builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1464998508.95 results: success (0) buildid: 20160603143006 builduid: 146f572a2336485094a9e4e9df8cc87c revision: ab5e81678aaae8da42e11e8daf118e2a9c90baac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:48.948148) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:48.948619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:48.948993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:48.987358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:48.987726) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 17:01:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-06-03 17:01:49 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.130953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.131306) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.183399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.184184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab5e81678aaae8da42e11e8daf118e2a9c90baac --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 ab5e81678aaae8da42e11e8daf118e2a9c90baac --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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 17:01:49,329 truncating revision to first 12 chars 2016-06-03 17:01:49,329 Setting DEBUG logging. 2016-06-03 17:01:49,329 attempt 1/10 2016-06-03 17:01:49,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab5e81678aaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 17:01:49,632 unpacking tar archive at: fx-team-ab5e81678aaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.824955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.825290) ========= script_repo_revision: ab5e81678aaae8da42e11e8daf118e2a9c90baac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.825719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.826031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 17:01:49.837472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-03 17:01:49.837793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:50 INFO - MultiFileLogger online at 20160603 17:01:50 in /builds/slave/test 17:01:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:50 INFO - {'append_to_log': False, 17:01:50 INFO - 'base_work_dir': '/builds/slave/test', 17:01:50 INFO - 'blob_upload_branch': 'Fx-Team', 17:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:50 INFO - 'branch': 'Fx-Team', 17:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:50 INFO - 'config_files': ('talos/linux_config.py',), 17:01:50 INFO - 'default_actions': ('clobber', 17:01:50 INFO - 'read-buildbot-config', 17:01:50 INFO - 'download-and-extract', 17:01:50 INFO - 'populate-webroot', 17:01:50 INFO - 'create-virtualenv', 17:01:50 INFO - 'install', 17:01:50 INFO - 'run-tests'), 17:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:50 INFO - 'download_minidump_stackwalk': True, 17:01:50 INFO - 'download_symbols': 'ondemand', 17:01:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:50 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:50 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:50 INFO - 'installer_path': 'installer.exe', 17:01:50 INFO - 'log_level': 'info', 17:01:50 INFO - 'log_name': 'talos', 17:01:50 INFO - 'log_to_console': True, 17:01:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:50 INFO - 'opt_config_files': (), 17:01:50 INFO - 'pip_index': False, 17:01:50 INFO - 'sps_profile': False, 17:01:50 INFO - 'sps_profile_interval': 0, 17:01:50 INFO - 'suite': 'dromaeojs-e10s', 17:01:50 INFO - 'system_bits': '32', 17:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:50 INFO - 'title': 'talos-linux64-ix-001', 17:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:50 INFO - 'use_talos_json': True, 17:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:50 INFO - 'work_dir': 'build'} 17:01:50 INFO - ##### 17:01:50 INFO - ##### Running clobber step. 17:01:50 INFO - ##### 17:01:50 INFO - Running pre-action listener: _resource_record_pre_action 17:01:50 INFO - Running main action method: clobber 17:01:50 INFO - rmtree: /builds/slave/test/build 17:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:50 INFO - Running post-action listener: _resource_record_post_action 17:01:50 INFO - ##### 17:01:50 INFO - ##### Finished clobber step (success) 17:01:50 INFO - ##### 17:01:50 INFO - ##### 17:01:50 INFO - ##### Running read-buildbot-config step. 17:01:50 INFO - ##### 17:01:50 INFO - Running pre-action listener: _resource_record_pre_action 17:01:50 INFO - Running main action method: read_buildbot_config 17:01:50 INFO - Using buildbot properties: 17:01:50 INFO - { 17:01:50 INFO - "project": "", 17:01:50 INFO - "product": "firefox", 17:01:50 INFO - "script_repo_revision": "production", 17:01:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:01:50 INFO - "repository": "", 17:01:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:01:50 INFO - "buildid": "20160603143006", 17:01:50 INFO - "pgo_build": "True", 17:01:50 INFO - "basedir": "/builds/slave/test", 17:01:50 INFO - "buildnumber": 809, 17:01:50 INFO - "slavename": "talos-linux64-ix-001", 17:01:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:01:50 INFO - "platform": "ubuntu64_hw", 17:01:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:01:50 INFO - "branch": "fx-team", 17:01:50 INFO - "repo_path": "integration/fx-team", 17:01:50 INFO - "revision": "ab5e81678aaae8da42e11e8daf118e2a9c90baac", 17:01:50 INFO - "stage_platform": "linux64-pgo", 17:01:50 INFO - "builduid": "146f572a2336485094a9e4e9df8cc87c", 17:01:50 INFO - "slavebuilddir": "test" 17:01:50 INFO - } 17:01:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:01:50 INFO - Running post-action listener: _resource_record_post_action 17:01:50 INFO - ##### 17:01:50 INFO - ##### Finished read-buildbot-config step (success) 17:01:50 INFO - ##### 17:01:50 INFO - ##### 17:01:50 INFO - ##### Running download-and-extract step. 17:01:50 INFO - ##### 17:01:50 INFO - Running pre-action listener: _resource_record_pre_action 17:01:50 INFO - Running main action method: download_and_extract 17:01:50 INFO - mkdir: /builds/slave/test/build/tests 17:01: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')]} 17:01:50 INFO - https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:01:51 INFO - Downloaded 1361 bytes. 17:01:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:51 INFO - Using the following test package requirements: 17:01:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:01:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:01:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'jsshell-linux-x86_64.zip'], 17:01:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:01:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:01:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:01:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:01:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:01:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:01:51 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')]} 17:01:51 INFO - https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:52 INFO - Downloaded 24440968 bytes. 17:01:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:01:54 INFO - Return code: 0 17:01:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:01:54 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')]} 17:01:54 INFO - https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:56 INFO - Downloaded 24440968 bytes. 17:01:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:01:57 INFO - Return code: 0 17:01:57 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')]} 17:01:57 INFO - https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:01:58 INFO - Downloaded 10833369 bytes. 17:01:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:01:59 INFO - Return code: 0 17:01:59 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')]} 17:01:59 INFO - https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:01:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:02:00 INFO - Downloaded 59141391 bytes. 17:02:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:02:00 INFO - mkdir: /builds/slave/test/properties 17:02:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:00 INFO - Contents: 17:02:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:02:01 INFO - Running post-action listener: _resource_record_post_action 17:02:01 INFO - Running post-action listener: set_extra_try_arguments 17:02:01 INFO - ##### 17:02:01 INFO - ##### Finished download-and-extract step (success) 17:02:01 INFO - ##### 17:02:01 INFO - ##### 17:02:01 INFO - ##### Running populate-webroot step. 17:02:01 INFO - ##### 17:02:01 INFO - Running pre-action listener: _resource_record_pre_action 17:02:01 INFO - Running main action method: populate_webroot 17:02:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:01 INFO - '--tppagecycles', 17:02:01 INFO - '7'], 17:02:01 INFO - 'tests': ['tsvgm']}}, 17:02:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['damp', 'tps']}, 17:02:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'tests': ['damp', 'tps']}, 17:02:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['dromaeo_dom']}, 17:02:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['a11yr', 17:02:01 INFO - 'ts_paint', 17:02:01 INFO - 'tpaint', 17:02:01 INFO - 'sessionrestore', 17:02:01 INFO - 'sessionrestore_no_auto_restore', 17:02:01 INFO - 'tabpaint']}, 17:02:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['tsvgx', 17:02:01 INFO - 'tsvgr_opacity', 17:02:01 INFO - 'tart', 17:02:01 INFO - 'tscrollx', 17:02:01 INFO - 'cart']}, 17:02:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:01 INFO - 'tsvgr_opacity', 17:02:01 INFO - 'tart', 17:02:01 INFO - 'tscrollx', 17:02:01 INFO - 'cart']}, 17:02:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'talos_options': ['--disable-e10s'], 17:02:01 INFO - 'tests': ['tp5o']}, 17:02:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'tests': ['tp5o']}, 17:02:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'talos_options': ['--disable-e10s', 17:02:01 INFO - '--xperf_path', 17:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:01 INFO - 'tests': ['tp5n']}, 17:02:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:01 INFO - 'talos_options': ['--xperf_path', 17:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:01 INFO - 'tests': ['tp5n']}}, 17:02:01 INFO - 'talos.zip': {'path': '', 17:02:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:01 INFO - Running post-action listener: _resource_record_post_action 17:02:01 INFO - ##### 17:02:01 INFO - ##### Finished populate-webroot step (success) 17:02:01 INFO - ##### 17:02:01 INFO - ##### 17:02:01 INFO - ##### Running create-virtualenv step. 17:02:01 INFO - ##### 17:02:01 INFO - Running pre-action listener: _resource_record_pre_action 17:02:01 INFO - Running main action method: create_virtualenv 17:02:01 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:01 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 17:02:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:01 INFO - Using real prefix '/usr' 17:02:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:03 INFO - Installing pip.................done. 17:02:03 INFO - Return code: 0 17:02:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02: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')]} 17:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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')]} 17:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02: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', 'pip>=1.5'] in /builds/slave/test/build 17:02: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 pip>=1.5 17:02:03 INFO - Using env: {'DISPLAY': ':0', 17:02:03 INFO - 'HOME': '/home/cltbld', 17:02:03 INFO - 'LANG': 'en_US.UTF-8', 17:02:03 INFO - 'LANGUAGE': 'en_US:en', 17:02:03 INFO - 'LOGNAME': 'cltbld', 17:02:03 INFO - 'MAIL': '/var/mail/cltbld', 17:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:03 INFO - 'MOZ_NO_REMOTE': '1', 17:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:03 INFO - 'NO_EM_RESTART': '1', 17:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:03 INFO - 'PWD': '/builds/slave/test', 17:02:03 INFO - 'SHELL': '/bin/bash', 17:02:03 INFO - 'SHLVL': '1', 17:02:03 INFO - 'TERM': 'linux', 17:02:03 INFO - 'TMOUT': '86400', 17:02:03 INFO - 'USER': 'cltbld', 17:02:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:03 INFO - '_': '/tools/buildbot/bin/python'} 17:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:04 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 17:02:04 INFO - Cleaning up... 17:02:04 INFO - Return code: 0 17:02:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02:04 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')]} 17:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:04 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')]} 17:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:04 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:04 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 17:02:04 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 17:02:04 INFO - Using env: {'DISPLAY': ':0', 17:02:04 INFO - 'HOME': '/home/cltbld', 17:02:04 INFO - 'LANG': 'en_US.UTF-8', 17:02:04 INFO - 'LANGUAGE': 'en_US:en', 17:02:04 INFO - 'LOGNAME': 'cltbld', 17:02:04 INFO - 'MAIL': '/var/mail/cltbld', 17:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:04 INFO - 'MOZ_NO_REMOTE': '1', 17:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:04 INFO - 'NO_EM_RESTART': '1', 17:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:04 INFO - 'PWD': '/builds/slave/test', 17:02:04 INFO - 'SHELL': '/bin/bash', 17:02:04 INFO - 'SHLVL': '1', 17:02:04 INFO - 'TERM': 'linux', 17:02:04 INFO - 'TMOUT': '86400', 17:02:04 INFO - 'USER': 'cltbld', 17:02:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:04 INFO - '_': '/tools/buildbot/bin/python'} 17:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:04 INFO - Downloading/unpacking psutil>=3.1.1 17:02:04 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 17:02:04 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 17:02:04 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 17:02:04 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 17:02:04 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 17:02:04 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 17:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:06 INFO - Installing collected packages: psutil 17:02:06 INFO - Running setup.py install for psutil 17:02:06 INFO - building 'psutil._psutil_linux' extension 17:02:06 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 17:02:06 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 17:02:06 INFO - building 'psutil._psutil_posix' extension 17:02:06 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 17:02:06 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 17:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:06 INFO - Successfully installed psutil 17:02:06 INFO - Cleaning up... 17:02:06 INFO - Return code: 0 17:02:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:02: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')]} 17:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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')]} 17:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:06 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:06 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 17:02:06 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 17:02:06 INFO - Using env: {'DISPLAY': ':0', 17:02:06 INFO - 'HOME': '/home/cltbld', 17:02:06 INFO - 'LANG': 'en_US.UTF-8', 17:02:06 INFO - 'LANGUAGE': 'en_US:en', 17:02:06 INFO - 'LOGNAME': 'cltbld', 17:02:06 INFO - 'MAIL': '/var/mail/cltbld', 17:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:06 INFO - 'MOZ_NO_REMOTE': '1', 17:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:06 INFO - 'NO_EM_RESTART': '1', 17:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:06 INFO - 'PWD': '/builds/slave/test', 17:02:06 INFO - 'SHELL': '/bin/bash', 17:02:06 INFO - 'SHLVL': '1', 17:02:06 INFO - 'TERM': 'linux', 17:02:06 INFO - 'TMOUT': '86400', 17:02:06 INFO - 'USER': 'cltbld', 17:02:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:06 INFO - '_': '/tools/buildbot/bin/python'} 17:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:02:07 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 17:02:07 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 17:02:07 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 17:02:07 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 17:02:07 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 17:02:07 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 17:02:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:02:09 INFO - Installing collected packages: mozsystemmonitor 17:02:09 INFO - Running setup.py install for mozsystemmonitor 17:02:09 INFO - Successfully installed mozsystemmonitor 17:02:09 INFO - Cleaning up... 17:02:09 INFO - Return code: 0 17:02:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:02:09 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')]} 17:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:09 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')]} 17:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:09 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:09 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 17:02:09 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 17:02:09 INFO - Using env: {'DISPLAY': ':0', 17:02:09 INFO - 'HOME': '/home/cltbld', 17:02:09 INFO - 'LANG': 'en_US.UTF-8', 17:02:09 INFO - 'LANGUAGE': 'en_US:en', 17:02:09 INFO - 'LOGNAME': 'cltbld', 17:02:09 INFO - 'MAIL': '/var/mail/cltbld', 17:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:09 INFO - 'MOZ_NO_REMOTE': '1', 17:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:09 INFO - 'NO_EM_RESTART': '1', 17:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:09 INFO - 'PWD': '/builds/slave/test', 17:02:09 INFO - 'SHELL': '/bin/bash', 17:02:09 INFO - 'SHLVL': '1', 17:02:09 INFO - 'TERM': 'linux', 17:02:09 INFO - 'TMOUT': '86400', 17:02:09 INFO - 'USER': 'cltbld', 17:02:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:09 INFO - '_': '/tools/buildbot/bin/python'} 17:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:09 INFO - Downloading/unpacking jsonschema==2.5.1 17:02:09 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 17:02:09 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 17:02:09 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 17:02:09 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 17:02:09 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 17:02:09 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 17:02:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:11 INFO - warning: no files found matching '*.txt' 17:02:11 INFO - no previously-included directories found matching 'build' 17:02:11 INFO - no previously-included directories found matching 'dist' 17:02:11 INFO - no previously-included directories found matching '.git*' 17:02:11 INFO - Installing collected packages: jsonschema, functools32 17:02:11 INFO - Running setup.py install for functools32 17:02:11 INFO - warning: no files found matching '*.txt' 17:02:11 INFO - no previously-included directories found matching 'build' 17:02:11 INFO - no previously-included directories found matching 'dist' 17:02:11 INFO - no previously-included directories found matching '.git*' 17:02:11 INFO - Successfully installed jsonschema functools32 17:02:11 INFO - Cleaning up... 17:02:11 INFO - Return code: 0 17:02:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:11 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')]} 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 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')]} 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:11 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 17:02:11 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 17:02:11 INFO - Using env: {'DISPLAY': ':0', 17:02:11 INFO - 'HOME': '/home/cltbld', 17:02:11 INFO - 'LANG': 'en_US.UTF-8', 17:02:11 INFO - 'LANGUAGE': 'en_US:en', 17:02:11 INFO - 'LOGNAME': 'cltbld', 17:02:11 INFO - 'MAIL': '/var/mail/cltbld', 17:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:11 INFO - 'MOZ_NO_REMOTE': '1', 17:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:11 INFO - 'NO_EM_RESTART': '1', 17:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:11 INFO - 'PWD': '/builds/slave/test', 17:02:11 INFO - 'SHELL': '/bin/bash', 17:02:11 INFO - 'SHLVL': '1', 17:02:11 INFO - 'TERM': 'linux', 17:02:11 INFO - 'TMOUT': '86400', 17:02:11 INFO - 'USER': 'cltbld', 17:02:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:11 INFO - '_': '/tools/buildbot/bin/python'} 17:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02:14 INFO - Downloading docopt-0.6.1.tar.gz 17:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:14 INFO - Running setup.py install for blobuploader 17:02:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:14 INFO - Running setup.py install for requests 17:02:15 INFO - Running setup.py install for docopt 17:02:15 INFO - Successfully installed blobuploader requests docopt 17:02:15 INFO - Cleaning up... 17:02:15 INFO - Return code: 0 17:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:15 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')]} 17:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:15 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')]} 17:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:15 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:15 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 17:02:15 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 17:02:15 INFO - Using env: {'DISPLAY': ':0', 17:02:15 INFO - 'HOME': '/home/cltbld', 17:02:15 INFO - 'LANG': 'en_US.UTF-8', 17:02:15 INFO - 'LANGUAGE': 'en_US:en', 17:02:15 INFO - 'LOGNAME': 'cltbld', 17:02:15 INFO - 'MAIL': '/var/mail/cltbld', 17:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:15 INFO - 'MOZ_NO_REMOTE': '1', 17:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:15 INFO - 'NO_EM_RESTART': '1', 17:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:15 INFO - 'PWD': '/builds/slave/test', 17:02:15 INFO - 'SHELL': '/bin/bash', 17:02:15 INFO - 'SHLVL': '1', 17:02:15 INFO - 'TERM': 'linux', 17:02:15 INFO - 'TMOUT': '86400', 17:02:15 INFO - 'USER': 'cltbld', 17:02:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:15 INFO - '_': '/tools/buildbot/bin/python'} 17:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:15 INFO - Running setup.py (path:/tmp/pip-GeoVwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:15 INFO - Running setup.py (path:/tmp/pip-ig1G4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:15 INFO - Running setup.py (path:/tmp/pip-YXt3a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:15 INFO - Running setup.py (path:/tmp/pip-TXiQmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:15 INFO - Running setup.py (path:/tmp/pip-sbVKfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:15 INFO - Running setup.py (path:/tmp/pip-60UEXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:15 INFO - Running setup.py (path:/tmp/pip-Im3O2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:15 INFO - Running setup.py (path:/tmp/pip-gxPL8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:15 INFO - Running setup.py (path:/tmp/pip-Fy_wqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:16 INFO - Running setup.py (path:/tmp/pip-taiqXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:16 INFO - Running setup.py (path:/tmp/pip-AC62jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:16 INFO - Running setup.py (path:/tmp/pip-2x6UPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:16 INFO - Running setup.py (path:/tmp/pip-oy5z2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:16 INFO - Running setup.py (path:/tmp/pip-EN6Fm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:16 INFO - Running setup.py (path:/tmp/pip-OM4_2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:16 INFO - Running setup.py (path:/tmp/pip-2rDjoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:16 INFO - Running setup.py (path:/tmp/pip-5vDORk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:16 INFO - Running setup.py install for manifestparser 17:02:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:16 INFO - Running setup.py install for mozcrash 17:02:16 INFO - Running setup.py install for mozdebug 17:02:16 INFO - Running setup.py install for mozdevice 17:02:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozfile 17:02:17 INFO - Running setup.py install for mozhttpd 17:02:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozinfo 17:02:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozInstall 17:02:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozleak 17:02:17 INFO - Running setup.py install for mozlog 17:02:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for moznetwork 17:02:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozprocess 17:02:17 INFO - Running setup.py install for mozprofile 17:02:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:17 INFO - Running setup.py install for mozrunner 17:02:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:18 INFO - Running setup.py install for mozscreenshot 17:02:18 INFO - Running setup.py install for moztest 17:02:18 INFO - Running setup.py install for mozversion 17:02:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:18 INFO - Cleaning up... 17:02:18 INFO - Return code: 0 17:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:18 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')]} 17:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:18 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')]} 17:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:18 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:18 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 17:02:18 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 17:02:18 INFO - Using env: {'DISPLAY': ':0', 17:02:18 INFO - 'HOME': '/home/cltbld', 17:02:18 INFO - 'LANG': 'en_US.UTF-8', 17:02:18 INFO - 'LANGUAGE': 'en_US:en', 17:02:18 INFO - 'LOGNAME': 'cltbld', 17:02:18 INFO - 'MAIL': '/var/mail/cltbld', 17:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:18 INFO - 'MOZ_NO_REMOTE': '1', 17:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:18 INFO - 'NO_EM_RESTART': '1', 17:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:18 INFO - 'PWD': '/builds/slave/test', 17:02:18 INFO - 'SHELL': '/bin/bash', 17:02:18 INFO - 'SHLVL': '1', 17:02:18 INFO - 'TERM': 'linux', 17:02:18 INFO - 'TMOUT': '86400', 17:02:18 INFO - 'USER': 'cltbld', 17:02:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:18 INFO - '_': '/tools/buildbot/bin/python'} 17:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:18 INFO - Running setup.py (path:/tmp/pip-eYyVj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:18 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)) 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:18 INFO - Running setup.py (path:/tmp/pip-kGxTdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:18 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)) 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:18 INFO - Running setup.py (path:/tmp/pip-JQ8VBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:18 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)) 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:18 INFO - Running setup.py (path:/tmp/pip-s5IvTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:18 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)) 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:18 INFO - Running setup.py (path:/tmp/pip-1Y0NhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:18 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)) 17:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:18 INFO - Running setup.py (path:/tmp/pip-F5bjVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:19 INFO - Running setup.py (path:/tmp/pip-VIDlry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:19 INFO - Running setup.py (path:/tmp/pip-cPaeIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:19 INFO - Running setup.py (path:/tmp/pip-0Y8QdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:19 INFO - Running setup.py (path:/tmp/pip-Poorq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:19 INFO - Running setup.py (path:/tmp/pip-Xe1rJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:19 INFO - Running setup.py (path:/tmp/pip-kz9RVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:19 INFO - Running setup.py (path:/tmp/pip-dgpjOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:19 INFO - Running setup.py (path:/tmp/pip-FgZOPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:19 INFO - Running setup.py (path:/tmp/pip-3CbemK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:19 INFO - Running setup.py (path:/tmp/pip-xqhBjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:19 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)) 17:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:19 INFO - Running setup.py (path:/tmp/pip-anV7lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:19 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)) 17:02:19 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)) 17:02:19 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)) 17:02:19 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)) 17:02:19 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)) 17:02:19 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)) 17:02:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:19 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 17:02:19 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 17:02:19 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 17:02:19 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 17:02:19 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 17:02:19 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 17:02:21 INFO - Downloading blessings-1.6.tar.gz 17:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:21 INFO - Installing collected packages: blessings 17:02:21 INFO - Running setup.py install for blessings 17:02:21 INFO - Successfully installed blessings 17:02:21 INFO - Cleaning up... 17:02:21 INFO - Return code: 0 17:02:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:22 INFO - Reading from file tmpfile_stdout 17:02:22 INFO - Current package versions: 17:02:22 INFO - argparse == 1.2.1 17:02:22 INFO - blessings == 1.6 17:02:22 INFO - blobuploader == 1.2.4 17:02:22 INFO - docopt == 0.6.1 17:02:22 INFO - functools32 == 3.2.3-2 17:02:22 INFO - jsonschema == 2.5.1 17:02:22 INFO - manifestparser == 1.1 17:02:22 INFO - mozInstall == 1.12 17:02:22 INFO - mozcrash == 0.17 17:02:22 INFO - mozdebug == 0.1 17:02:22 INFO - mozdevice == 0.48 17:02:22 INFO - mozfile == 1.2 17:02:22 INFO - mozhttpd == 0.7 17:02:22 INFO - mozinfo == 0.9 17:02:22 INFO - mozleak == 0.1 17:02:22 INFO - mozlog == 3.2 17:02:22 INFO - moznetwork == 0.27 17:02:22 INFO - mozprocess == 0.22 17:02:22 INFO - mozprofile == 0.28 17:02:22 INFO - mozrunner == 6.11 17:02:22 INFO - mozscreenshot == 0.1 17:02:22 INFO - mozsystemmonitor == 0.3 17:02:22 INFO - moztest == 0.7 17:02:22 INFO - mozversion == 1.4 17:02:22 INFO - psutil == 3.1.1 17:02:22 INFO - requests == 1.2.3 17:02:22 INFO - wsgiref == 0.1.2 17:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:22 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')]} 17:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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')]} 17:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:22 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 17:02:22 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 17:02:22 INFO - Using env: {'DISPLAY': ':0', 17:02:22 INFO - 'HOME': '/home/cltbld', 17:02:22 INFO - 'LANG': 'en_US.UTF-8', 17:02:22 INFO - 'LANGUAGE': 'en_US:en', 17:02:22 INFO - 'LOGNAME': 'cltbld', 17:02:22 INFO - 'MAIL': '/var/mail/cltbld', 17:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:22 INFO - 'MOZ_NO_REMOTE': '1', 17:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:22 INFO - 'NO_EM_RESTART': '1', 17:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:22 INFO - 'PWD': '/builds/slave/test', 17:02:22 INFO - 'SHELL': '/bin/bash', 17:02:22 INFO - 'SHLVL': '1', 17:02:22 INFO - 'TERM': 'linux', 17:02:22 INFO - 'TMOUT': '86400', 17:02:22 INFO - 'USER': 'cltbld', 17:02:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:22 INFO - '_': '/tools/buildbot/bin/python'} 17:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 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)) 17:02:22 INFO - Cleaning up... 17:02:22 INFO - Return code: 0 17:02:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:22 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')]} 17:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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')]} 17:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:22 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 17:02:22 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 17:02:22 INFO - Using env: {'DISPLAY': ':0', 17:02:22 INFO - 'HOME': '/home/cltbld', 17:02:22 INFO - 'LANG': 'en_US.UTF-8', 17:02:22 INFO - 'LANGUAGE': 'en_US:en', 17:02:22 INFO - 'LOGNAME': 'cltbld', 17:02:22 INFO - 'MAIL': '/var/mail/cltbld', 17:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:22 INFO - 'MOZ_NO_REMOTE': '1', 17:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:22 INFO - 'NO_EM_RESTART': '1', 17:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:22 INFO - 'PWD': '/builds/slave/test', 17:02:22 INFO - 'SHELL': '/bin/bash', 17:02:22 INFO - 'SHLVL': '1', 17:02:22 INFO - 'TERM': 'linux', 17:02:22 INFO - 'TMOUT': '86400', 17:02:22 INFO - 'USER': 'cltbld', 17:02:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:22 INFO - '_': '/tools/buildbot/bin/python'} 17:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:02:22 INFO - Cleaning up... 17:02:22 INFO - Return code: 0 17:02:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:02:22 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')]} 17:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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')]} 17:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:22 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 0x7fbb60bf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, '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': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', '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 17:02:22 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 17:02:22 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 17:02:22 INFO - Using env: {'DISPLAY': ':0', 17:02:22 INFO - 'HOME': '/home/cltbld', 17:02:22 INFO - 'LANG': 'en_US.UTF-8', 17:02:22 INFO - 'LANGUAGE': 'en_US:en', 17:02:22 INFO - 'LOGNAME': 'cltbld', 17:02:22 INFO - 'MAIL': '/var/mail/cltbld', 17:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:22 INFO - 'MOZ_NO_REMOTE': '1', 17:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:22 INFO - 'NO_EM_RESTART': '1', 17:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:22 INFO - 'PWD': '/builds/slave/test', 17:02:22 INFO - 'SHELL': '/bin/bash', 17:02:22 INFO - 'SHLVL': '1', 17:02:22 INFO - 'TERM': 'linux', 17:02:22 INFO - 'TMOUT': '86400', 17:02:22 INFO - 'USER': 'cltbld', 17:02:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:22 INFO - '_': '/tools/buildbot/bin/python'} 17:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:22 INFO - Downloading/unpacking flake8 17:02:22 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 17:02:22 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 17:02:22 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 17:02:22 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 17:02:22 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 17:02:22 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 17:02:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:02:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:02:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:02:25 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 17:02:25 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 17:02:25 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 17:02:25 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 17:02:25 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 17:02:25 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 17:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:02:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:25 INFO - no previously-included directories found matching 'docs/_build' 17:02:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:02:25 INFO - Running setup.py install for pep8 17:02:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:25 INFO - no previously-included directories found matching 'docs/_build' 17:02:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:02:25 INFO - Cleaning up... 17:02:25 INFO - Return code: 0 17:02:25 INFO - Running post-action listener: _resource_record_post_action 17:02:25 INFO - Running post-action listener: _start_resource_monitoring 17:02:25 INFO - Starting resource monitoring. 17:02:25 INFO - ##### 17:02:25 INFO - ##### Finished create-virtualenv step (success) 17:02:25 INFO - ##### 17:02:25 INFO - ##### 17:02:25 INFO - ##### Running install step. 17:02:25 INFO - ##### 17:02:25 INFO - Running pre-action listener: _resource_record_pre_action 17:02:25 INFO - Running main action method: install 17:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:25 INFO - Reading from file tmpfile_stdout 17:02:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:26 INFO - Reading from file tmpfile_stdout 17:02:26 INFO - Output received: 17:02:26 INFO - Usage: mozinstall [options] installer 17:02:26 INFO - Options: 17:02:26 INFO - -h, --help show this help message and exit 17:02:26 INFO - -d DEST, --destination=DEST 17:02:26 INFO - Directory to install application into. [default: 17:02:26 INFO - "/builds/slave/test"] 17:02:26 INFO - --app=APP Application being installed. [default: firefox] 17:02:26 INFO - mkdir: /builds/slave/test/build/application 17:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:02:42 INFO - Reading from file tmpfile_stdout 17:02:42 INFO - Output received: 17:02:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:02:42 INFO - Running post-action listener: _resource_record_post_action 17:02:42 INFO - ##### 17:02:42 INFO - ##### Finished install step (success) 17:02:42 INFO - ##### 17:02:42 INFO - ##### 17:02:42 INFO - ##### Running run-tests step. 17:02:42 INFO - ##### 17:02:42 INFO - Running pre-action listener: _resource_record_pre_action 17:02:42 INFO - Running main action method: run_tests 17:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:02:42 INFO - Python 2.7.3 17:02:42 INFO - Return code: 0 17:02:42 INFO - grabbing minidump binary from tooltool 17:02: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')]} 17:02:42 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 0x1c201c0>, '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 0x1c210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:02:42 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 17:02:42 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 17:02:42 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 17:02:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:02:42 INFO - Return code: 0 17:02:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:02:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:02:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:02:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:02:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:02:43 INFO - Return code: 0 17:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:02:43 INFO - Using env: {'DISPLAY': ':0', 17:02:43 INFO - 'HOME': '/home/cltbld', 17:02:43 INFO - 'LANG': 'en_US.UTF-8', 17:02:43 INFO - 'LANGUAGE': 'en_US:en', 17:02:43 INFO - 'LOGNAME': 'cltbld', 17:02:43 INFO - 'MAIL': '/var/mail/cltbld', 17:02:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:43 INFO - 'MOZ_NO_REMOTE': '1', 17:02:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:43 INFO - 'NO_EM_RESTART': '1', 17:02:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:43 INFO - 'PWD': '/builds/slave/test', 17:02:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:43 INFO - 'SHELL': '/bin/bash', 17:02:43 INFO - 'SHLVL': '1', 17:02:43 INFO - 'TERM': 'linux', 17:02:43 INFO - 'TMOUT': '86400', 17:02:43 INFO - 'USER': 'cltbld', 17:02:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049', 17:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:43 INFO - '_': '/tools/buildbot/bin/python'} 17:02:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:02:43 INFO - mozversion application_buildid: 20160603143006 17:02:43 INFO - mozversion application_changeset: ab5e81678aaae8da42e11e8daf118e2a9c90baac 17:02:43 INFO - mozversion application_display_name: Nightly 17:02:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:02:43 INFO - mozversion application_name: Firefox 17:02:43 INFO - mozversion application_remotingname: firefox 17:02:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:02:43 INFO - mozversion application_vendor: Mozilla 17:02:43 INFO - mozversion application_version: 49.0a1 17:02:43 INFO - mozversion platform_buildid: 20160603143006 17:02:43 INFO - mozversion platform_changeset: ab5e81678aaae8da42e11e8daf118e2a9c90baac 17:02:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:02:43 INFO - mozversion platform_version: 49.0a1 17:02:43 INFO - using testdate: 1464998563 17:02:43 INFO - actual date: 1464998563 17:02:43 INFO - starting webserver on 'localhost:46129' 17:02:43 INFO - SUITE-START | Running 2 tests 17:02:43 INFO - TEST-START | dromaeo_css 17:02:43 INFO - operating with platform_type : linux_ 17:02:43 INFO - Initialising browser for dromaeo_css test... 17:02:44 INFO - TEST-INFO | started process 6505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3u8psK/profile http://localhost:46129/getInfo.html) 17:02:48 INFO - PROCESS | 6505 | __metrics Screen width/height:1600/1200 17:02:48 INFO - PROCESS | 6505 | colorDepth:24 17:02:48 INFO - PROCESS | 6505 | Browser inner width/height: 1024/697 17:02:48 INFO - PROCESS | 6505 | __metrics 17:02:49 ERROR - PROCESS | 6505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:02:50 INFO - TEST-INFO | 6505: exit 0 17:02:50 INFO - Browser initialized. 17:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:02:50 INFO - TEST-INFO | started process 6626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3u8psK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:02 INFO - PROCESS | 6626 | RSS: Main: 167116800 17:03:02 INFO - PROCESS | 6626 | 17:03:51 INFO - PROCESS | 6626 | 1464998631620 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] 17:05:59 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46129/tests/dromaeo/cssquery-ext.html) 17:06:00 INFO - PROCESS | 6626 | RSS: Main: 170536960 17:06:00 INFO - PROCESS | 6626 | 17:09:02 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-ext.html (next: http://localhost:46129/tests/dromaeo/cssquery-jquery.html) 17:09:03 INFO - PROCESS | 6626 | RSS: Main: 170094592 17:09:03 INFO - PROCESS | 6626 | 17:12:04 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46129/tests/dromaeo/cssquery-mootools.html) 17:12:05 INFO - PROCESS | 6626 | RSS: Main: 171462656 17:12:05 INFO - PROCESS | 6626 | 17:15:07 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46129/tests/dromaeo/cssquery-prototype.html) 17:15:07 INFO - PROCESS | 6626 | RSS: Main: 169025536 17:15:07 INFO - PROCESS | 6626 | 17:18:10 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46129/tests/dromaeo/cssquery-yui.html) 17:18:11 INFO - PROCESS | 6626 | RSS: Main: 171077632 17:18:11 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:46129/tests/dromaeo/cssquery-yui.html (next: http://localhost:46129/tests/dromaeo/cssquery-dojo.html) 17:21:14 INFO - PROCESS | 6626 | RSS: Main: 172126208 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | __start_tp_report 17:21:14 INFO - PROCESS | 6626 | _x_x_mozilla_page_load 17:21:14 INFO - PROCESS | 6626 | _x_x_mozilla_page_load_details 17:21:14 INFO - PROCESS | 6626 | |i|pagename|runs| 17:21:14 INFO - PROCESS | 6626 | |0;dojo.html;3112.3775244951007;3128.0772172209195;3160.320531085816;3173.6350319713238;3178.014815407224;5427.91858122128;5444.972775136123;5458.481444262794;5513.558915286778;5515.641483303582;5397.730113494319;5438;5448.509634132927;5472.315960504937;5509.421510741375;4916.213405855064;4936.456989731127;5040.521150490697;5078.847634570969;5127.769250383723;853.1060374232167;4882;4902.534259245366;5003.624728145385;5022.723750193738;4918.385201849769;4968.056069346831;4969.527894849984;4977.029479251547;4978.6514943953935;4981.203007518816;4983.651144419892;4987.401511818605;4988.251762235657;5008.624353173526;4945.876353091166;4985.302057711923;5001.099802035632;5006.224035274538;5019.222020586815;5423.620346575742;5443.1835224716215;5465.398806131322;5480.287562616874;5481.424450432727;5697.77208911643;5781.566382521286;5908.261467316585;5950.642961422285;5971.552133589998;5904.704764761745;5921.940780592182;5924.674142922137;5962.761489540413;5967.791127310524;5519.834404967857;5522.91715624266;5526.336839579196;5537.833864984057;5547.694876781776;5816.651000939957;5918.7928422505;6065.848353791191;6075.453209211192;6098.390160983866;5760.971195143998;5777.7977770777825;5792.594518383757;5833.212516310244;5873.794417195378;5961.076033214858;5964.850878728066;5965.522758179335;5970;5976.223090998143;5713.5714821388565;5863.853403664857;5913.497352725067;5917.55618328627;5920.763169473259;5862.325832529228;5862.736176872051;5885.087811389241;5925.496332811673;5935.762569497172;4481.7983190756495;4489.034857505587;4491.887702807456;4496.437945256843;4538.2738761797955;3917.0011647030396;3927.430522574211;3984.7409918355215;4006.6994975376965;4030.496187976503;5614.663120212718;5630.07103827872;5653.349864765522;5660.915086273709;5662;5999.760009599654;6047.758089676452;6053.727582258809;6054.212952316171;6056.091586262096;5671.092625179951;5674.858128546819;5696.430356964271;5729.455701708331;5765.8558536036935;5143.614228932845;5172.120739474299;5182.922256166085;5192.506711862367;5201.661891977009;5911.586188966731;6216.813495595049;6220.377962203834;6221.875562488724;6231.189945307081;5892.175095486636;5932.16949627044;5962.731677074629;5979.162917191684;6010.158577799024;6125.448709616156;6135.938640613536;6148.723307451265;6151.8926593213655;6158.261008678987;5686.317641883001;5783.3638299787835;5801.245838041028;5837.6497410155525;5880.059190529495;5907.763689452546;5989.940100598938;6002.489788367863;6024.548158888013;6073.878522429438;5811.476967072984;5825.893080314727;5830.883382332245;5836.153757705194;5856.94143058564;5546.362168350692;5659.830205093854;5669.262995810518;5798.652080875161;5824.271966004249;5457.672539647634;5700.3444603871085;5710.400407957105;5723.6851973141875;5736.4550367715;5862;5879.441453061952;5905.822825315247;5919.792807251725;5936.910946335722;5530.336359636869;5669.376368599368;5694.430556944272;5785.103308987113;5787.508061814793 17:21:14 INFO - PROCESS | 6626 | |1;ext.html;549.5630973376166;593.2139914613139;598.7455331484118;612.9540284478663;628.3684896678839;33063.1734206645;43543.56456435435;43704.56295437045;43870.12259754803;44137.77931110344;45823;46149.30776038362;46348;46471.53528464714;46494.5129115316;8698.912635920526;8831.77920551988;8839.116088391174;8878.689245876396;8904.554772261394;8603.741887743347;8826.691065812698;8872.73381798547;8874.778130546756;8878.24534914533;8893.866592001124;8962.955185224066;8963.41737787045;8965.820683586324;8971.551422428885;8833.425827321204;8853.601587928526;8861.025287218401;8861.822763544758;8889.866652000224;8785.165409286172;8826.779330516723;8880.289576833839;8892.244159246471;8904.73285801427;42271.577284227074;42497;42573.36139957903;42678.57321426777;42689.35965960513;3760.6615404613717;3802.638749318838;3942.704297177723;4100.958990410088;4375.7155784873885;32327.676723232937;32608.836955815306;32633.673663263537;33183.170420739676;34184;4305.78471076448;4330.740155590644;4384.627306678936;4395.670324725658;4550.340200670884;355749;356009;357968;358925.20537397405;359958;35104;36196.45705314422;54917.1762423564;55025.72487137539;55267;37602.24795504129;37712.81143594319;37921.62078379236;38045.429318560244;38056.238875222894;14293.285335733171;14359.78460323096;14448.783268250985;14458.493952711604;14459.927700361432;11695.473703683354;11735.882641173479;11765.058795296356;11833.11251656112;11881.64355069332;8423.199796019368;8430.662773488992;8496.150384961578;8533.232009119085;8579.742607721779;3233.3048394594803;3257.625373082126;3258.3483303339426;3269.035634487832;3315;1012.8581998520214;1059.1103473082649;1078.9190810689229;1103.9834402483968;1147.7761836441814;32583.83708081492;33848;34110.658893411244;34155.316893661984;34417.483737743954;1128.4527004402858;1148.6381789736374;1201;1203.48851738011;1294.4175121195499;17239.22423490946;17692.380766673105;17759.911200443916;17805.46583602468;17894;594780;596542;607667;607835;608909;61141.694291528256;61928;62139;62171.37828621746;62286.37713622896;1364.6179069860455;1372.4921778941855;1377.0360747476807;1394.637394277495;1400.0549629000384;31758.36483270368;33095.17262068467;33367;33372.833135835135;33622.327553449286;53718.46281537135;53824;54182.916341673736;54193;54198.45801541934;374456;374743.13655886095;377052;377912;378773;28930.27674308159;29201.63268548976;29350.55974160432;29814.552781708724;30025.3994920096;49170.75414622904;49970.25044624406;50212.748936255084;51154.74422627863;51229;42044.36933445939;42925.78537107419;42966.78516607397;43413.34879976866;43911.45934576417;42183.578164219194;42263.366049508666;42880.35679464873;43284.147179849395;43407.782961084995;42976.57023429726;43523;44258.33612495751;44442.00010999577;45880.31179532377;37018.25963480769;38704.45182192681;38962.415563767136;39138.60861391349;39408;29026.7654438993;29207.707922920497;29410.705892940798;29420.705792942652;29430.852845735633 17:21:14 INFO - PROCESS | 6626 | |2;jquery.html;386.2121272603888;388.93582558877785;390.5567181249282;396.90275882408815;404.58327922240085;13827.65430864229;18475.722864157033;19076.809231907675;20189.899050504762;20389.184432622696;18767;18784.342548010824;19028.71456928147;19967.800321996776;20013.699794503056;5633.661980281176;5693.914591281134;5817.6800275985015;5848.736806843703;5875.412458754112;5747.023006088975;5758.42415758425;5779.248697669297;5795.130730390433;5810.6513609183585;5560.7219639017885;5719.714014299289;5722.484976352128;5727.484526392624;5755.856103597423;5696.2594862668;5714.914276285859;5725.227094342273;5736.942630573682;5744.224529688501;4889.48660390661;5123.3339665843205;5124.026434977342;5130.640855140142;5137.383513978347;22373.888130559404;22886.542269154692;23188.65217021746;23643.40891477727;23659.645105323434;2393.3059412770276;2511.748825117492;2518.64738936549;2556.8082393820537;2678.25008997481;14327.426902923871;14603.926980365137;14670;14685.632859178499;14806.259687015714;1972.7040943858392;1993.5813479169392;2018.3137733170793;2032.5934813037304;2096.5387614724737;58610.706946465;61055.999999999556;70940.29059709389;71280.93078603825;86590.56704716437;10616.522256498476;10691.625793097204;10855.240133190759;10958.561657533768;11018.559257629606;15062.548123556311;15138.621534461507;15165.317560709795;15193.164375959208;15213.31540080699;7928.088269848926;7939.64271607779;8033.076196237391;8052.838943221102;8073.838523229502;7623.695052197961;7635.198304178092;7636.31273185416;7777.338926191337;7780;6726.697298621574;6763.458923286125;6818.829529261808;6872.10662613857;6922.273161317989;1731.5584525945803;1797.63148554546;1805.1606003208308;1808.2586139682667;1810.2125575374755;1004.4776716107583;1028.6091285311534;1028.8148133335922;1095.1622009162998;1107.5237647811518;17980.280788768563;19755.40733777989;20248.898755506423;20319.187232510532;20396.49008774763;1043.6816770884952;1069.4011353641986;1077.49357801833;1113.9498722557505;1124.9718757030976;11132.387718675389;11684.240524365889;11686.065114790796;11791.174617776845;11849.585264515701;463522;464771;467104;495213;500372;82980;88255.55872220726;88405.11594884098;89356;89406;1005.5424781724298;1015.6699072801222;1021.1575450253571;1025.4462590201208;1040.1107053469327;17717.114144292475;18140.72788908194;18318.17568209407;18432.631347373244;18687.813121868607;40095.39856902207;40772.59227407688;41266.174676506904;41436.58563414327;41619.37570936499;53192.73403632957;54080.72959635334;54292.45707542874;55283.72358138183;56034.439655602924;8477;8528.360372972176;8570.871436928326;8638.56807159627;8857.911420885966;12975;13244.801327979896;13306.800397993844;13536.323183840965;13604.727905442034;11689.123315751183;11766.88233117658;11788.941055294668;11832.585859494877;11872.465739041936;8735.733318668885;11049;11368.658940231475;11597.88402115968;11725.648230553097;11559.36423496682;11662.650120496059;11755.118366122746;11855.34795586251;11863.050955923332;7483.102027756704;7988;8143.063547692092;8608.139186081342;8830.779230519289;8831.425957312755;12040.157188997036;12235.021198303937;12293.385330733248;12308.446119924445 17:21:14 INFO - PROCESS | 6626 | |3;mootools.html;1504.6840163565655;1526.404702166155;1732.9740053899193;1784.348712719856;1875.8124187581243;8004.719834805783;8599.785005374853;8626.956865215672;9268.351215414923;9329.53352332384;8634.395592308541;8918.197362237397;9004.414713043663;9006.729798106051;9007.774805629846;2356.552255071531;2410.5299466603933;2410.7950824179966;2412.2763171048705;2412.4813165169485;2400.747921468238;2423.0671191591186;2445.76765207305;2453.2272334214754;2461.1016978802786;2389.5340408620327;2397.2688330059327;2398.4843258699375;2401.903923843044;2406.759324067597;2381.3332266965276;2413.963790543143;2420.527997040587;2432.1487479382254;2446.620773780067;2423.7939775119135;2424.599941009749;2448.192096608115;2449.4856080223176;2453.6932883389577;9144.771380715469;9160.496172710498;9160.587773550205;9206.26349892007;9206.677766278215;5360.678359298455;5552.5280351170195;5616.663000219959;5618.101103823409;5623.465770751772;3344.5652065231607;3409.232922592422;3492.0396890854963;3497.4404095344876;3506.6142724300307;1119.1326721790597;1182.0602620916306;1191.5174354386488;1197.868234494205;1216.6836622478131;12810.167339122927;12908.612741617766;12934.159279646792;12984.870151298555;13007.86992130076;4713.198756211452;4924.876878078005;4977.178765503724;5010.67430617016;5021.14640511114;10933.835992460119;11038.11695064393;11058.11535077192;11098.889011109786;11106.055985241344;5569.607598100475;5614.354349249807;5625.915611265835;5631.155326701028;5639.915401268984;4574;4903.4606193318705;5012.874678133076;5021.447640759514;5063.670861393997;4131.566185550534;4158.189153115174;4222.852200172979;4248.383984322256;4252.425922500484;1281.8782215689494;1349.6490912362856;1359;1360.8911287097008;1374.182361494909;1019.4749703902496;1021.8569400283966;1026.9229807764298;1034.3276870034538;1049.627382279295;6118.1434599156155;6301.684915754286;6310.9368906311265;6442.226932768098;6446;460.1693942433872;461.4462644826155;463.069230846002;466.0469340199233;468.08255818595933;4149.688773342012;4224.831006759695;4229.492460904649;4256.191323648497;4339.7396156230725;11125.276857004268;11585.189036767346;11640.126990475748;11657.883421165849;11710.473028713728;11210.959341800417;11435.59975400857;11520.423978801195;11602.6519204424;11640.708982275342;8442.113578074337;8593.22660960504;8606.65573377058;8663.653453861774;8705.434146780439;6206.937930620636;6305.8108256752375;6352.491800655844;6359.96820015897;6366.840828979312;10243.94878025605;10533.893941136377;10636.042756151983;10670.253082284165;10674.946625266824;10782.892171078189;10799.352038877692;10821.242513024014;10856.45717714127;10914.945425273141;7156.177039640508;7740.225977402215;7968.681252750057;8068.636911339121;8121.4721043132;8891.510966896883;8958.820823583623;8976.192142707188;9038.322125840457;9044.81910361776;7626.733064342721;7700.5764682940735;7770.922290777246;8052.074011488519;8059.3552515799765;7929.643166057426;7970.202979701983;7979.760607181794;8022.719204827803;8087;6961.060256865258;7098.148222213367;7215.530990485601;7218.927810721825;7242.058532390755;5360.731963401892;5370.919436208538;5406.540444062299;5433.728313584226;5440.510354067995;5274.446183150867;5358.437364076872;5399.622026458267;5550.833474995757;5564.054110801093 17:21:14 INFO - PROCESS | 6626 | |4;prototype.html;333.33499668162017;337.7736916266102;338.8627605819642;341.0416728991535;348.0810659857974;5640.379558248595;5657.773689052438;5686.4597863203035;5711.629208989843;5766.625169363989;5643.548516118711;5661.8584535386635;5668.3075539119;5675.233843431146;5708.42915708429;4194.643455306303;4205.873823785291;4333.285007973681;4334.371516130159;4374.6875937218865;4335.442089167391;4344.370066340379;4357.629601483878;4371.322445021026;4386.868393948187;4328.805203765823;4331.523532411448;4344.63070638996;4350.869473915787;4361.520232774392;4252.6597872170305;4268;4302.290122129845;4306.074194048263;4321.530679568961;3771.396576547739;3781.6974642028845;3794.6528982211194;3803.155469597243;3854.614538546151;5381.48875856793;5420.34955805302;5438.53772429344;5488.69812160331;5504.80733174337;4871.585915197213;4984.850454486371;5000.949990500085;5002.874928126789;5015.072211640858;5698.202251684767;5866.9706651466895;5941.890628826791;5946.8810623787285;5958.463738263577;4149.564295748964;4166.958330416687;4167.729097608676;4173.9582604173875;4180.101278225196;5834.795782147605;6108.205933228696;6124.908126378108;6133.233345831771;6193.194884664965;4218.135282267128;4234.534201237861;4253.064325848309;4257.4252475915355;4264.637505812041;4296.248156572649;4307.698461107692;4320.200762858881;4325.264705000158;4334.913301733947;4768.3085952536685;4960.181570040902;4960.982998485302;4966.354373931438;4977.576905963034;5890.145928840294;5949.077892926603;5953.553483488669;5963.254593175853;5991.490723288569;1491.1202390589388;1492.4776328285013;1499.5951093204774;1501.3919362658141;1505.1345476351141;931.1433481197315;940.1256831147099;994.9950250248702;999.3254553176722;1011.4841430870309;5591.4688104629995;5622.803201887914;5681.403452637496;5716.28546431696;5748.252727145445;6004.159417681528;6064.241969753781;6110.541709371726;6122.2959359674205;6132.202813634199;5496.31296087989;5664.773409063674;5759.2512973313205;5772.278465191851;5816;3217.260030193069;3232.434323993292;3238.3037646906027;3265.804051756902;3273.263515708946;6211.9689401552705;6393.904091438632;6403.775867844696;6413.454856337264;6435.131257280301;6155.876882462326;6236.6258024518675;6263.342349053284;6287.685615719196;6319.988801791691;6082.665453400105;6238.344973777779;6241.656708881055;6336.461400780985;6342.936570634327;6099.512039036955;6127.234095738033;6128.63228206309;6139.84650383744;6156.661383623944;6092.8781424372155;6093.390660934048;6095.420935011167;6121.081837724377;6125.9693701531205;6009.248843894513;6303.212098487689;6328.588641738273;6350.968245158745;6373.6175829450385;4294.527601963844;4299.785610410703;4333.241682705577;4336.783160841882;4351.43431353922;5877.794277200449;6238.469730072995;6244.500439964882;6258;6274.780382686584;6031;6083.813656336972;6112.449879510866;6113.327533971171;6126.754929802758;5940.405959404198;5963.552733544915;5982.371850955587;5988.5508586855285;6071.330384144219;5591.356993945748;5702.00644661556;5896.3514013457625;5930.644161350333;5954.553408494294;5987.730552125077;6052;6072.453479186895;6074.661255416785;6094.14681944537;5560.944390556043;5872.588918775645;5892.793752218652;5892.882142357214;5923.911141332969 17:21:14 INFO - PROCESS | 6626 | |5;yui.html;731.9817004574888;745.8881167824826;762.7940456076863;786.1273985875673;792.0495405513384;15146.772798408032;16547.917260413695;16548.669026619475;16566.585835354093;16591.751123733153;14418.423263069491;15140.621484462894;15236;15248.085114893114;15265.38938442461;779.8752199648058;808.6159074439638;817.9100298967138;825.859603867341;826.6197549127409;812.9349652027853;815.8694608862584;823.6869989404018;823.7034667519688;824.0111865761081;858.4034096303072;864.7967727584013;865.6840253307561;867.3061550759368;867.4014929698487;859.0464584311409;860.1699360117485;861.7070196133282;862.8144948836031;863.0161615758041;629.568745409396;630.2437075509362;631.8641492079225;632.2286810091681;632.9683515824237;16066.116363599996;16142.75785863213;16210.270537825827;16218.108004059772;16226.350945962147;14033.228172450512;14494.275286235646;14547.854521454756;14602.415903363853;14664.780028299583;12536.247825130522;12545;12666.176698514568;12750.61748147557;13356.265405402699;3842;3863.632954869283;3909.139989202371;3926.7840268785208;3996.220736956295;74147;87728;87986;88196.11803881943;88537.55731221303;11586.594469193538;11691.590794322328;11842.822357664641;11882.405879706153;12301.569445069379;22784.31647050591;23035.193768218032;23094.76905230926;23109.191178309015;23128.88435557845;8372.958135209285;8615.61229744663;8665.306775457948;8692;8873.201411872962;4749.833755818529;4925.852224433201;4947.307376967227;4947.777350019258;4970.776315065831;3511.13977075613;3597.2086141048926;3599.208174201671;3610.205754733954;3645.2345007548183;622.9190205273286;636.5893998371117;642.2357394700385;648.3257412291258;649.909012738217;613.1599708399522;668.6890595872942;668.8896332105148;740.7148247924588;743.8214828441244;10017.499125043718;10306.381617102998;10498.10766084876;10593.523291451904;10774.622888199032;628.424991133108;630.5208041888199;649.5453182772078;772.2663469703804;782.593051613158;4695.647826413033;5133.614978876524;5142.537171654569;5185.714785686823;5205.219217117463;76823;107162.46418768012;107431;111788.44105779582;113159;61968;79297;87577;90444;96475;88810.55594721985;88828.5558572203;89484;89697;90877.09122908818;9640.228781697588;9920.603175872884;9939.950300248742;9941.602335906482;9990.850137248093;50941.745291273306;51509.7424512875;52277.215841763165;53306.20040699315;53587.464125358245;72045.63977180081;73216.26783732095;73988.26011740029;74916.62541687257;76836.61581692056;11426.2001659883;12033.157678962389;12297.139200255897;12403.13178077562;12446.688832779253;13847;13874.861251387358;14052.859471405563;14236.501722439665;14359.712805744035;12686.365681716063;12712.427940742873;13288.870446012197;13337.933310333387;13430.597082087554;12823.487060517848;12953.676158096123;13195.868041319463;13445.865541344852;13604.523841665494;12265;12410.5656302029;12513.562025329069;12890;12911.418986145834;10337;10422.530986105492;10461.738456538344;10484.42335671515;10786.352818830896;11276.436178191221;11540.192186546861;11552.942235289105;11605.187636865337;11619.360935148648 17:21:14 INFO - PROCESS | 6626 | __end_tp_report 17:21:14 INFO - PROCESS | 6626 | __start_cc_report 17:21:14 INFO - PROCESS | 6626 | _x_x_mozilla_cycle_collect,353 17:21:14 INFO - PROCESS | 6626 | __end_cc_report 17:21:14 INFO - PROCESS | 6626 | __startTimestamp1464999674500__endTimestamp 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | ------- Summary: start ------- 17:21:14 INFO - PROCESS | 6626 | Number of tests: 6 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#0] dojo.html Cycles:165 Average:5466.21 Median:5710.40 stddev:739.29 (12.9%) stddev-sans-first:718.13 17:21:14 INFO - PROCESS | 6626 | Values: 3112.4 3128.1 3160.3 3173.6 3178.0 5427.9 5445.0 5458.5 5513.6 5515.6 5397.7 5438.0 5448.5 5472.3 5509.4 4916.2 4936.5 5040.5 5078.8 5127.8 853.1 4882.0 4902.5 5003.6 5022.7 4918.4 4968.1 4969.5 4977.0 4978.7 4981.2 4983.7 4987.4 4988.3 5008.6 4945.9 4985.3 5001.1 5006.2 5019.2 5423.6 5443.2 5465.4 5480.3 5481.4 5697.8 5781.6 5908.3 5950.6 5971.6 5904.7 5921.9 5924.7 5962.8 5967.8 5519.8 5522.9 5526.3 5537.8 5547.7 5816.7 5918.8 6065.8 6075.5 6098.4 5761.0 5777.8 5792.6 5833.2 5873.8 5961.1 5964.9 5965.5 5970.0 5976.2 5713.6 5863.9 5913.5 5917.6 5920.8 5862.3 5862.7 5885.1 5925.5 5935.8 4481.8 4489.0 4491.9 4496.4 4538.3 3917.0 3927.4 3984.7 4006.7 4030.5 5614.7 5630.1 5653.3 5660.9 5662.0 5999.8 6047.8 6053.7 6054.2 6056.1 5671.1 5674.9 5696.4 5729.5 5765.9 5143.6 5172.1 5182.9 5192.5 5201.7 5911.6 6216.8 6220.4 6221.9 6231.2 5892.2 5932.2 5962.7 5979.2 6010.2 6125.4 6135.9 6148.7 6151.9 6158.3 5686.3 5783.4 5801.2 5837.6 5880.1 5907.8 5989.9 6002.5 6024.5 6073.9 5811.5 5825.9 5830.9 5836.2 5856.9 5546.4 5659.8 5669.3 5798.7 5824.3 5457.7 5700.3 5710.4 5723.7 5736.5 5862.0 5879.4 5905.8 5919.8 5936.9 5530.3 5669.4 5694.4 5785.1 5787.5 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#1] ext.html Cycles:180 Average:59980.77 Median:42384.29 stddev:122384.89 (288.8%) stddev-sans-first:122646.87 17:21:14 INFO - PROCESS | 6626 | Values: 549.6 593.2 598.7 613.0 628.4 33063.2 43543.6 43704.6 43870.1 44137.8 45823.0 46149.3 46348.0 46471.5 46494.5 8698.9 8831.8 8839.1 8878.7 8904.6 8603.7 8826.7 8872.7 8874.8 8878.2 8893.9 8963.0 8963.4 8965.8 8971.6 8833.4 8853.6 8861.0 8861.8 8889.9 8785.2 8826.8 8880.3 8892.2 8904.7 42271.6 42497.0 42573.4 42678.6 42689.4 3760.7 3802.6 3942.7 4101.0 4375.7 32327.7 32608.8 32633.7 33183.2 34184.0 4305.8 4330.7 4384.6 4395.7 4550.3 355749.0 356009.0 357968.0 358925.2 359958.0 35104.0 36196.5 54917.2 55025.7 55267.0 37602.2 37712.8 37921.6 38045.4 38056.2 14293.3 14359.8 14448.8 14458.5 14459.9 11695.5 11735.9 11765.1 11833.1 11881.6 8423.2 8430.7 8496.2 8533.2 8579.7 3233.3 3257.6 3258.3 3269.0 3315.0 1012.9 1059.1 1078.9 1104.0 1147.8 32583.8 33848.0 34110.7 34155.3 34417.5 1128.5 1148.6 1201.0 1203.5 1294.4 17239.2 17692.4 17759.9 17805.5 17894.0 594780.0 596542.0 607667.0 607835.0 608909.0 61141.7 61928.0 62139.0 62171.4 62286.4 1364.6 1372.5 1377.0 1394.6 1400.1 31758.4 33095.2 33367.0 33372.8 33622.3 53718.5 53824.0 54182.9 54193.0 54198.5 374456.0 374743.1 377052.0 377912.0 378773.0 28930.3 29201.6 29350.6 29814.6 30025.4 49170.8 49970.3 50212.7 51154.7 51229.0 42044.4 42925.8 42966.8 43413.3 43911.5 42183.6 42263.4 42880.4 43284.1 43407.8 42976.6 43523.0 44258.3 44442.0 45880.3 37018.3 38704.5 38962.4 39138.6 39408.0 29026.8 29207.7 29410.7 29420.7 29430.9 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#2] jquery.html Cycles:180 Average:28301.82 Median:23416.03 stddev:78619.06 (335.7%) stddev-sans-first:78811.66 17:21:14 INFO - PROCESS | 6626 | Values: 386.2 388.9 390.6 396.9 404.6 13827.7 18475.7 19076.8 20189.9 20389.2 18767.0 18784.3 19028.7 19967.8 20013.7 5633.7 5693.9 5817.7 5848.7 5875.4 5747.0 5758.4 5779.2 5795.1 5810.7 5560.7 5719.7 5722.5 5727.5 5755.9 5696.3 5714.9 5725.2 5736.9 5744.2 4889.5 5123.3 5124.0 5130.6 5137.4 22373.9 22886.5 23188.7 23643.4 23659.6 2393.3 2511.7 2518.6 2556.8 2678.3 14327.4 14603.9 14670.0 14685.6 14806.3 1972.7 1993.6 2018.3 2032.6 2096.5 58610.7 61056.0 70940.3 71280.9 86590.6 10616.5 10691.6 10855.2 10958.6 11018.6 15062.5 15138.6 15165.3 15193.2 15213.3 7928.1 7939.6 8033.1 8052.8 8073.8 7623.7 7635.2 7636.3 7777.3 7780.0 6726.7 6763.5 6818.8 6872.1 6922.3 1731.6 1797.6 1805.2 1808.3 1810.2 1004.5 1028.6 1028.8 1095.2 1107.5 17980.3 19755.4 20248.9 20319.2 20396.5 1043.7 1069.4 1077.5 1113.9 1125.0 11132.4 11684.2 11686.1 11791.2 11849.6 463522.0 464771.0 467104.0 495213.0 500372.0 82980.0 88255.6 88405.1 89356.0 89406.0 1005.5 1015.7 1021.2 1025.4 1040.1 17717.1 18140.7 18318.2 18432.6 18687.8 40095.4 40772.6 41266.2 41436.6 41619.4 53192.7 54080.7 54292.5 55283.7 56034.4 8477.0 8528.4 8570.9 8638.6 8857.9 12975.0 13244.8 13306.8 13536.3 13604.7 11689.1 11766.9 11788.9 11832.6 11872.5 8735.7 11049.0 11368.7 11597.9 11725.6 11559.4 11662.7 11755.1 11855.3 11863.1 7483.1 7988.0 8143.1 8608.1 8830.8 8831.4 12040.2 12235.0 12293.4 12308.4 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#3] mootools.html Cycles:180 Average:6050.26 Median:2517.08 stddev:3474.49 (138.0%) stddev-sans-first:3467.45 17:21:14 INFO - PROCESS | 6626 | Values: 1504.7 1526.4 1733.0 1784.3 1875.8 8004.7 8599.8 8627.0 9268.4 9329.5 8634.4 8918.2 9004.4 9006.7 9007.8 2356.6 2410.5 2410.8 2412.3 2412.5 2400.7 2423.1 2445.8 2453.2 2461.1 2389.5 2397.3 2398.5 2401.9 2406.8 2381.3 2414.0 2420.5 2432.1 2446.6 2423.8 2424.6 2448.2 2449.5 2453.7 9144.8 9160.5 9160.6 9206.3 9206.7 5360.7 5552.5 5616.7 5618.1 5623.5 3344.6 3409.2 3492.0 3497.4 3506.6 1119.1 1182.1 1191.5 1197.9 1216.7 12810.2 12908.6 12934.2 12984.9 13007.9 4713.2 4924.9 4977.2 5010.7 5021.1 10933.8 11038.1 11058.1 11098.9 11106.1 5569.6 5614.4 5625.9 5631.2 5639.9 4574.0 4903.5 5012.9 5021.4 5063.7 4131.6 4158.2 4222.9 4248.4 4252.4 1281.9 1349.6 1359.0 1360.9 1374.2 1019.5 1021.9 1026.9 1034.3 1049.6 6118.1 6301.7 6310.9 6442.2 6446.0 460.2 461.4 463.1 466.0 468.1 4149.7 4224.8 4229.5 4256.2 4339.7 11125.3 11585.2 11640.1 11657.9 11710.5 11211.0 11435.6 11520.4 11602.7 11640.7 8442.1 8593.2 8606.7 8663.7 8705.4 6206.9 6305.8 6352.5 6360.0 6366.8 10243.9 10533.9 10636.0 10670.3 10674.9 10782.9 10799.4 10821.2 10856.5 10914.9 7156.2 7740.2 7968.7 8068.6 8121.5 8891.5 8958.8 8976.2 9038.3 9044.8 7626.7 7700.6 7770.9 8052.1 8059.4 7929.6 7970.2 7979.8 8022.7 8087.0 6961.1 7098.1 7215.5 7218.9 7242.1 5360.7 5370.9 5406.5 5433.7 5440.5 5274.4 5358.4 5399.6 5550.8 5564.1 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#4] prototype.html Cycles:180 Average:4989.48 Median:5700.10 stddev:1496.43 (26.3%) stddev-sans-first:1459.25 17:21:14 INFO - PROCESS | 6626 | Values: 333.3 337.8 338.9 341.0 348.1 5640.4 5657.8 5686.5 5711.6 5766.6 5643.5 5661.9 5668.3 5675.2 5708.4 4194.6 4205.9 4333.3 4334.4 4374.7 4335.4 4344.4 4357.6 4371.3 4386.9 4328.8 4331.5 4344.6 4350.9 4361.5 4252.7 4268.0 4302.3 4306.1 4321.5 3771.4 3781.7 3794.7 3803.2 3854.6 5381.5 5420.3 5438.5 5488.7 5504.8 4871.6 4984.9 5000.9 5002.9 5015.1 5698.2 5867.0 5941.9 5946.9 5958.5 4149.6 4167.0 4167.7 4174.0 4180.1 5834.8 6108.2 6124.9 6133.2 6193.2 4218.1 4234.5 4253.1 4257.4 4264.6 4296.2 4307.7 4320.2 4325.3 4334.9 4768.3 4960.2 4961.0 4966.4 4977.6 5890.1 5949.1 5953.6 5963.3 5991.5 1491.1 1492.5 1499.6 1501.4 1505.1 931.1 940.1 995.0 999.3 1011.5 5591.5 5622.8 5681.4 5716.3 5748.3 6004.2 6064.2 6110.5 6122.3 6132.2 5496.3 5664.8 5759.3 5772.3 5816.0 3217.3 3232.4 3238.3 3265.8 3273.3 6212.0 6393.9 6403.8 6413.5 6435.1 6155.9 6236.6 6263.3 6287.7 6320.0 6082.7 6238.3 6241.7 6336.5 6342.9 6099.5 6127.2 6128.6 6139.8 6156.7 6092.9 6093.4 6095.4 6121.1 6126.0 6009.2 6303.2 6328.6 6351.0 6373.6 4294.5 4299.8 4333.2 4336.8 4351.4 5877.8 6238.5 6244.5 6258.0 6274.8 6031.0 6083.8 6112.4 6113.3 6126.8 5940.4 5963.6 5982.4 5988.6 6071.3 5591.4 5702.0 5896.4 5930.6 5954.6 5987.7 6052.0 6072.5 6074.7 6094.1 5560.9 5872.6 5892.8 5892.9 5923.9 17:21:14 INFO - PROCESS | 6626 | 17:21:14 INFO - PROCESS | 6626 | [#5] yui.html Cycles:180 Average:20493.97 Median:4837.84 stddev:28761.01 (594.5%) stddev-sans-first:28803.41 17:21:14 INFO - PROCESS | 6626 | Values: 732.0 745.9 762.8 786.1 792.0 15146.8 16547.9 16548.7 16566.6 16591.8 14418.4 15140.6 15236.0 15248.1 15265.4 779.9 808.6 817.9 825.9 826.6 812.9 815.9 823.7 823.7 824.0 858.4 864.8 865.7 867.3 867.4 859.0 860.2 861.7 862.8 863.0 629.6 630.2 631.9 632.2 633.0 16066.1 16142.8 16210.3 16218.1 16226.4 14033.2 14494.3 14547.9 14602.4 14664.8 12536.2 12545.0 12666.2 12750.6 13356.3 3842.0 3863.6 3909.1 3926.8 3996.2 74147.0 87728.0 87986.0 88196.1 88537.6 11586.6 11691.6 11842.8 11882.4 12301.6 22784.3 23035.2 23094.8 23109.2 23128.9 8373.0 8615.6 8665.3 8692.0 8873.2 4749.8 4925.9 4947.3 4947.8 4970.8 3511.1 3597.2 3599.2 3610.2 3645.2 622.9 636.6 642.2 648.3 649.9 613.2 668.7 668.9 740.7 743.8 10017.5 10306.4 10498.1 10593.5 10774.6 628.4 630.5 649.5 772.3 782.6 4695.6 5133.6 5142.5 5185.7 5205.2 76823.0 107162.5 107431.0 111788.4 113159.0 61968.0 79297.0 87577.0 90444.0 96475.0 88810.6 88828.6 89484.0 89697.0 90877.1 9640.2 9920.6 9940.0 9941.6 9990.9 50941.7 51509.7 52277.2 53306.2 53587.5 72045.6 73216.3 73988.3 74916.6 76836.6 11426.2 12033.2 12297.1 12403.1 12446.7 13847.0 13874.9 14052.9 14236.5 14359.7 12686.4 12712.4 13288.9 13337.9 13430.6 12823.5 12953.7 13195.9 13445.9 13604.5 12265.0 12410.6 12513.6 12890.0 12911.4 10337.0 10422.5 10461.7 10484.4 10786.4 11276.4 11540.2 11552.9 11605.2 11619.4 17:21:14 INFO - PROCESS | 6626 | -------- Summary: end -------- 17:21:14 INFO - PROCESS | 6626 | 17:21:15 INFO - TEST-INFO | 6626: exit 0 17:21:15 INFO - TEST-OK | dromaeo_css | took 1111209ms 17:21:15 INFO - TEST-START | kraken 17:21:15 INFO - operating with platform_type : linux_ 17:21:15 INFO - Initialising browser for kraken test... 17:21:15 INFO - TEST-INFO | started process 6864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnkHRsu/profile http://localhost:46129/getInfo.html) 17:21:19 INFO - PROCESS | 6864 | __metrics Screen width/height:1600/1200 17:21:19 INFO - PROCESS | 6864 | colorDepth:24 17:21:19 INFO - PROCESS | 6864 | Browser inner width/height: 1024/697 17:21:19 INFO - PROCESS | 6864 | __metrics 17:21:20 ERROR - PROCESS | 6864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:21:21 INFO - TEST-INFO | 6864: exit 0 17:21:21 INFO - Browser initialized. 17:21:21 INFO - Running cycle 1/1 for kraken test... 17:21:21 INFO - TEST-INFO | started process 6983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnkHRsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:33 INFO - PROCESS | 6983 | RSS: Main: 167542784 17:21:33 INFO - PROCESS | 6983 | 17:21:35 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46129/tests/kraken/driver.html?testName=audio-beat-detection) 17:21:36 INFO - PROCESS | 6983 | RSS: Main: 172957696 17:21:36 INFO - PROCESS | 6983 | 17:21:39 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46129/tests/kraken/driver.html?testName=audio-dft) 17:21:39 INFO - PROCESS | 6983 | RSS: Main: 171606016 17:21:39 INFO - PROCESS | 6983 | 17:21:42 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46129/tests/kraken/driver.html?testName=audio-fft) 17:21:43 INFO - PROCESS | 6983 | RSS: Main: 166723584 17:21:43 INFO - PROCESS | 6983 | 17:21:45 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46129/tests/kraken/driver.html?testName=audio-oscillator) 17:21:46 INFO - PROCESS | 6983 | RSS: Main: 167473152 17:21:46 INFO - PROCESS | 6983 | 17:21:48 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:21:48 INFO - PROCESS | 6983 | RSS: Main: 167616512 17:21:48 INFO - PROCESS | 6983 | 17:21:51 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46129/tests/kraken/driver.html?testName=imaging-darkroom) 17:21:52 INFO - PROCESS | 6983 | RSS: Main: 167780352 17:21:52 INFO - PROCESS | 6983 | 17:21:56 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46129/tests/kraken/driver.html?testName=imaging-desaturate) 17:21:56 INFO - PROCESS | 6983 | RSS: Main: 165715968 17:21:56 INFO - PROCESS | 6983 | 17:21:59 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46129/tests/kraken/driver.html?testName=json-parse-financial) 17:22:00 INFO - PROCESS | 6983 | RSS: Main: 167116800 17:22:00 INFO - PROCESS | 6983 | 17:22:01 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:02 INFO - PROCESS | 6983 | RSS: Main: 167702528 17:22:02 INFO - PROCESS | 6983 | 17:22:04 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:04 INFO - PROCESS | 6983 | RSS: Main: 168296448 17:22:04 INFO - PROCESS | 6983 | 17:22:06 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:07 INFO - PROCESS | 6983 | RSS: Main: 168484864 17:22:07 INFO - PROCESS | 6983 | 17:22:10 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:10 INFO - PROCESS | 6983 | RSS: Main: 168525824 17:22:10 INFO - PROCESS | 6983 | 17:22:13 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:14 INFO - PROCESS | 6983 | RSS: Main: 168521728 17:22:14 INFO - PROCESS | 6983 | 17:22:15 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:46129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46129/tests/kraken/driver.html?testName=ai-astar) 17:22:16 INFO - PROCESS | 6983 | RSS: Main: 168968192 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | __start_tp_report 17:22:16 INFO - PROCESS | 6983 | _x_x_mozilla_page_load 17:22:16 INFO - PROCESS | 6983 | _x_x_mozilla_page_load_details 17:22:16 INFO - PROCESS | 6983 | |i|pagename|runs| 17:22:16 INFO - PROCESS | 6983 | |0;ai-astar;110;106;111;111;112;112;111;111;112;110 17:22:16 INFO - PROCESS | 6983 | |1;audio-beat-detection;167;127;164;178;137;152;155;127;181;127 17:22:16 INFO - PROCESS | 6983 | |2;audio-dft;163;163;162;167;162;167;176;163;164;164 17:22:16 INFO - PROCESS | 6983 | |3;audio-fft;74;75;75;167;75;74;75;76;158;76 17:22:16 INFO - PROCESS | 6983 | |4;audio-oscillator;84;86;155;84;85;85;143;86;87;153 17:22:16 INFO - PROCESS | 6983 | |5;imaging-gaussian-blur;117;117;117;117;119;117;118;118;118;117 17:22:16 INFO - PROCESS | 6983 | |6;imaging-darkroom;147;147;147;148;148;147;148;147;150;146 17:22:16 INFO - PROCESS | 6983 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;95;96 17:22:16 INFO - PROCESS | 6983 | |8;json-parse-financial;55;57;56;55;57;58;55;55;55;55 17:22:16 INFO - PROCESS | 6983 | |9;json-stringify-tinderbox;60;60;65;61;61;61;61;61;61;62 17:22:16 INFO - PROCESS | 6983 | |10;stanford-crypto-aes;79;80;85;83;81;81;81;82;119;80 17:22:16 INFO - PROCESS | 6983 | |11;stanford-crypto-ccm;126;132;131;145;124;125;133;133;126;126 17:22:16 INFO - PROCESS | 6983 | |12;stanford-crypto-pbkdf2;165;169;161;166;160;162;163;160;161;161 17:22:16 INFO - PROCESS | 6983 | |13;stanford-crypto-sha256-iterative;72;63;65;65;64;67;64;63;63;68 17:22:16 INFO - PROCESS | 6983 | __end_tp_report 17:22:16 INFO - PROCESS | 6983 | __start_cc_report 17:22:16 INFO - PROCESS | 6983 | _x_x_mozilla_cycle_collect,864 17:22:16 INFO - PROCESS | 6983 | __end_cc_report 17:22:16 INFO - PROCESS | 6983 | __startTimestamp1464999736103__endTimestamp 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | ------- Summary: start ------- 17:22:16 INFO - PROCESS | 6983 | Number of tests: 14 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.87 17:22:16 INFO - PROCESS | 6983 | Values: 110.0 106.0 111.0 111.0 112.0 112.0 111.0 111.0 112.0 110.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:159.50 stddev:21.06 (13.2%) stddev-sans-first:21.58 17:22:16 INFO - PROCESS | 6983 | Values: 167.0 127.0 164.0 178.0 137.0 152.0 155.0 127.0 181.0 127.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.23 (2.6%) stddev-sans-first:4.42 17:22:16 INFO - PROCESS | 6983 | Values: 163.0 163.0 162.0 167.0 162.0 167.0 176.0 163.0 164.0 164.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.96 (49.3%) stddev-sans-first:38.59 17:22:16 INFO - PROCESS | 6983 | Values: 74.0 75.0 75.0 167.0 75.0 74.0 75.0 76.0 158.0 76.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:85.00 stddev:31.58 (37.2%) stddev-sans-first:32.59 17:22:16 INFO - PROCESS | 6983 | Values: 84.0 86.0 155.0 84.0 85.0 85.0 143.0 86.0 87.0 153.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 17:22:16 INFO - PROCESS | 6983 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 118.0 118.0 118.0 117.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:22:16 INFO - PROCESS | 6983 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 150.0 146.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:22:16 INFO - PROCESS | 6983 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.14 (2.0%) stddev-sans-first:1.17 17:22:16 INFO - PROCESS | 6983 | Values: 55.0 57.0 56.0 55.0 57.0 58.0 55.0 55.0 55.0 55.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.42 (2.3%) stddev-sans-first:1.42 17:22:16 INFO - PROCESS | 6983 | Values: 60.0 60.0 65.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:81.00 stddev:12.03 (14.9%) stddev-sans-first:12.56 17:22:16 INFO - PROCESS | 6983 | Values: 79.0 80.0 85.0 83.0 81.0 81.0 81.0 82.0 119.0 80.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:131.50 stddev:6.30 (4.8%) stddev-sans-first:6.50 17:22:16 INFO - PROCESS | 6983 | Values: 126.0 132.0 131.0 145.0 124.0 125.0 133.0 133.0 126.0 126.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:162.50 stddev:2.97 (1.8%) stddev-sans-first:3.05 17:22:16 INFO - PROCESS | 6983 | Values: 165.0 169.0 161.0 166.0 160.0 162.0 163.0 160.0 161.0 161.0 17:22:16 INFO - PROCESS | 6983 | 17:22:16 INFO - PROCESS | 6983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.88 (4.4%) stddev-sans-first:1.80 17:22:16 INFO - PROCESS | 6983 | Values: 72.0 63.0 65.0 65.0 64.0 67.0 64.0 63.0 63.0 68.0 17:22:16 INFO - PROCESS | 6983 | -------- Summary: end -------- 17:22:16 INFO - PROCESS | 6983 | 17:22:17 INFO - TEST-INFO | 6983: exit 0 17:22:17 INFO - TEST-OK | kraken | took 61850ms 17:22:17 INFO - SUITE-END | took 1173s 17:22:17 INFO - Completed test suite (00:19:33) 17:22:17 INFO - javascript benchmark 17:22:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7359.165270882968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.3775244951007, 3128.0772172209195, 3160.320531085816, 3173.6350319713238, 3178.014815407224, 5427.91858122128, 5444.972775136123, 5458.481444262794, 5513.558915286778, 5515.641483303582, 5397.730113494319, 5438.0, 5448.509634132927, 5472.315960504937, 5509.421510741375, 4916.213405855064, 4936.456989731127, 5040.521150490697, 5078.847634570969, 5127.769250383723, 853.1060374232167, 4882.0, 4902.534259245366, 5003.624728145385, 5022.723750193738, 4918.385201849769, 4968.056069346831, 4969.527894849984, 4977.029479251547, 4978.6514943953935, 4981.203007518816, 4983.651144419892, 4987.401511818605, 4988.251762235657, 5008.624353173526, 4945.876353091166, 4985.302057711923, 5001.099802035632, 5006.224035274538, 5019.222020586815, 5423.620346575742, 5443.1835224716215, 5465.398806131322, 5480.287562616874, 5481.424450432727, 5697.77208911643, 5781.566382521286, 5908.261467316585, 5950.642961422285, 5971.552133589998, 5904.704764761745, 5921.940780592182, 5924.674142922137, 5962.761489540413, 5967.791127310524, 5519.834404967857, 5522.91715624266, 5526.336839579196, 5537.833864984057, 5547.694876781776, 5816.651000939957, 5918.7928422505, 6065.848353791191, 6075.453209211192, 6098.390160983866, 5760.971195143998, 5777.7977770777825, 5792.594518383757, 5833.212516310244, 5873.794417195378, 5961.076033214858, 5964.850878728066, 5965.522758179335, 5970.0, 5976.223090998143, 5713.5714821388565, 5863.853403664857, 5913.497352725067, 5917.55618328627, 5920.763169473259, 5862.325832529228, 5862.736176872051, 5885.087811389241, 5925.496332811673, 5935.762569497172, 4481.7983190756495, 4489.034857505587, 4491.887702807456, 4496.437945256843, 4538.2738761797955, 3917.0011647030396, 3927.430522574211, 3984.7409918355215, 4006.6994975376965, 4030.496187976503, 5614.663120212718, 5630.07103827872, 5653.349864765522, 5660.915086273709, 5662.0, 5999.760009599654, 6047.758089676452, 6053.727582258809, 6054.212952316171, 6056.091586262096, 5671.092625179951, 5674.858128546819, 5696.430356964271, 5729.455701708331, 5765.8558536036935, 5143.614228932845, 5172.120739474299, 5182.922256166085, 5192.506711862367, 5201.661891977009, 5911.586188966731, 6216.813495595049, 6220.377962203834, 6221.875562488724, 6231.189945307081, 5892.175095486636, 5932.16949627044, 5962.731677074629, 5979.162917191684, 6010.158577799024, 6125.448709616156, 6135.938640613536, 6148.723307451265, 6151.8926593213655, 6158.261008678987, 5686.317641883001, 5783.3638299787835, 5801.245838041028, 5837.6497410155525, 5880.059190529495, 5907.763689452546, 5989.940100598938, 6002.489788367863, 6024.548158888013, 6073.878522429438, 5811.476967072984, 5825.893080314727, 5830.883382332245, 5836.153757705194, 5856.94143058564, 5546.362168350692, 5659.830205093854, 5669.262995810518, 5798.652080875161, 5824.271966004249, 5457.672539647634, 5700.3444603871085, 5710.400407957105, 5723.6851973141875, 5736.4550367715, 5862.0, 5879.441453061952, 5905.822825315247, 5919.792807251725, 5936.910946335722, 5530.336359636869, 5669.376368599368, 5694.430556944272, 5785.103308987113, 5787.508061814793], "value": 5415.971599870078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5630973376166, 593.2139914613139, 598.7455331484118, 612.9540284478663, 628.3684896678839, 33063.1734206645, 43543.56456435435, 43704.56295437045, 43870.12259754803, 44137.77931110344, 45823.0, 46149.30776038362, 46348.0, 46471.53528464714, 46494.5129115316, 8698.912635920526, 8831.77920551988, 8839.116088391174, 8878.689245876396, 8904.554772261394, 8603.741887743347, 8826.691065812698, 8872.73381798547, 8874.778130546756, 8878.24534914533, 8893.866592001124, 8962.955185224066, 8963.41737787045, 8965.820683586324, 8971.551422428885, 8833.425827321204, 8853.601587928526, 8861.025287218401, 8861.822763544758, 8889.866652000224, 8785.165409286172, 8826.779330516723, 8880.289576833839, 8892.244159246471, 8904.73285801427, 42271.577284227074, 42497.0, 42573.36139957903, 42678.57321426777, 42689.35965960513, 3760.6615404613717, 3802.638749318838, 3942.704297177723, 4100.958990410088, 4375.7155784873885, 32327.676723232937, 32608.836955815306, 32633.673663263537, 33183.170420739676, 34184.0, 4305.78471076448, 4330.740155590644, 4384.627306678936, 4395.670324725658, 4550.340200670884, 355749.0, 356009.0, 357968.0, 358925.20537397405, 359958.0, 35104.0, 36196.45705314422, 54917.1762423564, 55025.72487137539, 55267.0, 37602.24795504129, 37712.81143594319, 37921.62078379236, 38045.429318560244, 38056.238875222894, 14293.285335733171, 14359.78460323096, 14448.783268250985, 14458.493952711604, 14459.927700361432, 11695.473703683354, 11735.882641173479, 11765.058795296356, 11833.11251656112, 11881.64355069332, 8423.199796019368, 8430.662773488992, 8496.150384961578, 8533.232009119085, 8579.742607721779, 3233.3048394594803, 3257.625373082126, 3258.3483303339426, 3269.035634487832, 3315.0, 1012.8581998520214, 1059.1103473082649, 1078.9190810689229, 1103.9834402483968, 1147.7761836441814, 32583.83708081492, 33848.0, 34110.658893411244, 34155.316893661984, 34417.483737743954, 1128.4527004402858, 1148.6381789736374, 1201.0, 1203.48851738011, 1294.4175121195499, 17239.22423490946, 17692.380766673105, 17759.911200443916, 17805.46583602468, 17894.0, 594780.0, 596542.0, 607667.0, 607835.0, 608909.0, 61141.694291528256, 61928.0, 62139.0, 62171.37828621746, 62286.37713622896, 1364.6179069860455, 1372.4921778941855, 1377.0360747476807, 1394.637394277495, 1400.0549629000384, 31758.36483270368, 33095.17262068467, 33367.0, 33372.833135835135, 33622.327553449286, 53718.46281537135, 53824.0, 54182.916341673736, 54193.0, 54198.45801541934, 374456.0, 374743.13655886095, 377052.0, 377912.0, 378773.0, 28930.27674308159, 29201.63268548976, 29350.55974160432, 29814.552781708724, 30025.3994920096, 49170.75414622904, 49970.25044624406, 50212.748936255084, 51154.74422627863, 51229.0, 42044.36933445939, 42925.78537107419, 42966.78516607397, 43413.34879976866, 43911.45934576417, 42183.578164219194, 42263.366049508666, 42880.35679464873, 43284.147179849395, 43407.782961084995, 42976.57023429726, 43523.0, 44258.33612495751, 44442.00010999577, 45880.31179532377, 37018.25963480769, 38704.45182192681, 38962.415563767136, 39138.60861391349, 39408.0, 29026.7654438993, 29207.707922920497, 29410.705892940798, 29420.705792942652, 29430.852845735633], "value": 19245.36364784681, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2121272603888, 388.93582558877785, 390.5567181249282, 396.90275882408815, 404.58327922240085, 13827.65430864229, 18475.722864157033, 19076.809231907675, 20189.899050504762, 20389.184432622696, 18767.0, 18784.342548010824, 19028.71456928147, 19967.800321996776, 20013.699794503056, 5633.661980281176, 5693.914591281134, 5817.6800275985015, 5848.736806843703, 5875.412458754112, 5747.023006088975, 5758.42415758425, 5779.248697669297, 5795.130730390433, 5810.6513609183585, 5560.7219639017885, 5719.714014299289, 5722.484976352128, 5727.484526392624, 5755.856103597423, 5696.2594862668, 5714.914276285859, 5725.227094342273, 5736.942630573682, 5744.224529688501, 4889.48660390661, 5123.3339665843205, 5124.026434977342, 5130.640855140142, 5137.383513978347, 22373.888130559404, 22886.542269154692, 23188.65217021746, 23643.40891477727, 23659.645105323434, 2393.3059412770276, 2511.748825117492, 2518.64738936549, 2556.8082393820537, 2678.25008997481, 14327.426902923871, 14603.926980365137, 14670.0, 14685.632859178499, 14806.259687015714, 1972.7040943858392, 1993.5813479169392, 2018.3137733170793, 2032.5934813037304, 2096.5387614724737, 58610.706946465, 61055.999999999556, 70940.29059709389, 71280.93078603825, 86590.56704716437, 10616.522256498476, 10691.625793097204, 10855.240133190759, 10958.561657533768, 11018.559257629606, 15062.548123556311, 15138.621534461507, 15165.317560709795, 15193.164375959208, 15213.31540080699, 7928.088269848926, 7939.64271607779, 8033.076196237391, 8052.838943221102, 8073.838523229502, 7623.695052197961, 7635.198304178092, 7636.31273185416, 7777.338926191337, 7780.0, 6726.697298621574, 6763.458923286125, 6818.829529261808, 6872.10662613857, 6922.273161317989, 1731.5584525945803, 1797.63148554546, 1805.1606003208308, 1808.2586139682667, 1810.2125575374755, 1004.4776716107583, 1028.6091285311534, 1028.8148133335922, 1095.1622009162998, 1107.5237647811518, 17980.280788768563, 19755.40733777989, 20248.898755506423, 20319.187232510532, 20396.49008774763, 1043.6816770884952, 1069.4011353641986, 1077.49357801833, 1113.9498722557505, 1124.9718757030976, 11132.387718675389, 11684.240524365889, 11686.065114790796, 11791.174617776845, 11849.585264515701, 463522.0, 464771.0, 467104.0, 495213.0, 500372.0, 82980.0, 88255.55872220726, 88405.11594884098, 89356.0, 89406.0, 1005.5424781724298, 1015.6699072801222, 1021.1575450253571, 1025.4462590201208, 1040.1107053469327, 17717.114144292475, 18140.72788908194, 18318.17568209407, 18432.631347373244, 18687.813121868607, 40095.39856902207, 40772.59227407688, 41266.174676506904, 41436.58563414327, 41619.37570936499, 53192.73403632957, 54080.72959635334, 54292.45707542874, 55283.72358138183, 56034.439655602924, 8477.0, 8528.360372972176, 8570.871436928326, 8638.56807159627, 8857.911420885966, 12975.0, 13244.801327979896, 13306.800397993844, 13536.323183840965, 13604.727905442034, 11689.123315751183, 11766.88233117658, 11788.941055294668, 11832.585859494877, 11872.465739041936, 8735.733318668885, 11049.0, 11368.658940231475, 11597.88402115968, 11725.648230553097, 11559.36423496682, 11662.650120496059, 11755.118366122746, 11855.34795586251, 11863.050955923332, 7483.102027756704, 7988.0, 8143.063547692092, 8608.139186081342, 8830.779230519289, 8831.425957312755, 12040.157188997036, 12235.021198303937, 12293.385330733248, 12308.446119924445], "value": 9345.27640525882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.6840163565655, 1526.404702166155, 1732.9740053899193, 1784.348712719856, 1875.8124187581243, 8004.719834805783, 8599.785005374853, 8626.956865215672, 9268.351215414923, 9329.53352332384, 8634.395592308541, 8918.197362237397, 9004.414713043663, 9006.729798106051, 9007.774805629846, 2356.552255071531, 2410.5299466603933, 2410.7950824179966, 2412.2763171048705, 2412.4813165169485, 2400.747921468238, 2423.0671191591186, 2445.76765207305, 2453.2272334214754, 2461.1016978802786, 2389.5340408620327, 2397.2688330059327, 2398.4843258699375, 2401.903923843044, 2406.759324067597, 2381.3332266965276, 2413.963790543143, 2420.527997040587, 2432.1487479382254, 2446.620773780067, 2423.7939775119135, 2424.599941009749, 2448.192096608115, 2449.4856080223176, 2453.6932883389577, 9144.771380715469, 9160.496172710498, 9160.587773550205, 9206.26349892007, 9206.677766278215, 5360.678359298455, 5552.5280351170195, 5616.663000219959, 5618.101103823409, 5623.465770751772, 3344.5652065231607, 3409.232922592422, 3492.0396890854963, 3497.4404095344876, 3506.6142724300307, 1119.1326721790597, 1182.0602620916306, 1191.5174354386488, 1197.868234494205, 1216.6836622478131, 12810.167339122927, 12908.612741617766, 12934.159279646792, 12984.870151298555, 13007.86992130076, 4713.198756211452, 4924.876878078005, 4977.178765503724, 5010.67430617016, 5021.14640511114, 10933.835992460119, 11038.11695064393, 11058.11535077192, 11098.889011109786, 11106.055985241344, 5569.607598100475, 5614.354349249807, 5625.915611265835, 5631.155326701028, 5639.915401268984, 4574.0, 4903.4606193318705, 5012.874678133076, 5021.447640759514, 5063.670861393997, 4131.566185550534, 4158.189153115174, 4222.852200172979, 4248.383984322256, 4252.425922500484, 1281.8782215689494, 1349.6490912362856, 1359.0, 1360.8911287097008, 1374.182361494909, 1019.4749703902496, 1021.8569400283966, 1026.9229807764298, 1034.3276870034538, 1049.627382279295, 6118.1434599156155, 6301.684915754286, 6310.9368906311265, 6442.226932768098, 6446.0, 460.1693942433872, 461.4462644826155, 463.069230846002, 466.0469340199233, 468.08255818595933, 4149.688773342012, 4224.831006759695, 4229.492460904649, 4256.191323648497, 4339.7396156230725, 11125.276857004268, 11585.189036767346, 11640.126990475748, 11657.883421165849, 11710.473028713728, 11210.959341800417, 11435.59975400857, 11520.423978801195, 11602.6519204424, 11640.708982275342, 8442.113578074337, 8593.22660960504, 8606.65573377058, 8663.653453861774, 8705.434146780439, 6206.937930620636, 6305.8108256752375, 6352.491800655844, 6359.96820015897, 6366.840828979312, 10243.94878025605, 10533.893941136377, 10636.042756151983, 10670.253082284165, 10674.946625266824, 10782.892171078189, 10799.352038877692, 10821.242513024014, 10856.45717714127, 10914.945425273141, 7156.177039640508, 7740.225977402215, 7968.681252750057, 8068.636911339121, 8121.4721043132, 8891.510966896883, 8958.820823583623, 8976.192142707188, 9038.322125840457, 9044.81910361776, 7626.733064342721, 7700.5764682940735, 7770.922290777246, 8052.074011488519, 8059.3552515799765, 7929.643166057426, 7970.202979701983, 7979.760607181794, 8022.719204827803, 8087.0, 6961.060256865258, 7098.148222213367, 7215.530990485601, 7218.927810721825, 7242.058532390755, 5360.731963401892, 5370.919436208538, 5406.540444062299, 5433.728313584226, 5440.510354067995, 5274.446183150867, 5358.437364076872, 5399.622026458267, 5550.833474995757, 5564.054110801093], "value": 4757.572808514353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.33499668162017, 337.7736916266102, 338.8627605819642, 341.0416728991535, 348.0810659857974, 5640.379558248595, 5657.773689052438, 5686.4597863203035, 5711.629208989843, 5766.625169363989, 5643.548516118711, 5661.8584535386635, 5668.3075539119, 5675.233843431146, 5708.42915708429, 4194.643455306303, 4205.873823785291, 4333.285007973681, 4334.371516130159, 4374.6875937218865, 4335.442089167391, 4344.370066340379, 4357.629601483878, 4371.322445021026, 4386.868393948187, 4328.805203765823, 4331.523532411448, 4344.63070638996, 4350.869473915787, 4361.520232774392, 4252.6597872170305, 4268.0, 4302.290122129845, 4306.074194048263, 4321.530679568961, 3771.396576547739, 3781.6974642028845, 3794.6528982211194, 3803.155469597243, 3854.614538546151, 5381.48875856793, 5420.34955805302, 5438.53772429344, 5488.69812160331, 5504.80733174337, 4871.585915197213, 4984.850454486371, 5000.949990500085, 5002.874928126789, 5015.072211640858, 5698.202251684767, 5866.9706651466895, 5941.890628826791, 5946.8810623787285, 5958.463738263577, 4149.564295748964, 4166.958330416687, 4167.729097608676, 4173.9582604173875, 4180.101278225196, 5834.795782147605, 6108.205933228696, 6124.908126378108, 6133.233345831771, 6193.194884664965, 4218.135282267128, 4234.534201237861, 4253.064325848309, 4257.4252475915355, 4264.637505812041, 4296.248156572649, 4307.698461107692, 4320.200762858881, 4325.264705000158, 4334.913301733947, 4768.3085952536685, 4960.181570040902, 4960.982998485302, 4966.354373931438, 4977.576905963034, 5890.145928840294, 5949.077892926603, 5953.553483488669, 5963.254593175853, 5991.490723288569, 1491.1202390589388, 1492.4776328285013, 1499.5951093204774, 1501.3919362658141, 1505.1345476351141, 931.1433481197315, 940.1256831147099, 994.9950250248702, 999.3254553176722, 1011.4841430870309, 5591.4688104629995, 5622.803201887914, 5681.403452637496, 5716.28546431696, 5748.252727145445, 6004.159417681528, 6064.241969753781, 6110.541709371726, 6122.2959359674205, 6132.202813634199, 5496.31296087989, 5664.773409063674, 5759.2512973313205, 5772.278465191851, 5816.0, 3217.260030193069, 3232.434323993292, 3238.3037646906027, 3265.804051756902, 3273.263515708946, 6211.9689401552705, 6393.904091438632, 6403.775867844696, 6413.454856337264, 6435.131257280301, 6155.876882462326, 6236.6258024518675, 6263.342349053284, 6287.685615719196, 6319.988801791691, 6082.665453400105, 6238.344973777779, 6241.656708881055, 6336.461400780985, 6342.936570634327, 6099.512039036955, 6127.234095738033, 6128.63228206309, 6139.84650383744, 6156.661383623944, 6092.8781424372155, 6093.390660934048, 6095.420935011167, 6121.081837724377, 6125.9693701531205, 6009.248843894513, 6303.212098487689, 6328.588641738273, 6350.968245158745, 6373.6175829450385, 4294.527601963844, 4299.785610410703, 4333.241682705577, 4336.783160841882, 4351.43431353922, 5877.794277200449, 6238.469730072995, 6244.500439964882, 6258.0, 6274.780382686584, 6031.0, 6083.813656336972, 6112.449879510866, 6113.327533971171, 6126.754929802758, 5940.405959404198, 5963.552733544915, 5982.371850955587, 5988.5508586855285, 6071.330384144219, 5591.356993945748, 5702.00644661556, 5896.3514013457625, 5930.644161350333, 5954.553408494294, 5987.730552125077, 6052.0, 6072.453479186895, 6074.661255416785, 6094.14681944537, 5560.944390556043, 5872.588918775645, 5892.793752218652, 5892.882142357214, 5923.911141332969], "value": 4506.427489942799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.9817004574888, 745.8881167824826, 762.7940456076863, 786.1273985875673, 792.0495405513384, 15146.772798408032, 16547.917260413695, 16548.669026619475, 16566.585835354093, 16591.751123733153, 14418.423263069491, 15140.621484462894, 15236.0, 15248.085114893114, 15265.38938442461, 779.8752199648058, 808.6159074439638, 817.9100298967138, 825.859603867341, 826.6197549127409, 812.9349652027853, 815.8694608862584, 823.6869989404018, 823.7034667519688, 824.0111865761081, 858.4034096303072, 864.7967727584013, 865.6840253307561, 867.3061550759368, 867.4014929698487, 859.0464584311409, 860.1699360117485, 861.7070196133282, 862.8144948836031, 863.0161615758041, 629.568745409396, 630.2437075509362, 631.8641492079225, 632.2286810091681, 632.9683515824237, 16066.116363599996, 16142.75785863213, 16210.270537825827, 16218.108004059772, 16226.350945962147, 14033.228172450512, 14494.275286235646, 14547.854521454756, 14602.415903363853, 14664.780028299583, 12536.247825130522, 12545.0, 12666.176698514568, 12750.61748147557, 13356.265405402699, 3842.0, 3863.632954869283, 3909.139989202371, 3926.7840268785208, 3996.220736956295, 74147.0, 87728.0, 87986.0, 88196.11803881943, 88537.55731221303, 11586.594469193538, 11691.590794322328, 11842.822357664641, 11882.405879706153, 12301.569445069379, 22784.31647050591, 23035.193768218032, 23094.76905230926, 23109.191178309015, 23128.88435557845, 8372.958135209285, 8615.61229744663, 8665.306775457948, 8692.0, 8873.201411872962, 4749.833755818529, 4925.852224433201, 4947.307376967227, 4947.777350019258, 4970.776315065831, 3511.13977075613, 3597.2086141048926, 3599.208174201671, 3610.205754733954, 3645.2345007548183, 622.9190205273286, 636.5893998371117, 642.2357394700385, 648.3257412291258, 649.909012738217, 613.1599708399522, 668.6890595872942, 668.8896332105148, 740.7148247924588, 743.8214828441244, 10017.499125043718, 10306.381617102998, 10498.10766084876, 10593.523291451904, 10774.622888199032, 628.424991133108, 630.5208041888199, 649.5453182772078, 772.2663469703804, 782.593051613158, 4695.647826413033, 5133.614978876524, 5142.537171654569, 5185.714785686823, 5205.219217117463, 76823.0, 107162.46418768012, 107431.0, 111788.44105779582, 113159.0, 61968.0, 79297.0, 87577.0, 90444.0, 96475.0, 88810.55594721985, 88828.5558572203, 89484.0, 89697.0, 90877.09122908818, 9640.228781697588, 9920.603175872884, 9939.950300248742, 9941.602335906482, 9990.850137248093, 50941.745291273306, 51509.7424512875, 52277.215841763165, 53306.20040699315, 53587.464125358245, 72045.63977180081, 73216.26783732095, 73988.26011740029, 74916.62541687257, 76836.61581692056, 11426.2001659883, 12033.157678962389, 12297.139200255897, 12403.13178077562, 12446.688832779253, 13847.0, 13874.861251387358, 14052.859471405563, 14236.501722439665, 14359.712805744035, 12686.365681716063, 12712.427940742873, 13288.870446012197, 13337.933310333387, 13430.597082087554, 12823.487060517848, 12953.676158096123, 13195.868041319463, 13445.865541344852, 13604.523841665494, 12265.0, 12410.5656302029, 12513.562025329069, 12890.0, 12911.418986145834, 10337.0, 10422.530986105492, 10461.738456538344, 10484.42335671515, 10786.352818830896, 11276.436178191221, 11540.192186546861, 11552.942235289105, 11605.187636865337, 11619.360935148648], "value": 7605.345781458252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 127.0, 164.0, 178.0, 137.0, 152.0, 155.0, 127.0, 181.0, 127.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 167.0, 162.0, 167.0, 176.0, 163.0, 164.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 167.0, 75.0, 74.0, 75.0, 76.0, 158.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 155.0, 84.0, 85.0, 85.0, 143.0, 86.0, 87.0, 153.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 150.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 57.0, 58.0, 55.0, 55.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 65.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 85.0, 83.0, 81.0, 81.0, 81.0, 82.0, 119.0, 80.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 131.0, 145.0, 124.0, 125.0, 133.0, 133.0, 126.0, 126.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 161.0, 166.0, 160.0, 162.0, 163.0, 160.0, 161.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 65.0, 65.0, 64.0, 67.0, 64.0, 63.0, 63.0, 68.0], "value": 65.4, "unit": "score"}]}]} 17:22:17 INFO - Return code: 0 17:22:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:22:17 ERROR - # TBPL SUCCESS # 17:22:17 INFO - Running post-action listener: _resource_record_post_action 17:22:17 INFO - ##### 17:22:17 INFO - ##### Finished run-tests step (success) 17:22:17 INFO - ##### 17:22:17 INFO - Running post-run listener: _resource_record_post_run 17:22:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551829504; Read time: 16; Write time: 493980 17:22:17 INFO - TinderboxPrint: CPU usage
13.4% 17:22:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:22:17 INFO - TinderboxPrint: I/O write bytes / time
551,829,504 / 493,980 17:22:17 INFO - TinderboxPrint: CPU idle
8,224.0 (86.5%) 17:22:17 INFO - TinderboxPrint: CPU user
1,224.2 (12.9%) 17:22:17 INFO - TinderboxPrint: Swap in / out
0 / 0 17:22:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258080768; Read time: 0; Write time: 245968 17:22:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293748736; Read time: 16; Write time: 248012 17:22:18 INFO - Running post-run listener: _upload_blobber_files 17:22:18 INFO - Blob upload gear active. 17:22:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:18 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 17:22:18 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:22:18 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:22:18 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:22 INFO - (blobuploader) - INFO - Done attempting. 17:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:22 INFO - (blobuploader) - INFO - Done attempting. 17:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:22:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:23 INFO - (blobuploader) - INFO - Done attempting. 17:22:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:23 INFO - Return code: 0 17:22:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee8d2dd4bd083186d0542f114bfff0b93fb17a8e6259da34e815c5aa4a4f519cb21996e7259e45040626a5b311854e1a364775f50e2a30c52aa0fbdf57cef88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79b2dfdbd6fedc94245ffbe5892a0260f27080c3e49f619c912bc41f9636147284e3395a67a285587c5b220acc470be161a8904e4a088ccdd3c8f2bee36a0ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6c1927dbcd466619b45a30ef14b4ffb0e55742a3dfc54abca9306f08841df324068291c17a0b420d851d04a3001f7f0a2dc4a924f284a24acaf2f42419cffc5"} 17:22:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:23 INFO - Contents: 17:22:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee8d2dd4bd083186d0542f114bfff0b93fb17a8e6259da34e815c5aa4a4f519cb21996e7259e45040626a5b311854e1a364775f50e2a30c52aa0fbdf57cef88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79b2dfdbd6fedc94245ffbe5892a0260f27080c3e49f619c912bc41f9636147284e3395a67a285587c5b220acc470be161a8904e4a088ccdd3c8f2bee36a0ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6c1927dbcd466619b45a30ef14b4ffb0e55742a3dfc54abca9306f08841df324068291c17a0b420d851d04a3001f7f0a2dc4a924f284a24acaf2f42419cffc5"} 17:22:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:23 INFO - Copying logs to upload dir... 17:22:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.793164 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-03 17:22:23.649265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 17:22:23.653130) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee8d2dd4bd083186d0542f114bfff0b93fb17a8e6259da34e815c5aa4a4f519cb21996e7259e45040626a5b311854e1a364775f50e2a30c52aa0fbdf57cef88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79b2dfdbd6fedc94245ffbe5892a0260f27080c3e49f619c912bc41f9636147284e3395a67a285587c5b220acc470be161a8904e4a088ccdd3c8f2bee36a0ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6c1927dbcd466619b45a30ef14b4ffb0e55742a3dfc54abca9306f08841df324068291c17a0b420d851d04a3001f7f0a2dc4a924f284a24acaf2f42419cffc5"} build_url:https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/Vc7bO-yJSiOpaZl-UUolOw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee8d2dd4bd083186d0542f114bfff0b93fb17a8e6259da34e815c5aa4a4f519cb21996e7259e45040626a5b311854e1a364775f50e2a30c52aa0fbdf57cef88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79b2dfdbd6fedc94245ffbe5892a0260f27080c3e49f619c912bc41f9636147284e3395a67a285587c5b220acc470be161a8904e4a088ccdd3c8f2bee36a0ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6c1927dbcd466619b45a30ef14b4ffb0e55742a3dfc54abca9306f08841df324068291c17a0b420d851d04a3001f7f0a2dc4a924f284a24acaf2f42419cffc5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 17:22:23.680227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:22:23.680738) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464996061.604542-2043429049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:22:23.764769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 17:22:23.765080) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 17:22:23.765388) ========= ========= Total master_lag: 0.19 =========