builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1465313858.44 results: success (0) buildid: 20160607075532 builduid: dfd15feb7a0448d8aedd06d0bf2eaced revision: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.444960) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.445495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.445801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.460888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.461272) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 08:37:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-07 08:37:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.562145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.562493) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:38.613455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:37:38.613871) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 08:37:38,818 truncating revision to first 12 chars 2016-06-07 08:37:38,818 Setting DEBUG logging. 2016-06-07 08:37:38,818 attempt 1/10 2016-06-07 08:37:38,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f0a8c420b18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 08:37:40,115 unpacking tar archive at: fx-team-2f0a8c420b18/testing/mozharness/ program finished with exit code 0 elapsedTime=1.651878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:37:40.279699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:40.280034) ========= script_repo_revision: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:40.280437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:40.280731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:37:40.291298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-07 08:37:40.291679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:37:40 INFO - MultiFileLogger online at 20160607 08:37:40 in /builds/slave/test 08:37:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:37:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:40 INFO - {'append_to_log': False, 08:37:40 INFO - 'base_work_dir': '/builds/slave/test', 08:37:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:37:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:40 INFO - 'branch': 'Fx-Team-Non-PGO', 08:37:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:40 INFO - 'config_files': ('talos/linux_config.py',), 08:37:40 INFO - 'default_actions': ('clobber', 08:37:40 INFO - 'read-buildbot-config', 08:37:40 INFO - 'download-and-extract', 08:37:40 INFO - 'populate-webroot', 08:37:40 INFO - 'create-virtualenv', 08:37:40 INFO - 'install', 08:37:40 INFO - 'run-tests'), 08:37:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:40 INFO - 'download_minidump_stackwalk': True, 08:37:40 INFO - 'download_symbols': 'ondemand', 08:37:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:40 INFO - 'installer_path': 'installer.exe', 08:37:40 INFO - 'log_level': 'info', 08:37:40 INFO - 'log_name': 'talos', 08:37:40 INFO - 'log_to_console': True, 08:37:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:37:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:37:40 INFO - 'opt_config_files': (), 08:37:40 INFO - 'pip_index': False, 08:37:40 INFO - 'sps_profile': False, 08:37:40 INFO - 'sps_profile_interval': 0, 08:37:40 INFO - 'suite': 'dromaeojs', 08:37:40 INFO - 'system_bits': '32', 08:37:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:40 INFO - 'title': 'talos-linux64-ix-038', 08:37:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:40 INFO - 'use_talos_json': True, 08:37:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:40 INFO - 'work_dir': 'build'} 08:37:40 INFO - ##### 08:37:40 INFO - ##### Running clobber step. 08:37:40 INFO - ##### 08:37:40 INFO - Running pre-action listener: _resource_record_pre_action 08:37:40 INFO - Running main action method: clobber 08:37:40 INFO - rmtree: /builds/slave/test/build 08:37:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:41 INFO - Running post-action listener: _resource_record_post_action 08:37:41 INFO - ##### 08:37:41 INFO - ##### Finished clobber step (success) 08:37:41 INFO - ##### 08:37:41 INFO - ##### 08:37:41 INFO - ##### Running read-buildbot-config step. 08:37:41 INFO - ##### 08:37:41 INFO - Running pre-action listener: _resource_record_pre_action 08:37:41 INFO - Running main action method: read_buildbot_config 08:37:41 INFO - Using buildbot properties: 08:37:41 INFO - { 08:37:41 INFO - "project": "", 08:37:41 INFO - "product": "firefox", 08:37:41 INFO - "script_repo_revision": "production", 08:37:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:37:41 INFO - "repository": "", 08:37:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:37:41 INFO - "buildid": "20160607075532", 08:37:41 INFO - "pgo_build": "False", 08:37:41 INFO - "basedir": "/builds/slave/test", 08:37:41 INFO - "buildnumber": 1826, 08:37:41 INFO - "slavename": "talos-linux64-ix-038", 08:37:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:37:41 INFO - "platform": "ubuntu64_hw", 08:37:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:37:41 INFO - "branch": "fx-team", 08:37:41 INFO - "repo_path": "integration/fx-team", 08:37:41 INFO - "revision": "2f0a8c420b18954e18b57993ea9c1a84190a0cb1", 08:37:41 INFO - "stage_platform": "linux64", 08:37:41 INFO - "builduid": "dfd15feb7a0448d8aedd06d0bf2eaced", 08:37:41 INFO - "slavebuilddir": "test" 08:37:41 INFO - } 08:37:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:37:41 INFO - Running post-action listener: _resource_record_post_action 08:37:41 INFO - ##### 08:37:41 INFO - ##### Finished read-buildbot-config step (success) 08:37:41 INFO - ##### 08:37:41 INFO - ##### 08:37:41 INFO - ##### Running download-and-extract step. 08:37:41 INFO - ##### 08:37:41 INFO - Running pre-action listener: _resource_record_pre_action 08:37:41 INFO - Running main action method: download_and_extract 08:37:41 INFO - mkdir: /builds/slave/test/build/tests 08:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:41 INFO - https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:37:42 INFO - Downloaded 1361 bytes. 08:37:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:37:42 INFO - Using the following test package requirements: 08:37:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:37:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:37:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'jsshell-linux-x86_64.zip'], 08:37:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:37:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:37:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:37:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:37:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:37:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:42 INFO - https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:43 INFO - Downloaded 22873824 bytes. 08:37:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:45 INFO - Return code: 0 08:37:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:45 INFO - https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:48 INFO - Downloaded 22873824 bytes. 08:37:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:49 INFO - Return code: 0 08:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:49 INFO - https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:37:50 INFO - Downloaded 10833369 bytes. 08:37:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:37:50 INFO - Return code: 0 08:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:50 INFO - https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:37:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:37:52 INFO - Downloaded 55203229 bytes. 08:37:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:52 INFO - mkdir: /builds/slave/test/properties 08:37:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:52 INFO - Contents: 08:37:52 INFO - build_url:https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:52 INFO - Running post-action listener: _resource_record_post_action 08:37:52 INFO - Running post-action listener: set_extra_try_arguments 08:37:52 INFO - ##### 08:37:52 INFO - ##### Finished download-and-extract step (success) 08:37:52 INFO - ##### 08:37:52 INFO - ##### 08:37:52 INFO - ##### Running populate-webroot step. 08:37:52 INFO - ##### 08:37:52 INFO - Running pre-action listener: _resource_record_pre_action 08:37:52 INFO - Running main action method: populate_webroot 08:37:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:52 INFO - '--tppagecycles', 08:37:52 INFO - '7'], 08:37:52 INFO - 'tests': ['tsvgm']}}, 08:37:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:37:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['damp', 'tps']}, 08:37:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'tests': ['damp', 'tps']}, 08:37:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['dromaeo_dom']}, 08:37:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['a11yr', 08:37:52 INFO - 'ts_paint', 08:37:52 INFO - 'tpaint', 08:37:52 INFO - 'sessionrestore', 08:37:52 INFO - 'sessionrestore_no_auto_restore', 08:37:52 INFO - 'tabpaint']}, 08:37:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['tsvgx', 08:37:52 INFO - 'tsvgr_opacity', 08:37:52 INFO - 'tart', 08:37:52 INFO - 'tscrollx', 08:37:52 INFO - 'cart']}, 08:37:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:52 INFO - 'tsvgr_opacity', 08:37:52 INFO - 'tart', 08:37:52 INFO - 'tscrollx', 08:37:52 INFO - 'cart']}, 08:37:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'talos_options': ['--disable-e10s'], 08:37:52 INFO - 'tests': ['tp5o']}, 08:37:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'tests': ['tp5o']}, 08:37:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'talos_options': ['--disable-e10s', 08:37:52 INFO - '--xperf_path', 08:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:52 INFO - 'tests': ['tp5n']}, 08:37:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:52 INFO - 'talos_options': ['--xperf_path', 08:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:52 INFO - 'tests': ['tp5n']}}, 08:37:52 INFO - 'talos.zip': {'path': '', 08:37:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:52 INFO - Running post-action listener: _resource_record_post_action 08:37:52 INFO - ##### 08:37:52 INFO - ##### Finished populate-webroot step (success) 08:37:52 INFO - ##### 08:37:52 INFO - ##### 08:37:52 INFO - ##### Running create-virtualenv step. 08:37:52 INFO - ##### 08:37:52 INFO - Running pre-action listener: _resource_record_pre_action 08:37:52 INFO - Running main action method: create_virtualenv 08:37:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:37:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:52 INFO - Using real prefix '/usr' 08:37:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:55 INFO - Installing pip.................done. 08:37:55 INFO - Return code: 0 08:37:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:37:55 INFO - Using env: {'DISPLAY': ':0', 08:37:55 INFO - 'HOME': '/home/cltbld', 08:37:55 INFO - 'LANG': 'en_US.UTF-8', 08:37:55 INFO - 'LANGUAGE': 'en_US:en', 08:37:55 INFO - 'LOGNAME': 'cltbld', 08:37:55 INFO - 'MAIL': '/var/mail/cltbld', 08:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:55 INFO - 'MOZ_NO_REMOTE': '1', 08:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:55 INFO - 'NO_EM_RESTART': '1', 08:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:55 INFO - 'PWD': '/builds/slave/test', 08:37:55 INFO - 'SHELL': '/bin/bash', 08:37:55 INFO - 'SHLVL': '1', 08:37:55 INFO - 'TERM': 'linux', 08:37:55 INFO - 'TMOUT': '86400', 08:37:55 INFO - 'USER': 'cltbld', 08:37:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:55 INFO - '_': '/tools/buildbot/bin/python'} 08:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:37:55 INFO - Cleaning up... 08:37:55 INFO - Return code: 0 08:37:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:37:55 INFO - Using env: {'DISPLAY': ':0', 08:37:55 INFO - 'HOME': '/home/cltbld', 08:37:55 INFO - 'LANG': 'en_US.UTF-8', 08:37:55 INFO - 'LANGUAGE': 'en_US:en', 08:37:55 INFO - 'LOGNAME': 'cltbld', 08:37:55 INFO - 'MAIL': '/var/mail/cltbld', 08:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:55 INFO - 'MOZ_NO_REMOTE': '1', 08:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:55 INFO - 'NO_EM_RESTART': '1', 08:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:55 INFO - 'PWD': '/builds/slave/test', 08:37:55 INFO - 'SHELL': '/bin/bash', 08:37:55 INFO - 'SHLVL': '1', 08:37:55 INFO - 'TERM': 'linux', 08:37:55 INFO - 'TMOUT': '86400', 08:37:55 INFO - 'USER': 'cltbld', 08:37:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:55 INFO - '_': '/tools/buildbot/bin/python'} 08:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:55 INFO - Downloading/unpacking psutil>=3.1.1 08:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:57 INFO - Installing collected packages: psutil 08:37:57 INFO - Running setup.py install for psutil 08:37:57 INFO - building 'psutil._psutil_linux' extension 08:37:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:37:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:37:58 INFO - building 'psutil._psutil_posix' extension 08:37:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:37:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:58 INFO - Successfully installed psutil 08:37:58 INFO - Cleaning up... 08:37:58 INFO - Return code: 0 08:37:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:37:58 INFO - Using env: {'DISPLAY': ':0', 08:37:58 INFO - 'HOME': '/home/cltbld', 08:37:58 INFO - 'LANG': 'en_US.UTF-8', 08:37:58 INFO - 'LANGUAGE': 'en_US:en', 08:37:58 INFO - 'LOGNAME': 'cltbld', 08:37:58 INFO - 'MAIL': '/var/mail/cltbld', 08:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:58 INFO - 'MOZ_NO_REMOTE': '1', 08:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:58 INFO - 'NO_EM_RESTART': '1', 08:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:58 INFO - 'PWD': '/builds/slave/test', 08:37:58 INFO - 'SHELL': '/bin/bash', 08:37:58 INFO - 'SHLVL': '1', 08:37:58 INFO - 'TERM': 'linux', 08:37:58 INFO - 'TMOUT': '86400', 08:37:58 INFO - 'USER': 'cltbld', 08:37:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:58 INFO - '_': '/tools/buildbot/bin/python'} 08:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:38:00 INFO - Installing collected packages: mozsystemmonitor 08:38:00 INFO - Running setup.py install for mozsystemmonitor 08:38:00 INFO - Successfully installed mozsystemmonitor 08:38:00 INFO - Cleaning up... 08:38:00 INFO - Return code: 0 08:38:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:38:00 INFO - Using env: {'DISPLAY': ':0', 08:38:00 INFO - 'HOME': '/home/cltbld', 08:38:00 INFO - 'LANG': 'en_US.UTF-8', 08:38:00 INFO - 'LANGUAGE': 'en_US:en', 08:38:00 INFO - 'LOGNAME': 'cltbld', 08:38:00 INFO - 'MAIL': '/var/mail/cltbld', 08:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:00 INFO - 'MOZ_NO_REMOTE': '1', 08:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:00 INFO - 'NO_EM_RESTART': '1', 08:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:00 INFO - 'PWD': '/builds/slave/test', 08:38:00 INFO - 'SHELL': '/bin/bash', 08:38:00 INFO - 'SHLVL': '1', 08:38:00 INFO - 'TERM': 'linux', 08:38:00 INFO - 'TMOUT': '86400', 08:38:00 INFO - 'USER': 'cltbld', 08:38:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:00 INFO - '_': '/tools/buildbot/bin/python'} 08:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:03 INFO - warning: no files found matching '*.txt' 08:38:03 INFO - no previously-included directories found matching 'build' 08:38:03 INFO - no previously-included directories found matching 'dist' 08:38:03 INFO - no previously-included directories found matching '.git*' 08:38:03 INFO - Installing collected packages: jsonschema, functools32 08:38:03 INFO - Running setup.py install for functools32 08:38:03 INFO - warning: no files found matching '*.txt' 08:38:03 INFO - no previously-included directories found matching 'build' 08:38:03 INFO - no previously-included directories found matching 'dist' 08:38:03 INFO - no previously-included directories found matching '.git*' 08:38:03 INFO - Successfully installed jsonschema functools32 08:38:03 INFO - Cleaning up... 08:38:03 INFO - Return code: 0 08:38:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:38:03 INFO - Using env: {'DISPLAY': ':0', 08:38:03 INFO - 'HOME': '/home/cltbld', 08:38:03 INFO - 'LANG': 'en_US.UTF-8', 08:38:03 INFO - 'LANGUAGE': 'en_US:en', 08:38:03 INFO - 'LOGNAME': 'cltbld', 08:38:03 INFO - 'MAIL': '/var/mail/cltbld', 08:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:03 INFO - 'MOZ_NO_REMOTE': '1', 08:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:03 INFO - 'NO_EM_RESTART': '1', 08:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:03 INFO - 'PWD': '/builds/slave/test', 08:38:03 INFO - 'SHELL': '/bin/bash', 08:38:03 INFO - 'SHLVL': '1', 08:38:03 INFO - 'TERM': 'linux', 08:38:03 INFO - 'TMOUT': '86400', 08:38:03 INFO - 'USER': 'cltbld', 08:38:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:03 INFO - '_': '/tools/buildbot/bin/python'} 08:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:06 INFO - Downloading docopt-0.6.1.tar.gz 08:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:06 INFO - Running setup.py install for blobuploader 08:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:06 INFO - Running setup.py install for requests 08:38:06 INFO - Running setup.py install for docopt 08:38:06 INFO - Successfully installed blobuploader requests docopt 08:38:06 INFO - Cleaning up... 08:38:06 INFO - Return code: 0 08:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:38:06 INFO - Using env: {'DISPLAY': ':0', 08:38:06 INFO - 'HOME': '/home/cltbld', 08:38:06 INFO - 'LANG': 'en_US.UTF-8', 08:38:06 INFO - 'LANGUAGE': 'en_US:en', 08:38:06 INFO - 'LOGNAME': 'cltbld', 08:38:06 INFO - 'MAIL': '/var/mail/cltbld', 08:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:06 INFO - 'MOZ_NO_REMOTE': '1', 08:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:06 INFO - 'NO_EM_RESTART': '1', 08:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:06 INFO - 'PWD': '/builds/slave/test', 08:38:06 INFO - 'SHELL': '/bin/bash', 08:38:06 INFO - 'SHLVL': '1', 08:38:06 INFO - 'TERM': 'linux', 08:38:06 INFO - 'TMOUT': '86400', 08:38:06 INFO - 'USER': 'cltbld', 08:38:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:06 INFO - '_': '/tools/buildbot/bin/python'} 08:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:07 INFO - Running setup.py (path:/tmp/pip-6Jez6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:07 INFO - Running setup.py (path:/tmp/pip-B1yxMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:07 INFO - Running setup.py (path:/tmp/pip-da1eOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:07 INFO - Running setup.py (path:/tmp/pip-xjmAqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:07 INFO - Running setup.py (path:/tmp/pip-6Ht66Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:07 INFO - Running setup.py (path:/tmp/pip-jWxv6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:07 INFO - Running setup.py (path:/tmp/pip-lKxM0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:07 INFO - Running setup.py (path:/tmp/pip-GP6e4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:07 INFO - Running setup.py (path:/tmp/pip-syOpAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:07 INFO - Running setup.py (path:/tmp/pip-Yy2bEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:07 INFO - Running setup.py (path:/tmp/pip-ZLGAOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:07 INFO - Running setup.py (path:/tmp/pip-YxP3Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:07 INFO - Running setup.py (path:/tmp/pip-cfRd6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:07 INFO - Running setup.py (path:/tmp/pip-T79NNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:08 INFO - Running setup.py (path:/tmp/pip-gsbLys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:08 INFO - Running setup.py (path:/tmp/pip-picd7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:08 INFO - Running setup.py (path:/tmp/pip-pqcN7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:08 INFO - Running setup.py install for manifestparser 08:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozcrash 08:38:08 INFO - Running setup.py install for mozdebug 08:38:08 INFO - Running setup.py install for mozdevice 08:38:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozfile 08:38:08 INFO - Running setup.py install for mozhttpd 08:38:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozinfo 08:38:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozInstall 08:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozleak 08:38:09 INFO - Running setup.py install for mozlog 08:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for moznetwork 08:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozprocess 08:38:09 INFO - Running setup.py install for mozprofile 08:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozrunner 08:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:09 INFO - Running setup.py install for mozscreenshot 08:38:09 INFO - Running setup.py install for moztest 08:38:09 INFO - Running setup.py install for mozversion 08:38:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:10 INFO - Cleaning up... 08:38:10 INFO - Return code: 0 08:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:38:10 INFO - Using env: {'DISPLAY': ':0', 08:38:10 INFO - 'HOME': '/home/cltbld', 08:38:10 INFO - 'LANG': 'en_US.UTF-8', 08:38:10 INFO - 'LANGUAGE': 'en_US:en', 08:38:10 INFO - 'LOGNAME': 'cltbld', 08:38:10 INFO - 'MAIL': '/var/mail/cltbld', 08:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:10 INFO - 'MOZ_NO_REMOTE': '1', 08:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:10 INFO - 'NO_EM_RESTART': '1', 08:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:10 INFO - 'PWD': '/builds/slave/test', 08:38:10 INFO - 'SHELL': '/bin/bash', 08:38:10 INFO - 'SHLVL': '1', 08:38:10 INFO - 'TERM': 'linux', 08:38:10 INFO - 'TMOUT': '86400', 08:38:10 INFO - 'USER': 'cltbld', 08:38:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:10 INFO - '_': '/tools/buildbot/bin/python'} 08:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:10 INFO - Running setup.py (path:/tmp/pip-1YqWc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:10 INFO - Running setup.py (path:/tmp/pip-qrTkqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:10 INFO - Running setup.py (path:/tmp/pip-k59yzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:10 INFO - Running setup.py (path:/tmp/pip-nGkpXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:10 INFO - Running setup.py (path:/tmp/pip-dmqqZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:10 INFO - Running setup.py (path:/tmp/pip-nbkeqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:10 INFO - Running setup.py (path:/tmp/pip-H479Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:10 INFO - Running setup.py (path:/tmp/pip-QL6AgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:10 INFO - Running setup.py (path:/tmp/pip-D8ZCNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:10 INFO - Running setup.py (path:/tmp/pip-ODzMMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:10 INFO - Running setup.py (path:/tmp/pip-JPuVpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:11 INFO - Running setup.py (path:/tmp/pip-SOKHMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:11 INFO - Running setup.py (path:/tmp/pip-VrPf4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:11 INFO - Running setup.py (path:/tmp/pip-qG_kl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:11 INFO - Running setup.py (path:/tmp/pip-2PbeY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:11 INFO - Running setup.py (path:/tmp/pip-WBgGpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:11 INFO - Running setup.py (path:/tmp/pip-aw8EMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:13 INFO - Downloading blessings-1.6.tar.gz 08:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:13 INFO - Installing collected packages: blessings 08:38:13 INFO - Running setup.py install for blessings 08:38:13 INFO - Successfully installed blessings 08:38:13 INFO - Cleaning up... 08:38:13 INFO - Return code: 0 08:38:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:13 INFO - Reading from file tmpfile_stdout 08:38:13 INFO - Current package versions: 08:38:13 INFO - argparse == 1.2.1 08:38:13 INFO - blessings == 1.6 08:38:13 INFO - blobuploader == 1.2.4 08:38:13 INFO - docopt == 0.6.1 08:38:13 INFO - functools32 == 3.2.3-2 08:38:13 INFO - jsonschema == 2.5.1 08:38:13 INFO - manifestparser == 1.1 08:38:13 INFO - mozInstall == 1.12 08:38:13 INFO - mozcrash == 0.17 08:38:13 INFO - mozdebug == 0.1 08:38:13 INFO - mozdevice == 0.48 08:38:13 INFO - mozfile == 1.2 08:38:13 INFO - mozhttpd == 0.7 08:38:13 INFO - mozinfo == 0.9 08:38:13 INFO - mozleak == 0.1 08:38:13 INFO - mozlog == 3.2 08:38:13 INFO - moznetwork == 0.27 08:38:13 INFO - mozprocess == 0.22 08:38:13 INFO - mozprofile == 0.28 08:38:13 INFO - mozrunner == 6.11 08:38:13 INFO - mozscreenshot == 0.1 08:38:13 INFO - mozsystemmonitor == 0.3 08:38:13 INFO - moztest == 0.7 08:38:13 INFO - mozversion == 1.4 08:38:13 INFO - psutil == 3.1.1 08:38:13 INFO - requests == 1.2.3 08:38:13 INFO - wsgiref == 0.1.2 08:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:38:13 INFO - Using env: {'DISPLAY': ':0', 08:38:13 INFO - 'HOME': '/home/cltbld', 08:38:13 INFO - 'LANG': 'en_US.UTF-8', 08:38:13 INFO - 'LANGUAGE': 'en_US:en', 08:38:13 INFO - 'LOGNAME': 'cltbld', 08:38:13 INFO - 'MAIL': '/var/mail/cltbld', 08:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:13 INFO - 'MOZ_NO_REMOTE': '1', 08:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:13 INFO - 'NO_EM_RESTART': '1', 08:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:13 INFO - 'PWD': '/builds/slave/test', 08:38:13 INFO - 'SHELL': '/bin/bash', 08:38:13 INFO - 'SHLVL': '1', 08:38:13 INFO - 'TERM': 'linux', 08:38:13 INFO - 'TMOUT': '86400', 08:38:13 INFO - 'USER': 'cltbld', 08:38:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:13 INFO - '_': '/tools/buildbot/bin/python'} 08:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:38:14 INFO - Cleaning up... 08:38:14 INFO - Return code: 0 08:38:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:38:14 INFO - Using env: {'DISPLAY': ':0', 08:38:14 INFO - 'HOME': '/home/cltbld', 08:38:14 INFO - 'LANG': 'en_US.UTF-8', 08:38:14 INFO - 'LANGUAGE': 'en_US:en', 08:38:14 INFO - 'LOGNAME': 'cltbld', 08:38:14 INFO - 'MAIL': '/var/mail/cltbld', 08:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:14 INFO - 'MOZ_NO_REMOTE': '1', 08:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:14 INFO - 'NO_EM_RESTART': '1', 08:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:14 INFO - 'PWD': '/builds/slave/test', 08:38:14 INFO - 'SHELL': '/bin/bash', 08:38:14 INFO - 'SHLVL': '1', 08:38:14 INFO - 'TERM': 'linux', 08:38:14 INFO - 'TMOUT': '86400', 08:38:14 INFO - 'USER': 'cltbld', 08:38:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:14 INFO - '_': '/tools/buildbot/bin/python'} 08:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:38:14 INFO - Cleaning up... 08:38:14 INFO - Return code: 0 08:38:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc95ee70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:38:14 INFO - Using env: {'DISPLAY': ':0', 08:38:14 INFO - 'HOME': '/home/cltbld', 08:38:14 INFO - 'LANG': 'en_US.UTF-8', 08:38:14 INFO - 'LANGUAGE': 'en_US:en', 08:38:14 INFO - 'LOGNAME': 'cltbld', 08:38:14 INFO - 'MAIL': '/var/mail/cltbld', 08:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:14 INFO - 'MOZ_NO_REMOTE': '1', 08:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:14 INFO - 'NO_EM_RESTART': '1', 08:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:14 INFO - 'PWD': '/builds/slave/test', 08:38:14 INFO - 'SHELL': '/bin/bash', 08:38:14 INFO - 'SHLVL': '1', 08:38:14 INFO - 'TERM': 'linux', 08:38:14 INFO - 'TMOUT': '86400', 08:38:14 INFO - 'USER': 'cltbld', 08:38:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:14 INFO - '_': '/tools/buildbot/bin/python'} 08:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:14 INFO - Downloading/unpacking flake8 08:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:38:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:38:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:17 INFO - no previously-included directories found matching 'docs/_build' 08:38:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:38:17 INFO - Running setup.py install for pep8 08:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:17 INFO - no previously-included directories found matching 'docs/_build' 08:38:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:38:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:38:17 INFO - Cleaning up... 08:38:17 INFO - Return code: 0 08:38:17 INFO - Running post-action listener: _resource_record_post_action 08:38:17 INFO - Running post-action listener: _start_resource_monitoring 08:38:17 INFO - Starting resource monitoring. 08:38:17 INFO - ##### 08:38:17 INFO - ##### Finished create-virtualenv step (success) 08:38:17 INFO - ##### 08:38:17 INFO - ##### 08:38:17 INFO - ##### Running install step. 08:38:17 INFO - ##### 08:38:17 INFO - Running pre-action listener: _resource_record_pre_action 08:38:17 INFO - Running main action method: install 08:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:17 INFO - Reading from file tmpfile_stdout 08:38:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:17 INFO - Reading from file tmpfile_stdout 08:38:17 INFO - Output received: 08:38:17 INFO - Usage: mozinstall [options] installer 08:38:17 INFO - Options: 08:38:17 INFO - -h, --help show this help message and exit 08:38:17 INFO - -d DEST, --destination=DEST 08:38:17 INFO - Directory to install application into. [default: 08:38:17 INFO - "/builds/slave/test"] 08:38:17 INFO - --app=APP Application being installed. [default: firefox] 08:38:17 INFO - mkdir: /builds/slave/test/build/application 08:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:38:33 INFO - Reading from file tmpfile_stdout 08:38:33 INFO - Output received: 08:38:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:38:33 INFO - Running post-action listener: _resource_record_post_action 08:38:33 INFO - ##### 08:38:33 INFO - ##### Finished install step (success) 08:38:33 INFO - ##### 08:38:33 INFO - ##### 08:38:33 INFO - ##### Running run-tests step. 08:38:33 INFO - ##### 08:38:33 INFO - Running pre-action listener: _resource_record_pre_action 08:38:33 INFO - Running main action method: run_tests 08:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:38:33 INFO - Python 2.7.3 08:38:33 INFO - Return code: 0 08:38:33 INFO - grabbing minidump binary from tooltool 08:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21551c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21560c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:38:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:38:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:38:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:38:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:38:33 INFO - Return code: 0 08:38:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:38:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:38:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:38:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:38:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:38:34 INFO - Return code: 0 08:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:38:34 INFO - Using env: {'DISPLAY': ':0', 08:38:34 INFO - 'HOME': '/home/cltbld', 08:38:34 INFO - 'LANG': 'en_US.UTF-8', 08:38:34 INFO - 'LANGUAGE': 'en_US:en', 08:38:34 INFO - 'LOGNAME': 'cltbld', 08:38:34 INFO - 'MAIL': '/var/mail/cltbld', 08:38:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:38:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:34 INFO - 'MOZ_NO_REMOTE': '1', 08:38:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:34 INFO - 'NO_EM_RESTART': '1', 08:38:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:34 INFO - 'PWD': '/builds/slave/test', 08:38:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:38:34 INFO - 'SHELL': '/bin/bash', 08:38:34 INFO - 'SHLVL': '1', 08:38:34 INFO - 'TERM': 'linux', 08:38:34 INFO - 'TMOUT': '86400', 08:38:34 INFO - 'USER': 'cltbld', 08:38:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087', 08:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:34 INFO - '_': '/tools/buildbot/bin/python'} 08:38:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:38:34 INFO - mozversion application_buildid: 20160607075532 08:38:34 INFO - mozversion application_changeset: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 08:38:34 INFO - mozversion application_display_name: Nightly 08:38:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:38:34 INFO - mozversion application_name: Firefox 08:38:34 INFO - mozversion application_remotingname: firefox 08:38:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:38:34 INFO - mozversion application_vendor: Mozilla 08:38:34 INFO - mozversion application_version: 50.0a1 08:38:34 INFO - mozversion platform_buildid: 20160607075532 08:38:34 INFO - mozversion platform_changeset: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 08:38:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:38:34 INFO - mozversion platform_version: 50.0a1 08:38:34 INFO - using testdate: 1465313914 08:38:34 INFO - actual date: 1465313914 08:38:34 INFO - starting webserver on 'localhost:41111' 08:38:34 INFO - SUITE-START | Running 2 tests 08:38:34 INFO - TEST-START | dromaeo_css 08:38:34 INFO - operating with platform_type : linux_ 08:38:34 INFO - Initialising browser for dromaeo_css test... 08:38:34 INFO - TEST-INFO | started process 23781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptQfSqT/profile http://localhost:41111/getInfo.html) 08:38:39 INFO - PROCESS | 23781 | __metrics Screen width/height:1600/1200 08:38:39 INFO - PROCESS | 23781 | colorDepth:24 08:38:39 INFO - PROCESS | 23781 | Browser inner width/height: 1024/697 08:38:39 INFO - PROCESS | 23781 | __metrics 08:38:40 ERROR - PROCESS | 23781 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:38:40 INFO - PROCESS | 23781 | console.error: PushService: 08:38:40 INFO - PROCESS | 23781 | stateChangeProcessEnqueue: Error transitioning state 08:38:40 INFO - PROCESS | 23781 | UnknownError 08:38:41 INFO - TEST-INFO | 23781: exit 0 08:38:41 INFO - Browser initialized. 08:38:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:41 INFO - TEST-INFO | started process 23862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptQfSqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:53 INFO - PROCESS | 23862 | RSS: Main: 157859840 08:38:53 INFO - PROCESS | 23862 | 08:39:45 INFO - PROCESS | 23862 | 1465313985027 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:41:56 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41111/tests/dromaeo/cssquery-ext.html) 08:41:57 INFO - PROCESS | 23862 | RSS: Main: 256360448 08:41:57 INFO - PROCESS | 23862 | 08:45:00 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-ext.html (next: http://localhost:41111/tests/dromaeo/cssquery-jquery.html) 08:45:00 INFO - PROCESS | 23862 | RSS: Main: 239890432 08:45:00 INFO - PROCESS | 23862 | 08:48:03 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41111/tests/dromaeo/cssquery-mootools.html) 08:48:03 INFO - PROCESS | 23862 | RSS: Main: 240218112 08:48:03 INFO - PROCESS | 23862 | 08:51:05 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41111/tests/dromaeo/cssquery-prototype.html) 08:51:06 INFO - PROCESS | 23862 | RSS: Main: 232796160 08:51:06 INFO - PROCESS | 23862 | 08:54:09 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41111/tests/dromaeo/cssquery-yui.html) 08:54:10 INFO - PROCESS | 23862 | RSS: Main: 217337856 08:54:10 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | Cycle 1(1): loaded http://localhost:41111/tests/dromaeo/cssquery-yui.html (next: http://localhost:41111/tests/dromaeo/cssquery-dojo.html) 08:57:12 INFO - PROCESS | 23862 | RSS: Main: 275554304 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | __start_tp_report 08:57:12 INFO - PROCESS | 23862 | _x_x_mozilla_page_load 08:57:12 INFO - PROCESS | 23862 | _x_x_mozilla_page_load_details 08:57:12 INFO - PROCESS | 23862 | |i|pagename|runs| 08:57:12 INFO - PROCESS | 23862 | |0;dojo.html;2623.514649789789;2645.365112373031;2678.183154137987;2686.9328266793327;2690.4484580660965;4633.791479383427;4664.510226426227;4675.088357770236;4737.715737055775;4791.401074865642;4687.109449204657;4723.102610504002;4723.338732577433;4748.525147485249;4765.928511072337;4275.380069889864;4301.591348821857;4336.392904993303;4375.628071613916;4516.0967806438675;4438.223310920592;4478.283474644058;4483.5964763171305;4498.8875278117985;4520.028193938303;4238.406623072772;4295.763732994684;4299.032717638537;4329.610335069859;4333.371661109121;4327.632151267146;4348.260795664744;4356.607905288508;4405.515393306734;4409.691321607489;4360.956390436087;4377.4528183977;4394.714343567658;4421.07157496926;4430.490493593245;4516.525764794682;4602.585767280961;4613.976930115328;4658.487566367697;4668.136394766945;5137.229415587692;5146.150885103953;5149.433562308143;5150.098732721759;5155.175171972504;5101.0818052750865;5144.048351055067;5145.511176438233;5153.484651534854;5155.7679904404395;4568.977155114237;4705.12955103307;4737.59730422911;4739.028499157665;4763.428388593322;5206.55744261742;5234.005538947587;5234.764435600331;5241.606879484054;5242.947570524322;4973.52751488608;5017.297578339036;5018.84943451697;5020.221865610836;5020.246962955586;4900.730459824673;5007.073691367036;5065.696058236517;5072.442031376546;5114.43741188469;5048.015636950833;5050.520200580939;5055.570276526463;5060.721660308718;5082.720450375191;5021.046001259749;5039.496050394931;5040.420351659606;5046.293518907356;5096.184610462308;4191.036061705764;4231.048014196843;4234.745915245096;4278.379634952915;4376.3654270130655;3743.6630703236838;3761.8119094045737;3781.300459415017;3828.789416582059;3879.767213967171;4365.06151177492;4366.279563871989;4372.759498227628;4404.977975110168;4412.227860124465;4870.512948705172;5103.3110530077965;5112.182050871843;5114.667546609458;5120.129577971754;4225.302825033835;4330.588594083557;4388.824447022083;4396.824127034947;4398.252297109499;4611.838585649553;4617.238155704338;4627.028324051987;4629.328747331618;4669.159551280734;4604.930926036179;4810.615150787999;4813.326134341195;4817.13291607514;4820.927686084641;5040.193569028937;5077.213031980049;5102.285680004728;5127;5163.122269214317;4774.092922344744;4777.737224452689;4780.545848144421;4781.665283430127;4818.855434336975;5004.199328107631;5006.424261210008;5007.37407824022;5009.298698182184;5058.317127187783;4912.066707325596;4983.426905905722;4993.525615066563;5027.145385284437;5045.7981680732355;4856.247281671346;4857.95142048575;4865.489123641966;4881.536254055859;4908.901821963469;4708.552687494683;4874.756262186947;4885.316055752127;4890.242012487928;4942.233953737176;4751.358566593604;4783.210770222874;4825.806967721252;4871.488493708252;4886.389201349832;4937.7531123444405;4963.081829861487;4966.354373931365;4994.200927851526;5020.748962551931;4719.716816990992;4810.39870016248;4851.975740121276;4854.223324268241;4917.508249175197 08:57:12 INFO - PROCESS | 23862 | |1;ext.html;556.1546449396917;589.9262592175977;601.0863487499005;602.5932495565493;607.4047433515153;26546.203613891565;39181.80409097954;39749;39864.20271594566;39875.40186897195;40088.599114008925;40575;40728;40739.59260407395;40775.18449631006;7668.463207575458;7835.294823465887;7837.333826624744;7838.568878711669;7842.568658723768;7702.537847729154;7806.843863122735;7811.882821757678;7833.21667833215;7838.412119091063;7815.25755053269;7871.291583757461;7880.211978802103;7900;7912.169222231669;7850.489718168329;7889.368850491946;7908.960455197687;7909.327707144842;7911.723089691891;7659.885101723423;7720.613969301512;7756.728514502021;7768.57272849993;7770.145284018753;36877;37311.06722331963;37350.8132459336;37378;37415;3034.2262723005715;3117.2206948262933;3169.3027533942495;3207.4547326954475;3662.8351724172207;28107.156785296473;28423;28593;28879.711202887913;29180.270493237625;3422.8801991930413;3436.329915666446;3468.94796578049;3520.559930008749;3551.200979779529;247249;249514;249714;249748;249781;31406.842965785025;32414.189645259055;51448;51454;51723.74138129285;32989.17527061795;33209.66790332114;33418.3316333672;33424.83287583595;33492.49761253583;13769.173849569059;13912.234827084607;13918.58244252674;13922.860771392156;13940.093893896865;11665.358405287621;11712.824307635392;11731.413429328499;11734.354610496333;11737.413129343498;7597.164311925684;7625.961870190614;7691.538507689556;7697.653605587762;7702.422318326036;3041.5133578627315;3075.062106057674;3076.1079287006964;3096.90709278722;3122.4379611669665;870.8084221471266;914.9130832570895;922.1562270522531;925.2413021322451;936.9718908432758;26908.461830763274;27163;27408.17775466739;27625;27631.723682762917;862.8791969124328;884.969026084084;932.5616960028775;963.3834346018554;1021.269792098653;13935.65160870966;14211.431542738175;14447.49433769813;14530;14644.414223431157;417091;417915;422637;423331;423875;48618.27072593914;48937.75531122321;48946.51053489491;49119.035238590055;49164;1086.5979587552656;1139.2879450343535;1158.0561842098832;1169.7134202120535;1211.1582450197204;26922.59616105799;28527.28681782972;28685.856570717013;28687.282817929718;29072.27319317034;41085.794571026956;41497.1700565993;41746.791266043474;41779.58220417878;41780.58219417767;304941;305029;305347;305443;305607;21830.672539911597;21862.344129676134;21943.451413714785;24636.630450542896;25978.740212597633;40250.39624405577;41095.58904411037;41182.38226426546;41795.37306940337;42099.7895010523;35493.82253088718;35746.8212658935;35758.10604734902;36053;36437.27125457529;34658;35070.82464587661;35093.64906350904;35136.82431587826;35779.642203578675;34678.096151540136;34934.475982860786;35439;35878.46182307215;35953.460698089024;30053.398932021675;31366.529502057943;31467;31588.842055789573;31596.368072638877;23973.880130599235;24044.15845445401;24058.27825165248;24374.87812560926;24573.877130614233 08:57:12 INFO - PROCESS | 23862 | |2;jquery.html;361.9402798538241;366.17793054592437;382.8583424133073;393.2037623811779;396.31833246815484;15721.528354149379;16941.57646058849;17230.396936107238;17361.7395739064;17570.82429175708;15850.524484265461;16152.192390380493;16838.83161168388;16844.494665160066;16853.157342132905;4982.9252561211615;5115.53960143587;5129.2306154077;5166.354205724285;5167.870803229931;3716.7955762433057;3893.357595996657;5023.924641130386;5715.2855893013375;6017.187679663255;6025.427584379477;6045.33501314855;6064.575479716422;6068.726907289182;6069.211002569682;5897;5933.673647949361;5964.761409543613;5974.880502389928;6044.184035155242;3332.7333813294877;4934.358533390672;5262.158054711266;5273.209018647195;5277.102892508283;19719;20419.38741837747;20450.386488405224;20492.18031278747;20511.89744051285;1985.7914918933593;2036.7046778217223;2196.8022877940903;2309.168699268262;2487.601983682602;12482.188657737308;12890.484380624765;13018.414171362218;13057.738845223043;13404.061715679907;1653.4047742812577;1729.4292883348464;1733.9509596693945;1735.973960390595;1776.640869734654;63023.684881575755;63595.68202159006;63721.68139159275;64126.358736412505;64242.35757642457;9362.063793620584;9378.5310734463;9684.370515916444;9688.273379496566;9814.074370251956;13185.934070329587;13240.20558766477;13251.602451926265;13263.204207747565;13265.933670331586;7469.141048779351;7606.315431611071;7654.464187506933;7722.45942784011;7777.883331750028;7345.926540734631;7383.409327253807;7460.776176714708;7572.432067594842;7599.392048636096;5881.852953676193;6076.361981991828;6110.541709371815;6142.754289828356;6228.937710622927;1590.721623715845;1735.7917049954087;1748.5978225008319;1751.7722696049432;1784.9821501784816;749.9512531685423;877.1754550722301;895.7662837157854;909.1090731083443;938.3384713776771;16342.182890855409;17058.317667293417;17165.485035448957;17308;17560.209790559456;859.879616853641;903.6069309850236;908.9863652045225;908.9909100909039;915.9129882661136;9501.667441639509;10027.899721002697;10114.190864730805;10157.644482443227;10198.858239769583;380744;399987;410121;410742;410940;42297.44389619614;68295;68435;68918.65540672264;69742.65128674425;861.2076889261768;926.1757036237753;937.9249660027182;958.9760255993656;971.4656938683696;14075.225862577656;14849.851501485278;14877.851221487646;15761.605959850636;15789.789429479652;34225.657743423246;34494;34529.82735086309;34570.48144277788;35165.82417087898;43497;45735.771321143184;47624;47786.522134778206;47831;6894.310568943066;7518.473706840688;7898.486598371088;7925.722599708983;7940.205979402013;7489.962550187214;9395.859062113937;11345.262557933707;11601.5359385627;12252.08109391817;10560.84158737635;10614.946925265323;10701.19741019411;10705.9464702676;11111.611093612008;10034.09693127622;10116.696499105039;10603.681889543326;10603.8939610606;10634.723833140073;5914.852128696817;10352.430616315874;10437.947810260901;11087.501062452371;11305.71735706614;6775.356341147583;7170.892436613351;7302;7304.233055529093;7699.846003080019;9325.833213351261;10489.580416783243;10863;10997.285176463503;11015.394153321644 08:57:12 INFO - PROCESS | 23862 | |3;mootools.html;1196.1746394987463;1318.2420108437645;1369.589123263021;1434.2326855132505;1748.6852366574012;6263.217097862767;7333.1566869809985;7554;7587.886181707272;7723.61381930904;7466.216047315035;7610.238976102387;7618.200088990659;7619.314261716444;7626.809329766758;2067.5141341784706;2089.8014688604558;2092;2095.6961240620103;2095.6961240620103;2106.9789302107015;2132.402927180392;2154.892255387232;2157.600843843886;2161.589298033369;2080.625487412265;2101.3380785052736;2108.20942146695;2110.155937624947;2147.2269982806256;2085.582883423314;2088.3421722157473;2091.665333546633;2092.0376626751713;2093.445237012193;2006.8494862885343;2024.5141166120172;2024.544477492567;2026.9594608107902;2028.3914825552422;7278.96360518194;7517.097948246191;7603.011608490916;7661.042369703787;7670.079590449126;4285.700000999931;4384.802683879201;4388.692791504596;4389.780510974439;4395.142947125312;2719.619253304539;2809.4100238949845;2856.7286107819723;2859.37093839355;2861.998300594775;876.5967654878764;886.9750290791173;913.8766266553996;918.7014220378337;950.6150009246267;10257.230707696877;10278.794424111551;10301.381917084924;10321.690349289533;10336.89663103367;3801.695864330902;3898.7075969302414;3920.882373528799;4007.3788562772816;4008.9198216035516;8156.143604921398;8197.221263979913;8216.671333146607;8220.712275070344;8226.876596851052;4407.294832826797;4407.669424793154;4413.558644135561;4415.712978656377;4419.889502762457;3529.6999755020597;3908.921821563553;3991.760494370289;4023.3562629979065;4138.110306284103;3168.445522033681;3224.2584205632834;3271.936620598315;3275.9672403275663;3290.128116049249;924.1359329027381;975.4976187263564;981.5730157381562;987.7948902339135;993.7465946183677;856.6316483911978;858.587877818638;863.3481721300378;881.9470831750116;882.4661080046608;5149.201873709581;5253.212018197224;5294.8941021180135;5311.893762124736;5394.002109609734;792.5165648954134;796.2117503671324;822.3544517553692;884.4074470105045;897.2373482539789;3525.576930768324;3707.629237076325;3749.8312575934146;3798.6201379862346;3812.2375524895133;9131.589078491485;9395.812083758423;9412.15290623847;9432.481213533185;9450.90549094514;9325.766855828659;9411.576479058458;9429.575669094907;9430.528473576294;9458.243340532741;6744.347634829498;7036.085308909911;7040.5071644984355;7084;7155.212926578072;5234.816781412785;5260.710660913686;5275.551578115903;5299.894002119859;5312.070387682063;8380.58097095155;8496.192861678132;8526.232639062515;8604.623260278326;8606.61270242853;8472.237498625153;8542.74371768848;8607.139286071342;8639.395242333228;8729.214370706413;6278.780242691484;6482.2869484357625;6640.136782218281;6672;6702.564333318319;7301.634918254173;7307.451941104332;7325.6337183141695;7374.852502950018;7379.778606641809;6486.837829054311;6762.188537375547;6768.864622707617;6786.830329241809;6821.147356580427;6196.597221180609;6224.906626400517;6426.967865160645;6632.777289147969;6680.933190668031;6018.4583387493585;6047.274327080779;6050.546209034428;6083.6349819011;6097.542684298606;4365.192439398721;4636.675432719677;4646.605038571624;4718.103560323528;4750.168720473972;4664.4869064403565;4756.6908150970075;4761.952380476289;4781.258904869751;4841.152798260361 08:57:12 INFO - PROCESS | 23862 | |4;prototype.html;281.0780639502431;284.4893416317708;286.21148735234425;295.28540930947105;301.27392982911186;4766.378491829493;4815.868270956327;4819.710817350952;4823.300621409893;4839.298301746245;4763.737994410315;4782.450018247902;4791.832285869995;4810.39870016248;4836.2987366831785;3583.94624080639;3656.213914008488;3684.336819372512;3754.643308885665;3809.923801523968;3752.212035472554;3775.9433608495897;3781.4327850822324;3792.9810350948205;3809.8857034289017;3537.770044947083;3748.3815170496973;3763.1156678180605;3765.8870233893026;3769.0024287127867;3619.2037751694584;3761.322961866863;3771.7171212159196;3772.6415990480996;3784.375578029649;3305.2397948471985;3305.8760021592775;3315.7181639560667;3319.2531680371962;3319.7842140260805;4592.563706447882;4595.70127941686;4612.95387046132;4615.607673347769;4643.721376717374;4039.555648878621;4235.25882970479;4240.151969606091;4281.250781113293;4288.785560721983;4909.384031025527;4938.925916111261;4941.752912354404;4961.776720047606;4963.553280204799;3523.3834079036064;3531.4173161428334;3546.556680414948;3548.3790336690977;3553.5380400547765;5056.83947532792;5215.191645294985;5219.538529211789;5227.294315267428;5252.896891652796;3588.372034893883;3618.0231337538717;3629.6007439181667;3632.5096112025067;3642.745007849478;3658.176910195238;3658.725595580342;3677.3748462761396;3677.8161091945294;3681.5398075240596;4215.325547912319;4223.894402639959;4229.59818817218;4235.661147108224;4241.533431322552;4910.975445122752;5027.4721154279005;5029.371328583927;5032.572231360302;5046.44489106198;1253.9153632108162;1264.4626033935724;1267.309316422552;1268.5940499040403;1269.6762325607096;792.92162658784;800.87986801979;897.8518544440225;919.3977944446399;924.0990034716098;4314.870553883388;4347.586979236968;4347.956520434818;4360.931571764938;4361.760103194355;5006.774695138727;5061.8487142964095;5073.467285934998;5097.388313402341;5152.892128192457;4241.554636763157;4402.229609818269;4402.669799764966;4429.601335879786;4431.977840110779;2710.8915643374044;2731.7814574833965;2738.3017330580574;2750.35366688828;2768.1972228053637;4805.543473370094;4822.662413631012;4841.15279826029;4856.8785780355065;4870.172070747982;5134.897302053938;5229;5252.395974462909;5273.841784746463;5275.182346736262;4749.453812811433;4753.857384278477;4840.95159048405;4841.685290456109;4875.219964805614;5019.372578427697;5057.924131138109;5068.949310506848;5069.847904562869;5072.82245121419;4781.211100168433;5028.541722900464;5028.874278143076;5029.164355010322;5032;4779.689320194177;4797.320937671787;4819.228923372244;4823.662343636052;4828.637852161031;3707.6663100321102;3745.176061266517;3746.6440688134585;3754.136548593784;3769.264993326275;4883.658143930033;5063.493650634907;5072.847814565422;5121.359830021247;5244.9737751310995;5055.570276526537;5068.847934561969;5071.594272458268;5076.071092984642;5078.441371449064;4964.67729597575;5010.799568017239;5069.1635880079375;5089.931114465856;5090;4680.438347398198;4817.349657796152;4930.704157750546;4963.156263435152;4969.180085285887;4937.481564435682;5039.47085556026;5060.949390506048;5064;5073.543381095719;4902.264660300983;4918.852434426973;4935.728534930613;4939.728314942713;4979.875503112451 08:57:12 INFO - PROCESS | 23862 | |5;yui.html;681.959082455053;707.2503146664536;724.6231959381125;727.3163226567027;755.4409736794772;12406.689832754175;12862.228266304028;12870.227786332804;12894.161879477828;12924.806127908078;13122.147060441064;13276.867231327684;13278.402471888765;13279.867201327985;13289.933550332258;620.8230654263535;635.6249812610558;750.0886422996059;776.3788968824946;779.8362343907786;755.0750330844726;759.5860256160406;761.9619019049053;762.3672351947897;762.4548447859779;793.654760179321;801.6192308653372;801.6512816924627;801.7474495533888;804.5293503300576;643.787550108463;792.7066985215479;809.9190080991913;810.3922058456158;811.2617518058597;589.6285340235667;593.3413910559276;593.5311104227656;593.8693487432757;594.088074805172;12333.260004399765;12363.196392234477;12372.690682732913;12372.81440778389;12385.318807465586;11668.533258669642;12138.514459421702;12267.815982760265;12459.06557008228;12540.937295313557;11066.446677666085;11151.888481115166;11418.657440276806;11720.765584688259;11723.941380293129;4039.899002524931;4099.282625540519;4131.008557946071;4150.377443383486;4173.061061261192;54695.72652136714;56821.43178568203;56841.71579142119;56842.71578642122;60292;10159.187265018782;10176;10484.26610137283;10512.21158413122;10526.526306316235;17086.743698844526;17698.380556680455;18827.81172188288;18848.717269240973;18857.151428185764;6364.109024736541;6387.425131738166;6458.354164583598;6539.411452969255;6619.106420633153;3435.450327947566;3501.264734405803;3503.8423270952867;3511.3152935177905;3548.8580456781438;2944.4258369618146;3054.3585846972383;3058.342456371891;3058.388322335542;3062.2344413896526;452.93885325481295;500.20717163295853;507.64211231082;512.943576206617;527.8522013836132;450.8039003033625;548.5145646103227;572.9627574207664;594.3284088979426;625.9015427923964;7983.920160798434;7997.280244777998;8141.104478507359;8210.384221183434;8435.114312997048;452.46157073083583;466.92529195329263;528.02315715926;544.6677526708704;555.1256770586342;4051.4125451809323;4124.835006599762;4144.5026596808575;4203.726757760735;4374.300111982067;59159;60027.69986150041;60251.39748602545;81305.59347203345;99387.05516503549;53569.46430535645;66907;76341.23658763453;87620.12379876248;89598.55200723954;80022;80606.59696701597;81194.59402702948;81931;82461;7750.92249077502;7806.531608103532;7904.446688731734;8118.147594502729;8166.83666326682;46371;46462;48071;48198.51801482081;49122.75438622927;65492.34507654863;67919.3208067913;68476.97284540835;68584.3141568598;70567.29432705608;10038.749031274276;10240.166272801462;10260.486975651336;10304.793904121725;10323.48382580853;10481.37111773296;10611.363318200933;11114.27757195812;11984.520619175135;12234.143609947218;9097.59060842277;9111.863322050041;9206.677766278148;9211.953940230256;9265.027172146827;9782.608695652094;10016.949915250378;10121.342112762646;10136.847947280648;10317.432541210306;10109.140723038625;10156.593736250763;10171.186305095427;10360.430176340373;10406.791864162524;8989.235914947303;9306.208972237435;9329.440233586007;9386.389884657476;9654;9004.729858104267;9125.817483650157;9192.218661413588;9427.764305892408;9488.857667135137 08:57:12 INFO - PROCESS | 23862 | __end_tp_report 08:57:12 INFO - PROCESS | 23862 | __start_cc_report 08:57:12 INFO - PROCESS | 23862 | _x_x_mozilla_cycle_collect,912 08:57:12 INFO - PROCESS | 23862 | __end_cc_report 08:57:12 INFO - PROCESS | 23862 | __startTimestamp1465315032979__endTimestamp 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | ------- Summary: start ------- 08:57:12 INFO - PROCESS | 23862 | Number of tests: 6 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#0] dojo.html Cycles:165 Average:4682.28 Median:4783.21 stddev:486.54 (10.2%) stddev-sans-first:460.44 08:57:12 INFO - PROCESS | 23862 | Values: 2623.5 2645.4 2678.2 2686.9 2690.4 4633.8 4664.5 4675.1 4737.7 4791.4 4687.1 4723.1 4723.3 4748.5 4765.9 4275.4 4301.6 4336.4 4375.6 4516.1 4438.2 4478.3 4483.6 4498.9 4520.0 4238.4 4295.8 4299.0 4329.6 4333.4 4327.6 4348.3 4356.6 4405.5 4409.7 4361.0 4377.5 4394.7 4421.1 4430.5 4516.5 4602.6 4614.0 4658.5 4668.1 5137.2 5146.2 5149.4 5150.1 5155.2 5101.1 5144.0 5145.5 5153.5 5155.8 4569.0 4705.1 4737.6 4739.0 4763.4 5206.6 5234.0 5234.8 5241.6 5242.9 4973.5 5017.3 5018.8 5020.2 5020.2 4900.7 5007.1 5065.7 5072.4 5114.4 5048.0 5050.5 5055.6 5060.7 5082.7 5021.0 5039.5 5040.4 5046.3 5096.2 4191.0 4231.0 4234.7 4278.4 4376.4 3743.7 3761.8 3781.3 3828.8 3879.8 4365.1 4366.3 4372.8 4405.0 4412.2 4870.5 5103.3 5112.2 5114.7 5120.1 4225.3 4330.6 4388.8 4396.8 4398.3 4611.8 4617.2 4627.0 4629.3 4669.2 4604.9 4810.6 4813.3 4817.1 4820.9 5040.2 5077.2 5102.3 5127.0 5163.1 4774.1 4777.7 4780.5 4781.7 4818.9 5004.2 5006.4 5007.4 5009.3 5058.3 4912.1 4983.4 4993.5 5027.1 5045.8 4856.2 4858.0 4865.5 4881.5 4908.9 4708.6 4874.8 4885.3 4890.2 4942.2 4751.4 4783.2 4825.8 4871.5 4886.4 4937.8 4963.1 4966.4 4994.2 5020.7 4719.7 4810.4 4852.0 4854.2 4917.5 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#1] ext.html Cycles:180 Average:46353.67 Median:19649.01 stddev:88079.08 (448.3%) stddev-sans-first:88259.04 08:57:12 INFO - PROCESS | 23862 | Values: 556.2 589.9 601.1 602.6 607.4 26546.2 39181.8 39749.0 39864.2 39875.4 40088.6 40575.0 40728.0 40739.6 40775.2 7668.5 7835.3 7837.3 7838.6 7842.6 7702.5 7806.8 7811.9 7833.2 7838.4 7815.3 7871.3 7880.2 7900.0 7912.2 7850.5 7889.4 7909.0 7909.3 7911.7 7659.9 7720.6 7756.7 7768.6 7770.1 36877.0 37311.1 37350.8 37378.0 37415.0 3034.2 3117.2 3169.3 3207.5 3662.8 28107.2 28423.0 28593.0 28879.7 29180.3 3422.9 3436.3 3468.9 3520.6 3551.2 247249.0 249514.0 249714.0 249748.0 249781.0 31406.8 32414.2 51448.0 51454.0 51723.7 32989.2 33209.7 33418.3 33424.8 33492.5 13769.2 13912.2 13918.6 13922.9 13940.1 11665.4 11712.8 11731.4 11734.4 11737.4 7597.2 7626.0 7691.5 7697.7 7702.4 3041.5 3075.1 3076.1 3096.9 3122.4 870.8 914.9 922.2 925.2 937.0 26908.5 27163.0 27408.2 27625.0 27631.7 862.9 885.0 932.6 963.4 1021.3 13935.7 14211.4 14447.5 14530.0 14644.4 417091.0 417915.0 422637.0 423331.0 423875.0 48618.3 48937.8 48946.5 49119.0 49164.0 1086.6 1139.3 1158.1 1169.7 1211.2 26922.6 28527.3 28685.9 28687.3 29072.3 41085.8 41497.2 41746.8 41779.6 41780.6 304941.0 305029.0 305347.0 305443.0 305607.0 21830.7 21862.3 21943.5 24636.6 25978.7 40250.4 41095.6 41182.4 41795.4 42099.8 35493.8 35746.8 35758.1 36053.0 36437.3 34658.0 35070.8 35093.6 35136.8 35779.6 34678.1 34934.5 35439.0 35878.5 35953.5 30053.4 31366.5 31467.0 31588.8 31596.4 23973.9 24044.2 24058.3 24374.9 24573.9 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#2] jquery.html Cycles:180 Average:24060.71 Median:410431.50 stddev:65986.26 (16.1%) stddev-sans-first:66147.38 08:57:12 INFO - PROCESS | 23862 | Values: 361.9 366.2 382.9 393.2 396.3 15721.5 16941.6 17230.4 17361.7 17570.8 15850.5 16152.2 16838.8 16844.5 16853.2 4982.9 5115.5 5129.2 5166.4 5167.9 3716.8 3893.4 5023.9 5715.3 6017.2 6025.4 6045.3 6064.6 6068.7 6069.2 5897.0 5933.7 5964.8 5974.9 6044.2 3332.7 4934.4 5262.2 5273.2 5277.1 19719.0 20419.4 20450.4 20492.2 20511.9 1985.8 2036.7 2196.8 2309.2 2487.6 12482.2 12890.5 13018.4 13057.7 13404.1 1653.4 1729.4 1734.0 1736.0 1776.6 63023.7 63595.7 63721.7 64126.4 64242.4 9362.1 9378.5 9684.4 9688.3 9814.1 13185.9 13240.2 13251.6 13263.2 13265.9 7469.1 7606.3 7654.5 7722.5 7777.9 7345.9 7383.4 7460.8 7572.4 7599.4 5881.9 6076.4 6110.5 6142.8 6228.9 1590.7 1735.8 1748.6 1751.8 1785.0 750.0 877.2 895.8 909.1 938.3 16342.2 17058.3 17165.5 17308.0 17560.2 859.9 903.6 909.0 909.0 915.9 9501.7 10027.9 10114.2 10157.6 10198.9 380744.0 399987.0 410121.0 410742.0 410940.0 42297.4 68295.0 68435.0 68918.7 69742.7 861.2 926.2 937.9 959.0 971.5 14075.2 14849.9 14877.9 15761.6 15789.8 34225.7 34494.0 34529.8 34570.5 35165.8 43497.0 45735.8 47624.0 47786.5 47831.0 6894.3 7518.5 7898.5 7925.7 7940.2 7490.0 9395.9 11345.3 11601.5 12252.1 10560.8 10614.9 10701.2 10705.9 11111.6 10034.1 10116.7 10603.7 10603.9 10634.7 5914.9 10352.4 10437.9 11087.5 11305.7 6775.4 7170.9 7302.0 7304.2 7699.8 9325.8 10489.6 10863.0 10997.3 11015.4 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#3] mootools.html Cycles:180 Average:4965.53 Median:6032.87 stddev:2769.92 (45.9%) stddev-sans-first:2763.21 08:57:12 INFO - PROCESS | 23862 | Values: 1196.2 1318.2 1369.6 1434.2 1748.7 6263.2 7333.2 7554.0 7587.9 7723.6 7466.2 7610.2 7618.2 7619.3 7626.8 2067.5 2089.8 2092.0 2095.7 2095.7 2107.0 2132.4 2154.9 2157.6 2161.6 2080.6 2101.3 2108.2 2110.2 2147.2 2085.6 2088.3 2091.7 2092.0 2093.4 2006.8 2024.5 2024.5 2027.0 2028.4 7279.0 7517.1 7603.0 7661.0 7670.1 4285.7 4384.8 4388.7 4389.8 4395.1 2719.6 2809.4 2856.7 2859.4 2862.0 876.6 887.0 913.9 918.7 950.6 10257.2 10278.8 10301.4 10321.7 10336.9 3801.7 3898.7 3920.9 4007.4 4008.9 8156.1 8197.2 8216.7 8220.7 8226.9 4407.3 4407.7 4413.6 4415.7 4419.9 3529.7 3908.9 3991.8 4023.4 4138.1 3168.4 3224.3 3271.9 3276.0 3290.1 924.1 975.5 981.6 987.8 993.7 856.6 858.6 863.3 881.9 882.5 5149.2 5253.2 5294.9 5311.9 5394.0 792.5 796.2 822.4 884.4 897.2 3525.6 3707.6 3749.8 3798.6 3812.2 9131.6 9395.8 9412.2 9432.5 9450.9 9325.8 9411.6 9429.6 9430.5 9458.2 6744.3 7036.1 7040.5 7084.0 7155.2 5234.8 5260.7 5275.6 5299.9 5312.1 8380.6 8496.2 8526.2 8604.6 8606.6 8472.2 8542.7 8607.1 8639.4 8729.2 6278.8 6482.3 6640.1 6672.0 6702.6 7301.6 7307.5 7325.6 7374.9 7379.8 6486.8 6762.2 6768.9 6786.8 6821.1 6196.6 6224.9 6427.0 6632.8 6680.9 6018.5 6047.3 6050.5 6083.6 6097.5 4365.2 4636.7 4646.6 4718.1 4750.2 4664.5 4756.7 4762.0 4781.3 4841.2 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#4] prototype.html Cycles:180 Average:4149.45 Median:4780.45 stddev:1199.23 (25.1%) stddev-sans-first:1166.91 08:57:12 INFO - PROCESS | 23862 | Values: 281.1 284.5 286.2 295.3 301.3 4766.4 4815.9 4819.7 4823.3 4839.3 4763.7 4782.5 4791.8 4810.4 4836.3 3583.9 3656.2 3684.3 3754.6 3809.9 3752.2 3775.9 3781.4 3793.0 3809.9 3537.8 3748.4 3763.1 3765.9 3769.0 3619.2 3761.3 3771.7 3772.6 3784.4 3305.2 3305.9 3315.7 3319.3 3319.8 4592.6 4595.7 4613.0 4615.6 4643.7 4039.6 4235.3 4240.2 4281.3 4288.8 4909.4 4938.9 4941.8 4961.8 4963.6 3523.4 3531.4 3546.6 3548.4 3553.5 5056.8 5215.2 5219.5 5227.3 5252.9 3588.4 3618.0 3629.6 3632.5 3642.7 3658.2 3658.7 3677.4 3677.8 3681.5 4215.3 4223.9 4229.6 4235.7 4241.5 4911.0 5027.5 5029.4 5032.6 5046.4 1253.9 1264.5 1267.3 1268.6 1269.7 792.9 800.9 897.9 919.4 924.1 4314.9 4347.6 4348.0 4360.9 4361.8 5006.8 5061.8 5073.5 5097.4 5152.9 4241.6 4402.2 4402.7 4429.6 4432.0 2710.9 2731.8 2738.3 2750.4 2768.2 4805.5 4822.7 4841.2 4856.9 4870.2 5134.9 5229.0 5252.4 5273.8 5275.2 4749.5 4753.9 4841.0 4841.7 4875.2 5019.4 5057.9 5068.9 5069.8 5072.8 4781.2 5028.5 5028.9 5029.2 5032.0 4779.7 4797.3 4819.2 4823.7 4828.6 3707.7 3745.2 3746.6 3754.1 3769.3 4883.7 5063.5 5072.8 5121.4 5245.0 5055.6 5068.8 5071.6 5076.1 5078.4 4964.7 5010.8 5069.2 5089.9 5090.0 4680.4 4817.3 4930.7 4963.2 4969.2 4937.5 5039.5 5060.9 5064.0 5073.5 4902.3 4918.9 4935.7 4939.7 4979.9 08:57:12 INFO - PROCESS | 23862 | 08:57:12 INFO - PROCESS | 23862 | [#5] yui.html Cycles:180 Average:16795.39 Median:27622.12 stddev:23634.29 (85.6%) stddev-sans-first:23669.62 08:57:12 INFO - PROCESS | 23862 | Values: 682.0 707.3 724.6 727.3 755.4 12406.7 12862.2 12870.2 12894.2 12924.8 13122.1 13276.9 13278.4 13279.9 13289.9 620.8 635.6 750.1 776.4 779.8 755.1 759.6 762.0 762.4 762.5 793.7 801.6 801.7 801.7 804.5 643.8 792.7 809.9 810.4 811.3 589.6 593.3 593.5 593.9 594.1 12333.3 12363.2 12372.7 12372.8 12385.3 11668.5 12138.5 12267.8 12459.1 12540.9 11066.4 11151.9 11418.7 11720.8 11723.9 4039.9 4099.3 4131.0 4150.4 4173.1 54695.7 56821.4 56841.7 56842.7 60292.0 10159.2 10176.0 10484.3 10512.2 10526.5 17086.7 17698.4 18827.8 18848.7 18857.2 6364.1 6387.4 6458.4 6539.4 6619.1 3435.5 3501.3 3503.8 3511.3 3548.9 2944.4 3054.4 3058.3 3058.4 3062.2 452.9 500.2 507.6 512.9 527.9 450.8 548.5 573.0 594.3 625.9 7983.9 7997.3 8141.1 8210.4 8435.1 452.5 466.9 528.0 544.7 555.1 4051.4 4124.8 4144.5 4203.7 4374.3 59159.0 60027.7 60251.4 81305.6 99387.1 53569.5 66907.0 76341.2 87620.1 89598.6 80022.0 80606.6 81194.6 81931.0 82461.0 7750.9 7806.5 7904.4 8118.1 8166.8 46371.0 46462.0 48071.0 48198.5 49122.8 65492.3 67919.3 68477.0 68584.3 70567.3 10038.7 10240.2 10260.5 10304.8 10323.5 10481.4 10611.4 11114.3 11984.5 12234.1 9097.6 9111.9 9206.7 9212.0 9265.0 9782.6 10016.9 10121.3 10136.8 10317.4 10109.1 10156.6 10171.2 10360.4 10406.8 8989.2 9306.2 9329.4 9386.4 9654.0 9004.7 9125.8 9192.2 9427.8 9488.9 08:57:12 INFO - PROCESS | 23862 | -------- Summary: end -------- 08:57:12 INFO - PROCESS | 23862 | 08:57:13 INFO - TEST-INFO | 23862: exit 0 08:57:13 INFO - TEST-OK | dromaeo_css | took 1118968ms 08:57:13 INFO - TEST-START | kraken 08:57:13 INFO - operating with platform_type : linux_ 08:57:13 INFO - Initialising browser for kraken test... 08:57:13 INFO - TEST-INFO | started process 24040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKw116_/profile http://localhost:41111/getInfo.html) 08:57:18 INFO - PROCESS | 24040 | __metrics Screen width/height:1600/1200 08:57:18 INFO - PROCESS | 24040 | colorDepth:24 08:57:18 INFO - PROCESS | 24040 | Browser inner width/height: 1024/697 08:57:18 INFO - PROCESS | 24040 | __metrics 08:57:19 ERROR - PROCESS | 24040 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:57:19 INFO - PROCESS | 24040 | console.error: PushService: 08:57:19 INFO - PROCESS | 24040 | stateChangeProcessEnqueue: Error transitioning state 08:57:19 INFO - PROCESS | 24040 | UnknownError 08:57:20 INFO - TEST-INFO | 24040: exit 0 08:57:20 INFO - Browser initialized. 08:57:20 INFO - Running cycle 1/1 for kraken test... 08:57:20 INFO - TEST-INFO | started process 24123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKw116_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:32 INFO - PROCESS | 24123 | RSS: Main: 157626368 08:57:32 INFO - PROCESS | 24123 | 08:57:35 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41111/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:36 INFO - PROCESS | 24123 | RSS: Main: 216072192 08:57:36 INFO - PROCESS | 24123 | 08:57:38 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41111/tests/kraken/driver.html?testName=audio-dft) 08:57:39 INFO - PROCESS | 24123 | RSS: Main: 201572352 08:57:39 INFO - PROCESS | 24123 | 08:57:42 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41111/tests/kraken/driver.html?testName=audio-fft) 08:57:43 INFO - PROCESS | 24123 | RSS: Main: 270299136 08:57:43 INFO - PROCESS | 24123 | 08:57:45 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41111/tests/kraken/driver.html?testName=audio-oscillator) 08:57:46 INFO - PROCESS | 24123 | RSS: Main: 179920896 08:57:46 INFO - PROCESS | 24123 | 08:57:48 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:49 INFO - PROCESS | 24123 | RSS: Main: 184057856 08:57:49 INFO - PROCESS | 24123 | 08:57:52 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41111/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:52 INFO - PROCESS | 24123 | RSS: Main: 220721152 08:57:52 INFO - PROCESS | 24123 | 08:57:56 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41111/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:56 INFO - PROCESS | 24123 | RSS: Main: 216465408 08:57:56 INFO - PROCESS | 24123 | 08:57:59 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41111/tests/kraken/driver.html?testName=json-parse-financial) 08:58:00 INFO - PROCESS | 24123 | RSS: Main: 219312128 08:58:00 INFO - PROCESS | 24123 | 08:58:02 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:02 INFO - PROCESS | 24123 | RSS: Main: 209305600 08:58:02 INFO - PROCESS | 24123 | 08:58:04 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:05 INFO - PROCESS | 24123 | RSS: Main: 210120704 08:58:05 INFO - PROCESS | 24123 | 08:58:07 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:08 INFO - PROCESS | 24123 | RSS: Main: 218640384 08:58:08 INFO - PROCESS | 24123 | 08:58:11 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:11 INFO - PROCESS | 24123 | RSS: Main: 223674368 08:58:11 INFO - PROCESS | 24123 | 08:58:14 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:15 INFO - PROCESS | 24123 | RSS: Main: 224276480 08:58:15 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | Cycle 1(1): loaded http://localhost:41111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41111/tests/kraken/driver.html?testName=ai-astar) 08:58:17 INFO - PROCESS | 24123 | RSS: Main: 266526720 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | __start_tp_report 08:58:17 INFO - PROCESS | 24123 | _x_x_mozilla_page_load 08:58:17 INFO - PROCESS | 24123 | _x_x_mozilla_page_load_details 08:58:17 INFO - PROCESS | 24123 | |i|pagename|runs| 08:58:17 INFO - PROCESS | 24123 | |0;ai-astar;113;112;115;117;112;114;113;113;114;113 08:58:17 INFO - PROCESS | 24123 | |1;audio-beat-detection;163;130;130;186;136;131;155;129;167;131 08:58:17 INFO - PROCESS | 24123 | |2;audio-dft;161;161;165;162;162;161;161;161;161;161 08:58:17 INFO - PROCESS | 24123 | |3;audio-fft;76;75;76;110;76;85;75;75;99;75 08:58:17 INFO - PROCESS | 24123 | |4;audio-oscillator;86;85;111;86;87;87;130;85;86;120 08:58:17 INFO - PROCESS | 24123 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;116;117 08:58:17 INFO - PROCESS | 24123 | |6;imaging-darkroom;146;146;146;145;145;146;146;145;146;146 08:58:17 INFO - PROCESS | 24123 | |7;imaging-desaturate;94;95;95;94;95;94;95;95;94;94 08:58:17 INFO - PROCESS | 24123 | |8;json-parse-financial;61;61;62;62;65;65;64;63;62;62 08:58:17 INFO - PROCESS | 24123 | |9;json-stringify-tinderbox;66;66;65;66;65;67;65;66;65;67 08:58:17 INFO - PROCESS | 24123 | |10;stanford-crypto-aes;86;90;83;83;83;85;85;83;119;90 08:58:17 INFO - PROCESS | 24123 | |11;stanford-crypto-ccm;136;135;132;138;132;135;132;130;137;132 08:58:17 INFO - PROCESS | 24123 | |12;stanford-crypto-pbkdf2;171;171;170;171;174;172;176;176;168;175 08:58:17 INFO - PROCESS | 24123 | |13;stanford-crypto-sha256-iterative;68;67;68;66;68;67;68;67;67;66 08:58:17 INFO - PROCESS | 24123 | __end_tp_report 08:58:17 INFO - PROCESS | 24123 | __start_cc_report 08:58:17 INFO - PROCESS | 24123 | _x_x_mozilla_cycle_collect,1902 08:58:17 INFO - PROCESS | 24123 | __end_cc_report 08:58:17 INFO - PROCESS | 24123 | __startTimestamp1465315097280__endTimestamp 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | ------- Summary: start ------- 08:58:17 INFO - PROCESS | 24123 | Number of tests: 14 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:1.51 (1.3%) stddev-sans-first:1.58 08:58:17 INFO - PROCESS | 24123 | Values: 113.0 112.0 115.0 117.0 112.0 114.0 113.0 113.0 114.0 113.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:145.50 stddev:20.44 (14.1%) stddev-sans-first:20.71 08:58:17 INFO - PROCESS | 24123 | Values: 163.0 130.0 130.0 186.0 136.0 131.0 155.0 129.0 167.0 131.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 08:58:17 INFO - PROCESS | 24123 | Values: 161.0 161.0 165.0 162.0 162.0 161.0 161.0 161.0 161.0 161.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:12.41 (16.3%) stddev-sans-first:12.96 08:58:17 INFO - PROCESS | 24123 | Values: 76.0 75.0 76.0 110.0 76.0 85.0 75.0 75.0 99.0 75.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.00 stddev:17.19 (20.0%) stddev-sans-first:17.83 08:58:17 INFO - PROCESS | 24123 | Values: 86.0 85.0 111.0 86.0 87.0 87.0 130.0 85.0 86.0 120.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:58:17 INFO - PROCESS | 24123 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:58:17 INFO - PROCESS | 24123 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:58:17 INFO - PROCESS | 24123 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:62.50 stddev:1.49 (2.4%) stddev-sans-first:1.45 08:58:17 INFO - PROCESS | 24123 | Values: 61.0 61.0 62.0 62.0 65.0 65.0 64.0 63.0 62.0 62.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:58:17 INFO - PROCESS | 24123 | Values: 66.0 66.0 65.0 66.0 65.0 67.0 65.0 66.0 65.0 67.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:10.99 (12.9%) stddev-sans-first:11.61 08:58:17 INFO - PROCESS | 24123 | Values: 86.0 90.0 83.0 83.0 83.0 85.0 85.0 83.0 119.0 90.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:135.00 stddev:2.64 (2.0%) stddev-sans-first:2.69 08:58:17 INFO - PROCESS | 24123 | Values: 136.0 135.0 132.0 138.0 132.0 135.0 132.0 130.0 137.0 132.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.00 stddev:2.72 (1.6%) stddev-sans-first:2.83 08:58:17 INFO - PROCESS | 24123 | Values: 171.0 171.0 170.0 171.0 174.0 172.0 176.0 176.0 168.0 175.0 08:58:17 INFO - PROCESS | 24123 | 08:58:17 INFO - PROCESS | 24123 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 08:58:17 INFO - PROCESS | 24123 | Values: 68.0 67.0 68.0 66.0 68.0 67.0 68.0 67.0 67.0 66.0 08:58:17 INFO - PROCESS | 24123 | -------- Summary: end -------- 08:58:17 INFO - PROCESS | 24123 | 08:58:18 INFO - TEST-INFO | 24123: exit 0 08:58:18 INFO - TEST-OK | kraken | took 64566ms 08:58:18 INFO - SUITE-END | took 1183s 08:58:18 INFO - Completed test suite (00:19:43) 08:58:18 INFO - javascript benchmark 08:58:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.514649789789, 2645.365112373031, 2678.183154137987, 2686.9328266793327, 2690.4484580660965, 4633.791479383427, 4664.510226426227, 4675.088357770236, 4737.715737055775, 4791.401074865642, 4687.109449204657, 4723.102610504002, 4723.338732577433, 4748.525147485249, 4765.928511072337, 4275.380069889864, 4301.591348821857, 4336.392904993303, 4375.628071613916, 4516.0967806438675, 4438.223310920592, 4478.283474644058, 4483.5964763171305, 4498.8875278117985, 4520.028193938303, 4238.406623072772, 4295.763732994684, 4299.032717638537, 4329.610335069859, 4333.371661109121, 4327.632151267146, 4348.260795664744, 4356.607905288508, 4405.515393306734, 4409.691321607489, 4360.956390436087, 4377.4528183977, 4394.714343567658, 4421.07157496926, 4430.490493593245, 4516.525764794682, 4602.585767280961, 4613.976930115328, 4658.487566367697, 4668.136394766945, 5137.229415587692, 5146.150885103953, 5149.433562308143, 5150.098732721759, 5155.175171972504, 5101.0818052750865, 5144.048351055067, 5145.511176438233, 5153.484651534854, 5155.7679904404395, 4568.977155114237, 4705.12955103307, 4737.59730422911, 4739.028499157665, 4763.428388593322, 5206.55744261742, 5234.005538947587, 5234.764435600331, 5241.606879484054, 5242.947570524322, 4973.52751488608, 5017.297578339036, 5018.84943451697, 5020.221865610836, 5020.246962955586, 4900.730459824673, 5007.073691367036, 5065.696058236517, 5072.442031376546, 5114.43741188469, 5048.015636950833, 5050.520200580939, 5055.570276526463, 5060.721660308718, 5082.720450375191, 5021.046001259749, 5039.496050394931, 5040.420351659606, 5046.293518907356, 5096.184610462308, 4191.036061705764, 4231.048014196843, 4234.745915245096, 4278.379634952915, 4376.3654270130655, 3743.6630703236838, 3761.8119094045737, 3781.300459415017, 3828.789416582059, 3879.767213967171, 4365.06151177492, 4366.279563871989, 4372.759498227628, 4404.977975110168, 4412.227860124465, 4870.512948705172, 5103.3110530077965, 5112.182050871843, 5114.667546609458, 5120.129577971754, 4225.302825033835, 4330.588594083557, 4388.824447022083, 4396.824127034947, 4398.252297109499, 4611.838585649553, 4617.238155704338, 4627.028324051987, 4629.328747331618, 4669.159551280734, 4604.930926036179, 4810.615150787999, 4813.326134341195, 4817.13291607514, 4820.927686084641, 5040.193569028937, 5077.213031980049, 5102.285680004728, 5127.0, 5163.122269214317, 4774.092922344744, 4777.737224452689, 4780.545848144421, 4781.665283430127, 4818.855434336975, 5004.199328107631, 5006.424261210008, 5007.37407824022, 5009.298698182184, 5058.317127187783, 4912.066707325596, 4983.426905905722, 4993.525615066563, 5027.145385284437, 5045.7981680732355, 4856.247281671346, 4857.95142048575, 4865.489123641966, 4881.536254055859, 4908.901821963469, 4708.552687494683, 4874.756262186947, 4885.316055752127, 4890.242012487928, 4942.233953737176, 4751.358566593604, 4783.210770222874, 4825.806967721252, 4871.488493708252, 4886.389201349832, 4937.7531123444405, 4963.081829861487, 4966.354373931365, 4994.200927851526, 5020.748962551931, 4719.716816990992, 4810.39870016248, 4851.975740121276, 4854.223324268241, 4917.508249175197], "value": 4651.678987981148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1546449396917, 589.9262592175977, 601.0863487499005, 602.5932495565493, 607.4047433515153, 26546.203613891565, 39181.80409097954, 39749.0, 39864.20271594566, 39875.40186897195, 40088.599114008925, 40575.0, 40728.0, 40739.59260407395, 40775.18449631006, 7668.463207575458, 7835.294823465887, 7837.333826624744, 7838.568878711669, 7842.568658723768, 7702.537847729154, 7806.843863122735, 7811.882821757678, 7833.21667833215, 7838.412119091063, 7815.25755053269, 7871.291583757461, 7880.211978802103, 7900.0, 7912.169222231669, 7850.489718168329, 7889.368850491946, 7908.960455197687, 7909.327707144842, 7911.723089691891, 7659.885101723423, 7720.613969301512, 7756.728514502021, 7768.57272849993, 7770.145284018753, 36877.0, 37311.06722331963, 37350.8132459336, 37378.0, 37415.0, 3034.2262723005715, 3117.2206948262933, 3169.3027533942495, 3207.4547326954475, 3662.8351724172207, 28107.156785296473, 28423.0, 28593.0, 28879.711202887913, 29180.270493237625, 3422.8801991930413, 3436.329915666446, 3468.94796578049, 3520.559930008749, 3551.200979779529, 247249.0, 249514.0, 249714.0, 249748.0, 249781.0, 31406.842965785025, 32414.189645259055, 51448.0, 51454.0, 51723.74138129285, 32989.17527061795, 33209.66790332114, 33418.3316333672, 33424.83287583595, 33492.49761253583, 13769.173849569059, 13912.234827084607, 13918.58244252674, 13922.860771392156, 13940.093893896865, 11665.358405287621, 11712.824307635392, 11731.413429328499, 11734.354610496333, 11737.413129343498, 7597.164311925684, 7625.961870190614, 7691.538507689556, 7697.653605587762, 7702.422318326036, 3041.5133578627315, 3075.062106057674, 3076.1079287006964, 3096.90709278722, 3122.4379611669665, 870.8084221471266, 914.9130832570895, 922.1562270522531, 925.2413021322451, 936.9718908432758, 26908.461830763274, 27163.0, 27408.17775466739, 27625.0, 27631.723682762917, 862.8791969124328, 884.969026084084, 932.5616960028775, 963.3834346018554, 1021.269792098653, 13935.65160870966, 14211.431542738175, 14447.49433769813, 14530.0, 14644.414223431157, 417091.0, 417915.0, 422637.0, 423331.0, 423875.0, 48618.27072593914, 48937.75531122321, 48946.51053489491, 49119.035238590055, 49164.0, 1086.5979587552656, 1139.2879450343535, 1158.0561842098832, 1169.7134202120535, 1211.1582450197204, 26922.59616105799, 28527.28681782972, 28685.856570717013, 28687.282817929718, 29072.27319317034, 41085.794571026956, 41497.1700565993, 41746.791266043474, 41779.58220417878, 41780.58219417767, 304941.0, 305029.0, 305347.0, 305443.0, 305607.0, 21830.672539911597, 21862.344129676134, 21943.451413714785, 24636.630450542896, 25978.740212597633, 40250.39624405577, 41095.58904411037, 41182.38226426546, 41795.37306940337, 42099.7895010523, 35493.82253088718, 35746.8212658935, 35758.10604734902, 36053.0, 36437.27125457529, 34658.0, 35070.82464587661, 35093.64906350904, 35136.82431587826, 35779.642203578675, 34678.096151540136, 34934.475982860786, 35439.0, 35878.46182307215, 35953.460698089024, 30053.398932021675, 31366.529502057943, 31467.0, 31588.842055789573, 31596.368072638877, 23973.880130599235, 24044.15845445401, 24058.27825165248, 24374.87812560926, 24573.877130614233], "value": 16269.284004249219, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9402798538241, 366.17793054592437, 382.8583424133073, 393.2037623811779, 396.31833246815484, 15721.528354149379, 16941.57646058849, 17230.396936107238, 17361.7395739064, 17570.82429175708, 15850.524484265461, 16152.192390380493, 16838.83161168388, 16844.494665160066, 16853.157342132905, 4982.9252561211615, 5115.53960143587, 5129.2306154077, 5166.354205724285, 5167.870803229931, 3716.7955762433057, 3893.357595996657, 5023.924641130386, 5715.2855893013375, 6017.187679663255, 6025.427584379477, 6045.33501314855, 6064.575479716422, 6068.726907289182, 6069.211002569682, 5897.0, 5933.673647949361, 5964.761409543613, 5974.880502389928, 6044.184035155242, 3332.7333813294877, 4934.358533390672, 5262.158054711266, 5273.209018647195, 5277.102892508283, 19719.0, 20419.38741837747, 20450.386488405224, 20492.18031278747, 20511.89744051285, 1985.7914918933593, 2036.7046778217223, 2196.8022877940903, 2309.168699268262, 2487.601983682602, 12482.188657737308, 12890.484380624765, 13018.414171362218, 13057.738845223043, 13404.061715679907, 1653.4047742812577, 1729.4292883348464, 1733.9509596693945, 1735.973960390595, 1776.640869734654, 63023.684881575755, 63595.68202159006, 63721.68139159275, 64126.358736412505, 64242.35757642457, 9362.063793620584, 9378.5310734463, 9684.370515916444, 9688.273379496566, 9814.074370251956, 13185.934070329587, 13240.20558766477, 13251.602451926265, 13263.204207747565, 13265.933670331586, 7469.141048779351, 7606.315431611071, 7654.464187506933, 7722.45942784011, 7777.883331750028, 7345.926540734631, 7383.409327253807, 7460.776176714708, 7572.432067594842, 7599.392048636096, 5881.852953676193, 6076.361981991828, 6110.541709371815, 6142.754289828356, 6228.937710622927, 1590.721623715845, 1735.7917049954087, 1748.5978225008319, 1751.7722696049432, 1784.9821501784816, 749.9512531685423, 877.1754550722301, 895.7662837157854, 909.1090731083443, 938.3384713776771, 16342.182890855409, 17058.317667293417, 17165.485035448957, 17308.0, 17560.209790559456, 859.879616853641, 903.6069309850236, 908.9863652045225, 908.9909100909039, 915.9129882661136, 9501.667441639509, 10027.899721002697, 10114.190864730805, 10157.644482443227, 10198.858239769583, 380744.0, 399987.0, 410121.0, 410742.0, 410940.0, 42297.44389619614, 68295.0, 68435.0, 68918.65540672264, 69742.65128674425, 861.2076889261768, 926.1757036237753, 937.9249660027182, 958.9760255993656, 971.4656938683696, 14075.225862577656, 14849.851501485278, 14877.851221487646, 15761.605959850636, 15789.789429479652, 34225.657743423246, 34494.0, 34529.82735086309, 34570.48144277788, 35165.82417087898, 43497.0, 45735.771321143184, 47624.0, 47786.522134778206, 47831.0, 6894.310568943066, 7518.473706840688, 7898.486598371088, 7925.722599708983, 7940.205979402013, 7489.962550187214, 9395.859062113937, 11345.262557933707, 11601.5359385627, 12252.08109391817, 10560.84158737635, 10614.946925265323, 10701.19741019411, 10705.9464702676, 11111.611093612008, 10034.09693127622, 10116.696499105039, 10603.681889543326, 10603.8939610606, 10634.723833140073, 5914.852128696817, 10352.430616315874, 10437.947810260901, 11087.501062452371, 11305.71735706614, 6775.356341147583, 7170.892436613351, 7302.0, 7304.233055529093, 7699.846003080019, 9325.833213351261, 10489.580416783243, 10863.0, 10997.285176463503, 11015.394153321644], "value": 8289.068031074028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.1746394987463, 1318.2420108437645, 1369.589123263021, 1434.2326855132505, 1748.6852366574012, 6263.217097862767, 7333.1566869809985, 7554.0, 7587.886181707272, 7723.61381930904, 7466.216047315035, 7610.238976102387, 7618.200088990659, 7619.314261716444, 7626.809329766758, 2067.5141341784706, 2089.8014688604558, 2092.0, 2095.6961240620103, 2095.6961240620103, 2106.9789302107015, 2132.402927180392, 2154.892255387232, 2157.600843843886, 2161.589298033369, 2080.625487412265, 2101.3380785052736, 2108.20942146695, 2110.155937624947, 2147.2269982806256, 2085.582883423314, 2088.3421722157473, 2091.665333546633, 2092.0376626751713, 2093.445237012193, 2006.8494862885343, 2024.5141166120172, 2024.544477492567, 2026.9594608107902, 2028.3914825552422, 7278.96360518194, 7517.097948246191, 7603.011608490916, 7661.042369703787, 7670.079590449126, 4285.700000999931, 4384.802683879201, 4388.692791504596, 4389.780510974439, 4395.142947125312, 2719.619253304539, 2809.4100238949845, 2856.7286107819723, 2859.37093839355, 2861.998300594775, 876.5967654878764, 886.9750290791173, 913.8766266553996, 918.7014220378337, 950.6150009246267, 10257.230707696877, 10278.794424111551, 10301.381917084924, 10321.690349289533, 10336.89663103367, 3801.695864330902, 3898.7075969302414, 3920.882373528799, 4007.3788562772816, 4008.9198216035516, 8156.143604921398, 8197.221263979913, 8216.671333146607, 8220.712275070344, 8226.876596851052, 4407.294832826797, 4407.669424793154, 4413.558644135561, 4415.712978656377, 4419.889502762457, 3529.6999755020597, 3908.921821563553, 3991.760494370289, 4023.3562629979065, 4138.110306284103, 3168.445522033681, 3224.2584205632834, 3271.936620598315, 3275.9672403275663, 3290.128116049249, 924.1359329027381, 975.4976187263564, 981.5730157381562, 987.7948902339135, 993.7465946183677, 856.6316483911978, 858.587877818638, 863.3481721300378, 881.9470831750116, 882.4661080046608, 5149.201873709581, 5253.212018197224, 5294.8941021180135, 5311.893762124736, 5394.002109609734, 792.5165648954134, 796.2117503671324, 822.3544517553692, 884.4074470105045, 897.2373482539789, 3525.576930768324, 3707.629237076325, 3749.8312575934146, 3798.6201379862346, 3812.2375524895133, 9131.589078491485, 9395.812083758423, 9412.15290623847, 9432.481213533185, 9450.90549094514, 9325.766855828659, 9411.576479058458, 9429.575669094907, 9430.528473576294, 9458.243340532741, 6744.347634829498, 7036.085308909911, 7040.5071644984355, 7084.0, 7155.212926578072, 5234.816781412785, 5260.710660913686, 5275.551578115903, 5299.894002119859, 5312.070387682063, 8380.58097095155, 8496.192861678132, 8526.232639062515, 8604.623260278326, 8606.61270242853, 8472.237498625153, 8542.74371768848, 8607.139286071342, 8639.395242333228, 8729.214370706413, 6278.780242691484, 6482.2869484357625, 6640.136782218281, 6672.0, 6702.564333318319, 7301.634918254173, 7307.451941104332, 7325.6337183141695, 7374.852502950018, 7379.778606641809, 6486.837829054311, 6762.188537375547, 6768.864622707617, 6786.830329241809, 6821.147356580427, 6196.597221180609, 6224.906626400517, 6426.967865160645, 6632.777289147969, 6680.933190668031, 6018.4583387493585, 6047.274327080779, 6050.546209034428, 6083.6349819011, 6097.542684298606, 4365.192439398721, 4636.675432719677, 4646.605038571624, 4718.103560323528, 4750.168720473972, 4664.4869064403565, 4756.6908150970075, 4761.952380476289, 4781.258904869751, 4841.152798260361], "value": 3995.8647862605553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.0780639502431, 284.4893416317708, 286.21148735234425, 295.28540930947105, 301.27392982911186, 4766.378491829493, 4815.868270956327, 4819.710817350952, 4823.300621409893, 4839.298301746245, 4763.737994410315, 4782.450018247902, 4791.832285869995, 4810.39870016248, 4836.2987366831785, 3583.94624080639, 3656.213914008488, 3684.336819372512, 3754.643308885665, 3809.923801523968, 3752.212035472554, 3775.9433608495897, 3781.4327850822324, 3792.9810350948205, 3809.8857034289017, 3537.770044947083, 3748.3815170496973, 3763.1156678180605, 3765.8870233893026, 3769.0024287127867, 3619.2037751694584, 3761.322961866863, 3771.7171212159196, 3772.6415990480996, 3784.375578029649, 3305.2397948471985, 3305.8760021592775, 3315.7181639560667, 3319.2531680371962, 3319.7842140260805, 4592.563706447882, 4595.70127941686, 4612.95387046132, 4615.607673347769, 4643.721376717374, 4039.555648878621, 4235.25882970479, 4240.151969606091, 4281.250781113293, 4288.785560721983, 4909.384031025527, 4938.925916111261, 4941.752912354404, 4961.776720047606, 4963.553280204799, 3523.3834079036064, 3531.4173161428334, 3546.556680414948, 3548.3790336690977, 3553.5380400547765, 5056.83947532792, 5215.191645294985, 5219.538529211789, 5227.294315267428, 5252.896891652796, 3588.372034893883, 3618.0231337538717, 3629.6007439181667, 3632.5096112025067, 3642.745007849478, 3658.176910195238, 3658.725595580342, 3677.3748462761396, 3677.8161091945294, 3681.5398075240596, 4215.325547912319, 4223.894402639959, 4229.59818817218, 4235.661147108224, 4241.533431322552, 4910.975445122752, 5027.4721154279005, 5029.371328583927, 5032.572231360302, 5046.44489106198, 1253.9153632108162, 1264.4626033935724, 1267.309316422552, 1268.5940499040403, 1269.6762325607096, 792.92162658784, 800.87986801979, 897.8518544440225, 919.3977944446399, 924.0990034716098, 4314.870553883388, 4347.586979236968, 4347.956520434818, 4360.931571764938, 4361.760103194355, 5006.774695138727, 5061.8487142964095, 5073.467285934998, 5097.388313402341, 5152.892128192457, 4241.554636763157, 4402.229609818269, 4402.669799764966, 4429.601335879786, 4431.977840110779, 2710.8915643374044, 2731.7814574833965, 2738.3017330580574, 2750.35366688828, 2768.1972228053637, 4805.543473370094, 4822.662413631012, 4841.15279826029, 4856.8785780355065, 4870.172070747982, 5134.897302053938, 5229.0, 5252.395974462909, 5273.841784746463, 5275.182346736262, 4749.453812811433, 4753.857384278477, 4840.95159048405, 4841.685290456109, 4875.219964805614, 5019.372578427697, 5057.924131138109, 5068.949310506848, 5069.847904562869, 5072.82245121419, 4781.211100168433, 5028.541722900464, 5028.874278143076, 5029.164355010322, 5032.0, 4779.689320194177, 4797.320937671787, 4819.228923372244, 4823.662343636052, 4828.637852161031, 3707.6663100321102, 3745.176061266517, 3746.6440688134585, 3754.136548593784, 3769.264993326275, 4883.658143930033, 5063.493650634907, 5072.847814565422, 5121.359830021247, 5244.9737751310995, 5055.570276526537, 5068.847934561969, 5071.594272458268, 5076.071092984642, 5078.441371449064, 4964.67729597575, 5010.799568017239, 5069.1635880079375, 5089.931114465856, 5090.0, 4680.438347398198, 4817.349657796152, 4930.704157750546, 4963.156263435152, 4969.180085285887, 4937.481564435682, 5039.47085556026, 5060.949390506048, 5064.0, 5073.543381095719, 4902.264660300983, 4918.852434426973, 4935.728534930613, 4939.728314942713, 4979.875503112451], "value": 3766.970426210074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.959082455053, 707.2503146664536, 724.6231959381125, 727.3163226567027, 755.4409736794772, 12406.689832754175, 12862.228266304028, 12870.227786332804, 12894.161879477828, 12924.806127908078, 13122.147060441064, 13276.867231327684, 13278.402471888765, 13279.867201327985, 13289.933550332258, 620.8230654263535, 635.6249812610558, 750.0886422996059, 776.3788968824946, 779.8362343907786, 755.0750330844726, 759.5860256160406, 761.9619019049053, 762.3672351947897, 762.4548447859779, 793.654760179321, 801.6192308653372, 801.6512816924627, 801.7474495533888, 804.5293503300576, 643.787550108463, 792.7066985215479, 809.9190080991913, 810.3922058456158, 811.2617518058597, 589.6285340235667, 593.3413910559276, 593.5311104227656, 593.8693487432757, 594.088074805172, 12333.260004399765, 12363.196392234477, 12372.690682732913, 12372.81440778389, 12385.318807465586, 11668.533258669642, 12138.514459421702, 12267.815982760265, 12459.06557008228, 12540.937295313557, 11066.446677666085, 11151.888481115166, 11418.657440276806, 11720.765584688259, 11723.941380293129, 4039.899002524931, 4099.282625540519, 4131.008557946071, 4150.377443383486, 4173.061061261192, 54695.72652136714, 56821.43178568203, 56841.71579142119, 56842.71578642122, 60292.0, 10159.187265018782, 10176.0, 10484.26610137283, 10512.21158413122, 10526.526306316235, 17086.743698844526, 17698.380556680455, 18827.81172188288, 18848.717269240973, 18857.151428185764, 6364.109024736541, 6387.425131738166, 6458.354164583598, 6539.411452969255, 6619.106420633153, 3435.450327947566, 3501.264734405803, 3503.8423270952867, 3511.3152935177905, 3548.8580456781438, 2944.4258369618146, 3054.3585846972383, 3058.342456371891, 3058.388322335542, 3062.2344413896526, 452.93885325481295, 500.20717163295853, 507.64211231082, 512.943576206617, 527.8522013836132, 450.8039003033625, 548.5145646103227, 572.9627574207664, 594.3284088979426, 625.9015427923964, 7983.920160798434, 7997.280244777998, 8141.104478507359, 8210.384221183434, 8435.114312997048, 452.46157073083583, 466.92529195329263, 528.02315715926, 544.6677526708704, 555.1256770586342, 4051.4125451809323, 4124.835006599762, 4144.5026596808575, 4203.726757760735, 4374.300111982067, 59159.0, 60027.69986150041, 60251.39748602545, 81305.59347203345, 99387.05516503549, 53569.46430535645, 66907.0, 76341.23658763453, 87620.12379876248, 89598.55200723954, 80022.0, 80606.59696701597, 81194.59402702948, 81931.0, 82461.0, 7750.92249077502, 7806.531608103532, 7904.446688731734, 8118.147594502729, 8166.83666326682, 46371.0, 46462.0, 48071.0, 48198.51801482081, 49122.75438622927, 65492.34507654863, 67919.3208067913, 68476.97284540835, 68584.3141568598, 70567.29432705608, 10038.749031274276, 10240.166272801462, 10260.486975651336, 10304.793904121725, 10323.48382580853, 10481.37111773296, 10611.363318200933, 11114.27757195812, 11984.520619175135, 12234.143609947218, 9097.59060842277, 9111.863322050041, 9206.677766278148, 9211.953940230256, 9265.027172146827, 9782.608695652094, 10016.949915250378, 10121.342112762646, 10136.847947280648, 10317.432541210306, 10109.140723038625, 10156.593736250763, 10171.186305095427, 10360.430176340373, 10406.791864162524, 8989.235914947303, 9306.208972237435, 9329.440233586007, 9386.389884657476, 9654.0, 9004.729858104267, 9125.817483650157, 9192.218661413588, 9427.764305892408, 9488.857667135137], "value": 6320.403606790171, "unit": "score"}], "name": "dromaeo_css", "value": 6251.438998169789, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 115.0, 117.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 130.0, 186.0, 136.0, 131.0, 155.0, 129.0, 167.0, 131.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 165.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 110.0, 76.0, 85.0, 75.0, 75.0, 99.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 111.0, 86.0, 87.0, 87.0, 130.0, 85.0, 86.0, 120.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 65.0, 65.0, 64.0, 63.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 65.0, 66.0, 65.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 83.0, 83.0, 83.0, 85.0, 85.0, 83.0, 119.0, 90.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 132.0, 138.0, 132.0, 135.0, 132.0, 130.0, 137.0, 132.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 170.0, 171.0, 174.0, 172.0, 176.0, 176.0, 168.0, 175.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 67.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1547.0000000000002, "alertThreshold": 2.0}]} 08:58:18 INFO - Return code: 0 08:58:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:18 ERROR - # TBPL SUCCESS # 08:58:18 INFO - Running post-action listener: _resource_record_post_action 08:58:18 INFO - ##### 08:58:18 INFO - ##### Finished run-tests step (success) 08:58:18 INFO - ##### 08:58:18 INFO - Running post-run listener: _resource_record_post_run 08:58:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533794816; Read time: 392; Write time: 856748 08:58:18 INFO - TinderboxPrint: CPU usage
13.1% 08:58:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 392 08:58:18 INFO - TinderboxPrint: I/O write bytes / time
533,794,816 / 856,748 08:58:18 INFO - TinderboxPrint: CPU idle
8,326.2 (86.9%) 08:58:18 INFO - TinderboxPrint: CPU user
1,212.1 (12.6%) 08:58:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:18 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 237568000; Read time: 392; Write time: 423580 08:58:18 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 296226816; Read time: 0; Write time: 433168 08:58:19 INFO - Running post-run listener: _upload_blobber_files 08:58:19 INFO - Blob upload gear active. 08:58:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:20 INFO - (blobuploader) - INFO - Done attempting. 08:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:25 INFO - (blobuploader) - INFO - Done attempting. 08:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:26 INFO - (blobuploader) - INFO - Done attempting. 08:58:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:26 INFO - Return code: 0 08:58:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5b801e2a25b5410a70721297d3e45a3fd9315072048d8a50c301a1c90bacd6c328c45a0770a4569da77a0e43d3e274527d05ac8e346eb6fe15cdc1c46a131a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/156c5854a4787f5b541f514a6fae0294a4181b0d748c8f817dbe9e2aa1ed933f7382c8fc04aff4ce9b96e56b312706b156918fc57393a6445b37ab2b93f7139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26b84823f5ddac0d30ebe316a87a2802c968e2d763dc2653a886216d08162103cb31145deaff64599a44d3c77af70b9f023ca9da56f46a187cffb29403b17e96"} 08:58:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:26 INFO - Contents: 08:58:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5b801e2a25b5410a70721297d3e45a3fd9315072048d8a50c301a1c90bacd6c328c45a0770a4569da77a0e43d3e274527d05ac8e346eb6fe15cdc1c46a131a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/156c5854a4787f5b541f514a6fae0294a4181b0d748c8f817dbe9e2aa1ed933f7382c8fc04aff4ce9b96e56b312706b156918fc57393a6445b37ab2b93f7139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26b84823f5ddac0d30ebe316a87a2802c968e2d763dc2653a886216d08162103cb31145deaff64599a44d3c77af70b9f023ca9da56f46a187cffb29403b17e96"} 08:58:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:26 INFO - Copying logs to upload dir... 08:58:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.960031 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-07 08:58:26.272651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:58:26.277012) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5b801e2a25b5410a70721297d3e45a3fd9315072048d8a50c301a1c90bacd6c328c45a0770a4569da77a0e43d3e274527d05ac8e346eb6fe15cdc1c46a131a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/156c5854a4787f5b541f514a6fae0294a4181b0d748c8f817dbe9e2aa1ed933f7382c8fc04aff4ce9b96e56b312706b156918fc57393a6445b37ab2b93f7139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26b84823f5ddac0d30ebe316a87a2802c968e2d763dc2653a886216d08162103cb31145deaff64599a44d3c77af70b9f023ca9da56f46a187cffb29403b17e96"} build_url:https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/PM-3_GhJT0Wn-yHch65kbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5b801e2a25b5410a70721297d3e45a3fd9315072048d8a50c301a1c90bacd6c328c45a0770a4569da77a0e43d3e274527d05ac8e346eb6fe15cdc1c46a131a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/156c5854a4787f5b541f514a6fae0294a4181b0d748c8f817dbe9e2aa1ed933f7382c8fc04aff4ce9b96e56b312706b156918fc57393a6445b37ab2b93f7139e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26b84823f5ddac0d30ebe316a87a2802c968e2d763dc2653a886216d08162103cb31145deaff64599a44d3c77af70b9f023ca9da56f46a187cffb29403b17e96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:58:26.302899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:58:26.303335) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465313857.908228-323987087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:58:26.389136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:58:26.389518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:58:26.389864) ========= ========= Total master_lag: 0.17 =========