builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1465970079.12 results: success (0) buildid: 20160614221925 builduid: 4ae920de601647388cf625adaa9de991 revision: 161aea49941f2a90c46a2b6b834590f72b1e04a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.117077) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.117522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.117799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.146936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.147204) ========= 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=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 22:54:39-- 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% 223M=0s 2016-06-14 22:54:40 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.299383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.299672) ========= 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=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023400 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.350850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:39.351157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 161aea49941f2a90c46a2b6b834590f72b1e04a6 --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 161aea49941f2a90c46a2b6b834590f72b1e04a6 --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=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 22:54:40,121 truncating revision to first 12 chars 2016-06-14 22:54:40,121 Setting DEBUG logging. 2016-06-14 22:54:40,121 attempt 1/10 2016-06-14 22:54:40,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/161aea49941f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 22:54:40,567 unpacking tar archive at: fx-team-161aea49941f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:40.164138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:40.164441) ========= script_repo_revision: 161aea49941f2a90c46a2b6b834590f72b1e04a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:40.164868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:40.165424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 22:54:40.175810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-14 22:54:40.176089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:41 INFO - MultiFileLogger online at 20160614 22:54:41 in /builds/slave/test 22:54:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:54:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:54:41 INFO - {'append_to_log': False, 22:54:41 INFO - 'base_work_dir': '/builds/slave/test', 22:54:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:54:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:54:41 INFO - 'branch': 'Fx-Team-Non-PGO', 22:54:41 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:41 INFO - 'config_files': ('talos/linux_config.py',), 22:54:41 INFO - 'default_actions': ('clobber', 22:54:41 INFO - 'read-buildbot-config', 22:54:41 INFO - 'download-and-extract', 22:54:41 INFO - 'populate-webroot', 22:54:41 INFO - 'create-virtualenv', 22:54:41 INFO - 'install', 22:54:41 INFO - 'run-tests'), 22:54:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:41 INFO - 'download_minidump_stackwalk': True, 22:54:41 INFO - 'download_symbols': 'ondemand', 22:54:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:41 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:41 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:41 INFO - 'installer_path': 'installer.exe', 22:54:41 INFO - 'log_level': 'info', 22:54:41 INFO - 'log_name': 'talos', 22:54:41 INFO - 'log_to_console': True, 22:54:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:41 INFO - 'opt_config_files': (), 22:54:41 INFO - 'pip_index': False, 22:54:41 INFO - 'sps_profile': False, 22:54:41 INFO - 'sps_profile_interval': 0, 22:54:41 INFO - 'suite': 'dromaeojs-e10s', 22:54:41 INFO - 'system_bits': '32', 22:54:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:41 INFO - 'title': 'talos-linux64-ix-020', 22:54:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:41 INFO - 'use_talos_json': True, 22:54:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:54:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:41 INFO - 'work_dir': 'build'} 22:54:41 INFO - ##### 22:54:41 INFO - ##### Running clobber step. 22:54:41 INFO - ##### 22:54:41 INFO - Running pre-action listener: _resource_record_pre_action 22:54:41 INFO - Running main action method: clobber 22:54:41 INFO - rmtree: /builds/slave/test/build 22:54:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:54:41 INFO - Running post-action listener: _resource_record_post_action 22:54:41 INFO - ##### 22:54:41 INFO - ##### Finished clobber step (success) 22:54:41 INFO - ##### 22:54:41 INFO - ##### 22:54:41 INFO - ##### Running read-buildbot-config step. 22:54:41 INFO - ##### 22:54:41 INFO - Running pre-action listener: _resource_record_pre_action 22:54:41 INFO - Running main action method: read_buildbot_config 22:54:41 INFO - Using buildbot properties: 22:54:41 INFO - { 22:54:41 INFO - "project": "", 22:54:41 INFO - "product": "firefox", 22:54:41 INFO - "script_repo_revision": "production", 22:54:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:54:41 INFO - "repository": "", 22:54:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:54:41 INFO - "buildid": "20160614221925", 22:54:41 INFO - "pgo_build": "False", 22:54:41 INFO - "basedir": "/builds/slave/test", 22:54:41 INFO - "buildnumber": 1588, 22:54:41 INFO - "slavename": "talos-linux64-ix-020", 22:54:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:54:41 INFO - "platform": "ubuntu64_hw", 22:54:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:54:41 INFO - "branch": "fx-team", 22:54:41 INFO - "repo_path": "integration/fx-team", 22:54:41 INFO - "revision": "161aea49941f2a90c46a2b6b834590f72b1e04a6", 22:54:41 INFO - "stage_platform": "linux64", 22:54:41 INFO - "builduid": "4ae920de601647388cf625adaa9de991", 22:54:41 INFO - "slavebuilddir": "test" 22:54:41 INFO - } 22:54:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:54:41 INFO - Running post-action listener: _resource_record_post_action 22:54:41 INFO - ##### 22:54:41 INFO - ##### Finished read-buildbot-config step (success) 22:54:41 INFO - ##### 22:54:41 INFO - ##### 22:54:41 INFO - ##### Running download-and-extract step. 22:54:41 INFO - ##### 22:54:41 INFO - Running pre-action listener: _resource_record_pre_action 22:54:41 INFO - Running main action method: download_and_extract 22:54:41 INFO - mkdir: /builds/slave/test/build/tests 22:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:41 INFO - https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:54:49 INFO - Downloaded 1361 bytes. 22:54:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:54:49 INFO - Using the following test package requirements: 22:54:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:54:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'jsshell-linux-x86_64.zip'], 22:54:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:54:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:54:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:49 INFO - https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:50 INFO - Downloaded 22653673 bytes. 22:54:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:54:52 INFO - Return code: 0 22:54:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:54:52 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')]} 22:54:52 INFO - https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:54 INFO - Downloaded 22653673 bytes. 22:54:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:54:56 INFO - Return code: 0 22:54:56 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')]} 22:54:56 INFO - https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:54:58 INFO - Downloaded 14405384 bytes. 22:54:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:54:58 INFO - Return code: 0 22:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:58 INFO - https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:55:00 INFO - Downloaded 55397261 bytes. 22:55:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:55:00 INFO - mkdir: /builds/slave/test/properties 22:55:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:55:00 INFO - Writing to file /builds/slave/test/properties/build_url 22:55:00 INFO - Contents: 22:55:00 INFO - build_url:https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:55:01 INFO - Running post-action listener: _resource_record_post_action 22:55:01 INFO - Running post-action listener: set_extra_try_arguments 22:55:01 INFO - ##### 22:55:01 INFO - ##### Finished download-and-extract step (success) 22:55:01 INFO - ##### 22:55:01 INFO - ##### 22:55:01 INFO - ##### Running populate-webroot step. 22:55:01 INFO - ##### 22:55:01 INFO - Running pre-action listener: _resource_record_pre_action 22:55:01 INFO - Running main action method: populate_webroot 22:55:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:55:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:55:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:55:01 INFO - '--tppagecycles', 22:55:01 INFO - '7'], 22:55:01 INFO - 'tests': ['tsvgm']}}, 22:55:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:55:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:55:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:55:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:55:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['damp', 'tps']}, 22:55:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'tests': ['damp', 'tps']}, 22:55:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['dromaeo_dom']}, 22:55:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:55:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['basic_compositor_video']}, 22:55:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:55:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'other-e10s': {'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['a11yr', 22:55:01 INFO - 'ts_paint', 22:55:01 INFO - 'tpaint', 22:55:01 INFO - 'sessionrestore', 22:55:01 INFO - 'sessionrestore_no_auto_restore', 22:55:01 INFO - 'tabpaint']}, 22:55:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['tsvgx', 22:55:01 INFO - 'tsvgr_opacity', 22:55:01 INFO - 'tart', 22:55:01 INFO - 'tscrollx', 22:55:01 INFO - 'cart']}, 22:55:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:55:01 INFO - 'tsvgr_opacity', 22:55:01 INFO - 'tart', 22:55:01 INFO - 'tscrollx', 22:55:01 INFO - 'cart']}, 22:55:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'talos_options': ['--disable-e10s'], 22:55:01 INFO - 'tests': ['tp5o']}, 22:55:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'tests': ['tp5o']}, 22:55:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'talos_options': ['--disable-e10s', 22:55:01 INFO - '--xperf_path', 22:55:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:01 INFO - 'tests': ['tp5n']}, 22:55:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:01 INFO - 'talos_options': ['--xperf_path', 22:55:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:01 INFO - 'tests': ['tp5n']}}, 22:55:01 INFO - 'talos.zip': {'path': '', 22:55:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:55:01 INFO - Running post-action listener: _resource_record_post_action 22:55:01 INFO - ##### 22:55:01 INFO - ##### Finished populate-webroot step (success) 22:55:01 INFO - ##### 22:55:01 INFO - ##### 22:55:01 INFO - ##### Running create-virtualenv step. 22:55:01 INFO - ##### 22:55:01 INFO - Running pre-action listener: _resource_record_pre_action 22:55:01 INFO - Running main action method: create_virtualenv 22:55:01 INFO - Creating virtualenv /builds/slave/test/build/venv 22:55: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 22:55:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:55:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:55:01 INFO - Using real prefix '/usr' 22:55:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:55:01 INFO - Installing distribute.............................................................................................................................................................................................done. 22:55:03 INFO - Installing pip.................done. 22:55:03 INFO - Return code: 0 22:55:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:03 INFO - Using env: {'DISPLAY': ':0', 22:55:03 INFO - 'HOME': '/home/cltbld', 22:55:03 INFO - 'LANG': 'en_US.UTF-8', 22:55:03 INFO - 'LANGUAGE': 'en_US:en', 22:55:03 INFO - 'LOGNAME': 'cltbld', 22:55:03 INFO - 'MAIL': '/var/mail/cltbld', 22:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:03 INFO - 'MOZ_NO_REMOTE': '1', 22:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:03 INFO - 'NO_EM_RESTART': '1', 22:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:03 INFO - 'PWD': '/builds/slave/test', 22:55:03 INFO - 'SHELL': '/bin/bash', 22:55:03 INFO - 'SHLVL': '1', 22:55:03 INFO - 'TERM': 'linux', 22:55:03 INFO - 'TMOUT': '86400', 22:55:03 INFO - 'USER': 'cltbld', 22:55:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:03 INFO - '_': '/tools/buildbot/bin/python'} 22:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:03 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 22:55:03 INFO - Cleaning up... 22:55:03 INFO - Return code: 0 22:55:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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', '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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:55: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 psutil>=3.1.1 22:55:03 INFO - Using env: {'DISPLAY': ':0', 22:55:03 INFO - 'HOME': '/home/cltbld', 22:55:03 INFO - 'LANG': 'en_US.UTF-8', 22:55:03 INFO - 'LANGUAGE': 'en_US:en', 22:55:03 INFO - 'LOGNAME': 'cltbld', 22:55:03 INFO - 'MAIL': '/var/mail/cltbld', 22:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:03 INFO - 'MOZ_NO_REMOTE': '1', 22:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:03 INFO - 'NO_EM_RESTART': '1', 22:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:03 INFO - 'PWD': '/builds/slave/test', 22:55:03 INFO - 'SHELL': '/bin/bash', 22:55:03 INFO - 'SHLVL': '1', 22:55:03 INFO - 'TERM': 'linux', 22:55:03 INFO - 'TMOUT': '86400', 22:55:03 INFO - 'USER': 'cltbld', 22:55:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:03 INFO - '_': '/tools/buildbot/bin/python'} 22:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:04 INFO - Downloading/unpacking psutil>=3.1.1 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:55:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:06 INFO - Installing collected packages: psutil 22:55:06 INFO - Running setup.py install for psutil 22:55:06 INFO - building 'psutil._psutil_linux' extension 22:55: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 22:55: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 22:55:06 INFO - building 'psutil._psutil_posix' extension 22:55: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 22:55: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 22:55:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:06 INFO - Successfully installed psutil 22:55:06 INFO - Cleaning up... 22:55:06 INFO - Return code: 0 22:55:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:06 INFO - Using env: {'DISPLAY': ':0', 22:55:06 INFO - 'HOME': '/home/cltbld', 22:55:06 INFO - 'LANG': 'en_US.UTF-8', 22:55:06 INFO - 'LANGUAGE': 'en_US:en', 22:55:06 INFO - 'LOGNAME': 'cltbld', 22:55:06 INFO - 'MAIL': '/var/mail/cltbld', 22:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:06 INFO - 'MOZ_NO_REMOTE': '1', 22:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:06 INFO - 'NO_EM_RESTART': '1', 22:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:06 INFO - 'PWD': '/builds/slave/test', 22:55:06 INFO - 'SHELL': '/bin/bash', 22:55:06 INFO - 'SHLVL': '1', 22:55:06 INFO - 'TERM': 'linux', 22:55:06 INFO - 'TMOUT': '86400', 22:55:06 INFO - 'USER': 'cltbld', 22:55:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:06 INFO - '_': '/tools/buildbot/bin/python'} 22:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:55:06 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 22:55:06 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 22:55:06 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 22:55:06 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 22:55:06 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 22:55:06 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 22:55:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:55:08 INFO - Installing collected packages: mozsystemmonitor 22:55:08 INFO - Running setup.py install for mozsystemmonitor 22:55:08 INFO - Successfully installed mozsystemmonitor 22:55:08 INFO - Cleaning up... 22:55:08 INFO - Return code: 0 22:55:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:55:08 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')]} 22:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:08 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')]} 22:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:08 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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55:08 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 22:55:08 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 22:55:08 INFO - Using env: {'DISPLAY': ':0', 22:55:08 INFO - 'HOME': '/home/cltbld', 22:55:08 INFO - 'LANG': 'en_US.UTF-8', 22:55:08 INFO - 'LANGUAGE': 'en_US:en', 22:55:08 INFO - 'LOGNAME': 'cltbld', 22:55:08 INFO - 'MAIL': '/var/mail/cltbld', 22:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:08 INFO - 'MOZ_NO_REMOTE': '1', 22:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:08 INFO - 'NO_EM_RESTART': '1', 22:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:08 INFO - 'PWD': '/builds/slave/test', 22:55:08 INFO - 'SHELL': '/bin/bash', 22:55:08 INFO - 'SHLVL': '1', 22:55:08 INFO - 'TERM': 'linux', 22:55:08 INFO - 'TMOUT': '86400', 22:55:08 INFO - 'USER': 'cltbld', 22:55:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:08 INFO - '_': '/tools/buildbot/bin/python'} 22:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:09 INFO - Downloading/unpacking jsonschema==2.5.1 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:55:10 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 22:55:10 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 22:55:10 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 22:55:10 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 22:55:10 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 22:55:10 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 22:55:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:11 INFO - warning: no files found matching '*.txt' 22:55:11 INFO - no previously-included directories found matching 'build' 22:55:11 INFO - no previously-included directories found matching 'dist' 22:55:11 INFO - no previously-included directories found matching '.git*' 22:55:11 INFO - Installing collected packages: jsonschema, functools32 22:55:11 INFO - Running setup.py install for functools32 22:55:11 INFO - warning: no files found matching '*.txt' 22:55:11 INFO - no previously-included directories found matching 'build' 22:55:11 INFO - no previously-included directories found matching 'dist' 22:55:11 INFO - no previously-included directories found matching '.git*' 22:55:11 INFO - Successfully installed jsonschema functools32 22:55:11 INFO - Cleaning up... 22:55:11 INFO - Return code: 0 22:55:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:11 INFO - Using env: {'DISPLAY': ':0', 22:55:11 INFO - 'HOME': '/home/cltbld', 22:55:11 INFO - 'LANG': 'en_US.UTF-8', 22:55:11 INFO - 'LANGUAGE': 'en_US:en', 22:55:11 INFO - 'LOGNAME': 'cltbld', 22:55:11 INFO - 'MAIL': '/var/mail/cltbld', 22:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:11 INFO - 'MOZ_NO_REMOTE': '1', 22:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:11 INFO - 'NO_EM_RESTART': '1', 22:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:11 INFO - 'PWD': '/builds/slave/test', 22:55:11 INFO - 'SHELL': '/bin/bash', 22:55:11 INFO - 'SHLVL': '1', 22:55:11 INFO - 'TERM': 'linux', 22:55:11 INFO - 'TMOUT': '86400', 22:55:11 INFO - 'USER': 'cltbld', 22:55:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:11 INFO - '_': '/tools/buildbot/bin/python'} 22:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:55:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:55:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:14 INFO - Downloading docopt-0.6.1.tar.gz 22:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:55:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:55:14 INFO - Running setup.py install for blobuploader 22:55:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:55:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:55:14 INFO - Running setup.py install for requests 22:55:14 INFO - Running setup.py install for docopt 22:55:14 INFO - Successfully installed blobuploader requests docopt 22:55:14 INFO - Cleaning up... 22:55:14 INFO - Return code: 0 22:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:14 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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55:14 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 22:55:14 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 22:55:14 INFO - Using env: {'DISPLAY': ':0', 22:55:14 INFO - 'HOME': '/home/cltbld', 22:55:14 INFO - 'LANG': 'en_US.UTF-8', 22:55:14 INFO - 'LANGUAGE': 'en_US:en', 22:55:14 INFO - 'LOGNAME': 'cltbld', 22:55:14 INFO - 'MAIL': '/var/mail/cltbld', 22:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:14 INFO - 'MOZ_NO_REMOTE': '1', 22:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:14 INFO - 'NO_EM_RESTART': '1', 22:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:14 INFO - 'PWD': '/builds/slave/test', 22:55:14 INFO - 'SHELL': '/bin/bash', 22:55:14 INFO - 'SHLVL': '1', 22:55:14 INFO - 'TERM': 'linux', 22:55:14 INFO - 'TMOUT': '86400', 22:55:14 INFO - 'USER': 'cltbld', 22:55:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:14 INFO - '_': '/tools/buildbot/bin/python'} 22:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:55:15 INFO - Running setup.py (path:/tmp/pip-Y7_haC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:55:15 INFO - Running setup.py (path:/tmp/pip-CHwA7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:55:15 INFO - Running setup.py (path:/tmp/pip-qyJlU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:55:15 INFO - Running setup.py (path:/tmp/pip-hLsQtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:55:15 INFO - Running setup.py (path:/tmp/pip-VPIhVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:55:15 INFO - Running setup.py (path:/tmp/pip-LvuBSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:55:15 INFO - Running setup.py (path:/tmp/pip-HOLQyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:55:15 INFO - Running setup.py (path:/tmp/pip-oW9dGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:55:15 INFO - Running setup.py (path:/tmp/pip-z3BCie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:55:15 INFO - Running setup.py (path:/tmp/pip-K638B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:55:15 INFO - Running setup.py (path:/tmp/pip-sRCWr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:55:15 INFO - Running setup.py (path:/tmp/pip-AcKbPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:55:15 INFO - Running setup.py (path:/tmp/pip-pu4BEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:55:16 INFO - Running setup.py (path:/tmp/pip-ukLD_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:16 INFO - Running setup.py (path:/tmp/pip-PeL9mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:55:16 INFO - Running setup.py (path:/tmp/pip-Do55bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:55:16 INFO - Running setup.py (path:/tmp/pip-aO5Ers-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:55:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:55:16 INFO - Running setup.py install for manifestparser 22:55:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:55:16 INFO - Running setup.py install for mozcrash 22:55:16 INFO - Running setup.py install for mozdebug 22:55:16 INFO - Running setup.py install for mozdevice 22:55:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:55:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:55:16 INFO - Running setup.py install for mozfile 22:55:16 INFO - Running setup.py install for mozhttpd 22:55:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:55:16 INFO - Running setup.py install for mozinfo 22:55:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for mozInstall 22:55:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for mozleak 22:55:17 INFO - Running setup.py install for mozlog 22:55:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for moznetwork 22:55:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for mozprocess 22:55:17 INFO - Running setup.py install for mozprofile 22:55:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for mozrunner 22:55:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:55:17 INFO - Running setup.py install for mozscreenshot 22:55:17 INFO - Running setup.py install for moztest 22:55:17 INFO - Running setup.py install for mozversion 22:55:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:55:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:18 INFO - Cleaning up... 22:55:18 INFO - Return code: 0 22:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:18 INFO - Using env: {'DISPLAY': ':0', 22:55:18 INFO - 'HOME': '/home/cltbld', 22:55:18 INFO - 'LANG': 'en_US.UTF-8', 22:55:18 INFO - 'LANGUAGE': 'en_US:en', 22:55:18 INFO - 'LOGNAME': 'cltbld', 22:55:18 INFO - 'MAIL': '/var/mail/cltbld', 22:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:18 INFO - 'MOZ_NO_REMOTE': '1', 22:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:18 INFO - 'NO_EM_RESTART': '1', 22:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:18 INFO - 'PWD': '/builds/slave/test', 22:55:18 INFO - 'SHELL': '/bin/bash', 22:55:18 INFO - 'SHLVL': '1', 22:55:18 INFO - 'TERM': 'linux', 22:55:18 INFO - 'TMOUT': '86400', 22:55:18 INFO - 'USER': 'cltbld', 22:55:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:18 INFO - '_': '/tools/buildbot/bin/python'} 22:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:55:18 INFO - Running setup.py (path:/tmp/pip-gNsQau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:55: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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:55:18 INFO - Running setup.py (path:/tmp/pip-gubqru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:55: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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:55:18 INFO - Running setup.py (path:/tmp/pip-RKZ6G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:55: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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:55:18 INFO - Running setup.py (path:/tmp/pip-V2OmxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:55: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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:55:18 INFO - Running setup.py (path:/tmp/pip-cAhIp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:55: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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:55:18 INFO - Running setup.py (path:/tmp/pip-sJzLul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:55:18 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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:55:18 INFO - Running setup.py (path:/tmp/pip-Vp5Xys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:55:18 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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:55:18 INFO - Running setup.py (path:/tmp/pip-CNWqBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:55:18 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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:55:18 INFO - Running setup.py (path:/tmp/pip-_gvNNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:55:18 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)) 22:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:55:18 INFO - Running setup.py (path:/tmp/pip-GkNCru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:55:19 INFO - Running setup.py (path:/tmp/pip-_HciFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:55:19 INFO - Running setup.py (path:/tmp/pip-DvGhEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:55:19 INFO - Running setup.py (path:/tmp/pip-YA1gVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:55:19 INFO - Running setup.py (path:/tmp/pip-4thvVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:19 INFO - Running setup.py (path:/tmp/pip-ryeGMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:55:19 INFO - Running setup.py (path:/tmp/pip-6k6WOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:55: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)) 22:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:55:19 INFO - Running setup.py (path:/tmp/pip-AaOYx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:21 INFO - Downloading blessings-1.6.tar.gz 22:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:21 INFO - Installing collected packages: blessings 22:55:21 INFO - Running setup.py install for blessings 22:55:21 INFO - Successfully installed blessings 22:55:21 INFO - Cleaning up... 22:55:21 INFO - Return code: 0 22:55:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:21 INFO - Reading from file tmpfile_stdout 22:55:21 INFO - Current package versions: 22:55:21 INFO - argparse == 1.2.1 22:55:21 INFO - blessings == 1.6 22:55:21 INFO - blobuploader == 1.2.4 22:55:21 INFO - docopt == 0.6.1 22:55:21 INFO - functools32 == 3.2.3-2 22:55:21 INFO - jsonschema == 2.5.1 22:55:21 INFO - manifestparser == 1.1 22:55:21 INFO - mozInstall == 1.12 22:55:21 INFO - mozcrash == 0.17 22:55:21 INFO - mozdebug == 0.1 22:55:21 INFO - mozdevice == 0.48 22:55:21 INFO - mozfile == 1.2 22:55:21 INFO - mozhttpd == 0.7 22:55:21 INFO - mozinfo == 0.9 22:55:21 INFO - mozleak == 0.1 22:55:21 INFO - mozlog == 3.2 22:55:21 INFO - moznetwork == 0.27 22:55:21 INFO - mozprocess == 0.22 22:55:21 INFO - mozprofile == 0.28 22:55:21 INFO - mozrunner == 6.11 22:55:21 INFO - mozscreenshot == 0.1 22:55:21 INFO - mozsystemmonitor == 0.3 22:55:21 INFO - moztest == 0.7 22:55:21 INFO - mozversion == 1.4 22:55:21 INFO - psutil == 3.1.1 22:55:21 INFO - requests == 1.2.3 22:55:21 INFO - wsgiref == 0.1.2 22:55:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:21 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')]} 22:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:21 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')]} 22:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:21 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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55:21 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 22:55:21 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 22:55:21 INFO - Using env: {'DISPLAY': ':0', 22:55:21 INFO - 'HOME': '/home/cltbld', 22:55:21 INFO - 'LANG': 'en_US.UTF-8', 22:55:21 INFO - 'LANGUAGE': 'en_US:en', 22:55:21 INFO - 'LOGNAME': 'cltbld', 22:55:21 INFO - 'MAIL': '/var/mail/cltbld', 22:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:21 INFO - 'MOZ_NO_REMOTE': '1', 22:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:21 INFO - 'NO_EM_RESTART': '1', 22:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:21 INFO - 'PWD': '/builds/slave/test', 22:55:21 INFO - 'SHELL': '/bin/bash', 22:55:21 INFO - 'SHLVL': '1', 22:55:21 INFO - 'TERM': 'linux', 22:55:21 INFO - 'TMOUT': '86400', 22:55:21 INFO - 'USER': 'cltbld', 22:55:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:21 INFO - '_': '/tools/buildbot/bin/python'} 22:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55: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)) 22:55:22 INFO - Cleaning up... 22:55:22 INFO - Return code: 0 22:55:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:22 INFO - Using env: {'DISPLAY': ':0', 22:55:22 INFO - 'HOME': '/home/cltbld', 22:55:22 INFO - 'LANG': 'en_US.UTF-8', 22:55:22 INFO - 'LANGUAGE': 'en_US:en', 22:55:22 INFO - 'LOGNAME': 'cltbld', 22:55:22 INFO - 'MAIL': '/var/mail/cltbld', 22:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:22 INFO - 'MOZ_NO_REMOTE': '1', 22:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:22 INFO - 'NO_EM_RESTART': '1', 22:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:22 INFO - 'PWD': '/builds/slave/test', 22:55:22 INFO - 'SHELL': '/bin/bash', 22:55:22 INFO - 'SHLVL': '1', 22:55:22 INFO - 'TERM': 'linux', 22:55:22 INFO - 'TMOUT': '86400', 22:55:22 INFO - 'USER': 'cltbld', 22:55:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:22 INFO - '_': '/tools/buildbot/bin/python'} 22:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:55:22 INFO - Cleaning up... 22:55:22 INFO - Return code: 0 22:55:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:55: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')]} 22:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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 0x7fdfb5e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', '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 22:55: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 22:55: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 22:55:22 INFO - Using env: {'DISPLAY': ':0', 22:55:22 INFO - 'HOME': '/home/cltbld', 22:55:22 INFO - 'LANG': 'en_US.UTF-8', 22:55:22 INFO - 'LANGUAGE': 'en_US:en', 22:55:22 INFO - 'LOGNAME': 'cltbld', 22:55:22 INFO - 'MAIL': '/var/mail/cltbld', 22:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:22 INFO - 'MOZ_NO_REMOTE': '1', 22:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:22 INFO - 'NO_EM_RESTART': '1', 22:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:22 INFO - 'PWD': '/builds/slave/test', 22:55:22 INFO - 'SHELL': '/bin/bash', 22:55:22 INFO - 'SHLVL': '1', 22:55:22 INFO - 'TERM': 'linux', 22:55:22 INFO - 'TMOUT': '86400', 22:55:22 INFO - 'USER': 'cltbld', 22:55:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:22 INFO - '_': '/tools/buildbot/bin/python'} 22:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:22 INFO - Downloading/unpacking flake8 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:25 INFO - no previously-included directories found matching 'docs/_build' 22:55:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:25 INFO - Running setup.py install for pep8 22:55:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:25 INFO - no previously-included directories found matching 'docs/_build' 22:55:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:55:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:25 INFO - Cleaning up... 22:55:25 INFO - Return code: 0 22:55:25 INFO - Running post-action listener: _resource_record_post_action 22:55:25 INFO - Running post-action listener: _start_resource_monitoring 22:55:25 INFO - Starting resource monitoring. 22:55:25 INFO - ##### 22:55:25 INFO - ##### Finished create-virtualenv step (success) 22:55:25 INFO - ##### 22:55:25 INFO - ##### 22:55:25 INFO - ##### Running install step. 22:55:25 INFO - ##### 22:55:25 INFO - Running pre-action listener: _resource_record_pre_action 22:55:25 INFO - Running main action method: install 22:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:25 INFO - Reading from file tmpfile_stdout 22:55:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:55:25 INFO - Reading from file tmpfile_stdout 22:55:25 INFO - Output received: 22:55:25 INFO - Usage: mozinstall [options] installer 22:55:25 INFO - Options: 22:55:25 INFO - -h, --help show this help message and exit 22:55:25 INFO - -d DEST, --destination=DEST 22:55:25 INFO - Directory to install application into. [default: 22:55:25 INFO - "/builds/slave/test"] 22:55:25 INFO - --app=APP Application being installed. [default: firefox] 22:55:25 INFO - mkdir: /builds/slave/test/build/application 22:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:55:41 INFO - Reading from file tmpfile_stdout 22:55:41 INFO - Output received: 22:55:41 INFO - /builds/slave/test/build/application/firefox/firefox 22:55:41 INFO - Running post-action listener: _resource_record_post_action 22:55:41 INFO - ##### 22:55:41 INFO - ##### Finished install step (success) 22:55:41 INFO - ##### 22:55:41 INFO - ##### 22:55:41 INFO - ##### Running run-tests step. 22:55:41 INFO - ##### 22:55:41 INFO - Running pre-action listener: _resource_record_pre_action 22:55:41 INFO - Running main action method: run_tests 22:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:55:41 INFO - Python 2.7.3 22:55:41 INFO - Return code: 0 22:55:41 INFO - grabbing minidump binary from tooltool 22:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:41 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 0x1ebf1c0>, '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 0x1ec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:55:41 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 22:55:41 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 22:55:41 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 22:55:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:41 INFO - Return code: 0 22:55:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:55:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:55:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:55:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:55:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:55:42 INFO - Return code: 0 22:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 22:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 22:55:42 INFO - Using env: {'DISPLAY': ':0', 22:55:42 INFO - 'HOME': '/home/cltbld', 22:55:42 INFO - 'LANG': 'en_US.UTF-8', 22:55:42 INFO - 'LANGUAGE': 'en_US:en', 22:55:42 INFO - 'LOGNAME': 'cltbld', 22:55:42 INFO - 'MAIL': '/var/mail/cltbld', 22:55:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:55:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:42 INFO - 'MOZ_NO_REMOTE': '1', 22:55:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:42 INFO - 'NO_EM_RESTART': '1', 22:55:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:42 INFO - 'PWD': '/builds/slave/test', 22:55:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:55:42 INFO - 'SHELL': '/bin/bash', 22:55:42 INFO - 'SHLVL': '1', 22:55:42 INFO - 'TERM': 'linux', 22:55:42 INFO - 'TMOUT': '86400', 22:55:42 INFO - 'USER': 'cltbld', 22:55:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484', 22:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:42 INFO - '_': '/tools/buildbot/bin/python'} 22:55:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 22:55:42 INFO - mozversion application_buildid: 20160614221925 22:55:42 INFO - mozversion application_changeset: 161aea49941f2a90c46a2b6b834590f72b1e04a6 22:55:42 INFO - mozversion application_display_name: Nightly 22:55:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:42 INFO - mozversion application_name: Firefox 22:55:42 INFO - mozversion application_remotingname: firefox 22:55:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:42 INFO - mozversion application_vendor: Mozilla 22:55:42 INFO - mozversion application_version: 50.0a1 22:55:42 INFO - mozversion platform_buildid: 20160614221925 22:55:42 INFO - mozversion platform_changeset: 161aea49941f2a90c46a2b6b834590f72b1e04a6 22:55:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:42 INFO - mozversion platform_version: 50.0a1 22:55:42 INFO - using testdate: 1465970142 22:55:42 INFO - actual date: 1465970142 22:55:42 INFO - starting webserver on 'localhost:56515' 22:55:42 INFO - SUITE-START | Running 2 tests 22:55:42 INFO - TEST-START | dromaeo_css 22:55:42 INFO - operating with platform_type : linux_ 22:55:42 INFO - Initialising browser for dromaeo_css test... 22:55:42 INFO - TEST-INFO | started process 6402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHwDJW/profile http://localhost:56515/getInfo.html) 22:55:48 INFO - PROCESS | 6402 | __metrics Screen width/height:1600/1200 22:55:48 INFO - PROCESS | 6402 | colorDepth:24 22:55:48 INFO - PROCESS | 6402 | Browser inner width/height: 1024/697 22:55:48 INFO - PROCESS | 6402 | __metrics 22:55:49 ERROR - PROCESS | 6402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:55:50 INFO - TEST-INFO | 6402: exit 0 22:55:50 INFO - Browser initialized. 22:55:50 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:50 INFO - TEST-INFO | started process 6518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVHwDJW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:02 INFO - PROCESS | 6518 | RSS: Main: 186056704 22:56:02 INFO - PROCESS | 6518 | 22:56:52 INFO - PROCESS | 6518 | 1465970212197 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] 22:59:04 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56515/tests/dromaeo/cssquery-ext.html) 22:59:05 INFO - PROCESS | 6518 | RSS: Main: 189009920 22:59:05 INFO - PROCESS | 6518 | 23:02:07 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-ext.html (next: http://localhost:56515/tests/dromaeo/cssquery-jquery.html) 23:02:08 INFO - PROCESS | 6518 | RSS: Main: 188043264 23:02:08 INFO - PROCESS | 6518 | 23:05:10 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56515/tests/dromaeo/cssquery-mootools.html) 23:05:10 INFO - PROCESS | 6518 | RSS: Main: 189693952 23:05:10 INFO - PROCESS | 6518 | 23:08:12 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56515/tests/dromaeo/cssquery-prototype.html) 23:08:13 INFO - PROCESS | 6518 | RSS: Main: 186892288 23:08:13 INFO - PROCESS | 6518 | 23:11:15 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56515/tests/dromaeo/cssquery-yui.html) 23:11:16 INFO - PROCESS | 6518 | RSS: Main: 188858368 23:11:16 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:56515/tests/dromaeo/cssquery-yui.html (next: http://localhost:56515/tests/dromaeo/cssquery-dojo.html) 23:14:19 INFO - PROCESS | 6518 | RSS: Main: 190070784 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | __start_tp_report 23:14:19 INFO - PROCESS | 6518 | _x_x_mozilla_page_load 23:14:19 INFO - PROCESS | 6518 | _x_x_mozilla_page_load_details 23:14:19 INFO - PROCESS | 6518 | |i|pagename|runs| 23:14:19 INFO - PROCESS | 6518 | |0;dojo.html;2615.3330900620344;2686;2699.3521554826834;2703.5133675938323;2706.8375897446144;4788.329633851259;4791.520847915211;4837.105135549921;4846.248831431125;4935.161022626153;4624.213883639781;4782.1153086678905;4851.587615052716;4868.342773725546;4894;4367.366731823891;4382.189294980423;4463.330500424946;4494.258447356182;4495.617872480843;4185;4487.371767952489;4513.526079761627;4561.087782443525;4561.543845615445;4336.588024137702;4361.149575832714;4367.432233809616;4394.1870753910625;4435.866923992269;4347.891302717426;4359.585839345257;4414.448193975753;4417.558244175557;4430.313301438282;4389.758563279019;4398.912021759547;4399.978000110011;4405.405270288502;4463.285874260103;4744.928826067612;4823.493533179036;4840.564349208553;4859.07677541266;4863;5180.611454140954;5193.63644544882;5195.376554813447;5201.921971170435;5261;5060.266261392115;5234.136367499358;5242.475752424765;5254.185601231815;5262.578993680535;4901;4924.556789888928;4939.802407903644;4941.382327209099;4954.826581069645;5440.972795136078;5448.8365349038795;5458.727063646802;5467;5494.80768173112;4940.456549779521;5030.572401345853;5077.669951453144;5186.066508028515;5187.04039752647;4982.60139188864;5165.044466773659;5185.325907631984;5206.427292997767;5235.502627250406;5070.721110338893;5099.617528685363;5135.820246291362;5153.072446959508;5163.277141200235;4972.254161875748;5101.51535604117;5119.0273847968765;5150.047241260304;5184.170532714747;4396.472423309224;4418.867433976986;4420.248557745191;4453.020335526179;4470.083632855257;3797.468354430382;3811.866584669523;3830.0999265172663;3833.674137698271;3874.728768986144;4298.140371925628;4413.470383553929;4462.129884672458;4515.345274935116;4523.5024147343765;5199.272101905736;5245.0558899398475;5247.790088396498;5261.342332208474;5286.233496143038;4439.263925400513;4468.106378724268;4486.394336764561;4518.751468669255;4527.479339875957;4500.414946057057;4643.605293550018;4659.906801863944;4662.114198302312;4690.7654617269;4931.556159945622;4940.407151141814;4958.752062396938;4961.975190124026;5005.524475174852;5257.053730328577;5273.525382715574;5292.788288468418;5295.576353891603;5298.920516192337;4752.809887604457;4845.830395936126;4864.902701946012;4871.561559459666;4873.074115918106;5078.97460512695;5112.207607820794;5120.539151476385;5137.33214682089;5195.064888319987;4991.101601711727;5212.478752124757;5262.184361423985;5265.1049321614655;5266.73666316675;4820.301056346881;4976.601871850316;5035.320231768811;5100.081985242692;5126.846194614168;5002.299678045004;5044.571211447068;5057.291979122852;5068.417132029864;5081.593472522115;4934.481879402611;4957.702537847741;4967.7516124192925;4991.625628077836;5033.723145227048;4925.38432695913;5065.594752419724;5123.359580052494;5128.948710512847;5129.743512824419;4989.476105009067;5025.7989680412375;5030.170021946485;5040.571551418024;5048.848534543969 23:14:19 INFO - PROCESS | 6518 | |1;ext.html;548.8238154007256;571.3857603076692;576.084026398027;588.2558563417277;610.490240649058;34180.99999999997;38022.42966355507;38103.237935241275;38196;38196.236075278546;38143.42784858222;38611;38620.80689596555;38661;38732.41901371482;7806.219378062206;7952.165022672622;7974.481658692166;7993.960030199841;7998.080220774627;7771.533707977511;7844.490108142981;7905.881411778828;7916.287534121928;7927.445078844483;7928.048634163908;7942.6425810838655;7953.164917683646;7953.72161974331;7953.72161974331;7820.45256832022;7846.960765196166;7866.174051724573;7878.80302992424;7928.960355198187;7726.729564465217;7782.9610851945945;7831.6475758591005;7862.095858976234;7878.842423151562;29523.70476295231;36859.447108293396;37313;37429.812850935574;37489.81255093707;3094.2883136878418;3147.6380216275193;3245.837708114585;3669.101070237782;3767.4160505121476;27805.443891122268;28030.719692803013;28294.717052829415;30798.69201308003;31063.378732425226;3409.2499650077193;3526.0832183632183;3556.822158892045;3560.2523470071314;3724.9068773280883;248251;253498;254801;255557;255972.7201364;57510.42489575134;58099;58579.70710146422;58630;58669;33316.834405764035;33988.660113398546;34054.65945340564;36300.273994519965;36373.09067273286;13493;13552.45790168402;13594.048416610742;13596.456141754417;13627;10601.204909631808;10660.733481662865;10723.356598604109;10735.677929662123;10808.189385796097;18990.71513927292;18991.620167596848;19000;19270.518237044187;19462.70805937912;7300.926990730131;7473.364763995121;7697.615119244016;7703.1911649277135;7734.806629834186;837.4891316297054;887.1040249348205;899.4827973914894;930.2883294279882;976.5605477535138;28263.57604635932;28593.428131437257;28700;29107;29256;938.4838338913706;974.6832279509188;1020.9489525523694;1044.639599338227;1093.316677076827;14804.333804978802;15085.54743357701;15247;15316.923415382851;15595.766063509056;412726;412765;424424;424489;425198;50327.496725033016;50730.49269507331;50777.492225078015;50985;51027.23459148042;1164.4352489042808;1185.7450648110698;1205.4153735438306;1206.2340413837276;1214.8117041858527;26716.599251011638;26980.1905942822;28139;28359.29101772472;28623.570646439905;43503.78248108739;43814.56185438105;43897;43933.340999884385;44112.77943610262;334907;337546;339226;340023;340365;25905.74094259033;25928;26300.501452361994;26414.735852641228;26632.002599804706;43005.56994430141;43574.346384804885;43817;43930.780346098065;44064.55935440733;36439.81780091082;37909;37955;38358.2328353437;38719.419208711326;35784;38016.619833801306;38194.618053819104;40405.19189616133;40495;35924.64075359213;36661.63338366582;37007.25985480329;37386.252274954895;39429.802850985565;28485;31425.52861707122;31742;32035.839820800746;32112.518312225802;24894.875525622258;24915.626265606392;25008.499830002933;25131;25402.872985634953 23:14:19 INFO - PROCESS | 6518 | |2;jquery.html;368.3958308374266;370.9758865673732;372.4487758117987;381.74613881768624;381.92934307153195;16045.919770401146;16762.748558771615;16853.41013064543;16989.830101698994;17142.742858857095;16105.677886442265;16765;17462.563435914075;17476.475705728815;17562.912185439054;5016.172331565287;5169.638125331228;5200.193969934666;5201.505856943584;5207.114790485626;3702.9259414811686;5043.949560504403;5704.71476426177;6014.939850601503;6020.066889632114;6045.939540604603;6049;6057.666828324441;6083.604565703237;6093.451589356957;6012.038073908176;6086;6096.35988221237;6104.3590423005835;6110.847228819271;5314.202869569557;5348.705821179834;5363.195520671891;5364.436734142937;5385.7307134643115;17825.46523604294;18987.43037708871;20096.59806803856;20513.589728205352;20642.48393790152;1879.5864909719976;2186.9125234990584;2252.4931890324547;2319.095552734435;2321.976780232193;8841.027486976427;8901;8982.550872456351;9045.095490450967;9200.677976270865;1654.7352423612165;1676.9916150419292;1697.0496521947748;1734.314945596495;1751.098184435017;64854.675726621535;66200.3379966199;66687;67681.66159169222;67954.66022669854;9821;9976.102150806462;10104.898951010542;10119.190464762802;10148.441835698959;13694.93152534231;13741.381637826322;13779;13822.37799299014;13825.51610693621;6888.862222755517;7167.498275120692;7185.670650929595;7333;7391.186969433358;6711.966440167866;6743.35938085881;6847.554908930903;6855.108835851307;6930.549514281555;4238.533761286256;4353.563324103038;4406.162829062468;4447.555244475527;4452.844150454718;1672.5985763416693;1768.7877454705517;1818.3181307009872;1870.2518992402875;1893.6591413545418;875.2910142784365;885.2740752582949;911.4485736129678;915.2129168914728;983.8622592837008;16262.841055437448;16338.75491867623;16899.23953422099;17002.48992530226;17062;842.4608250719544;851.5231470376609;862.1163307609751;900.1358695652116;944.15498129174;9151.816963660689;9333.766655833522;9548.809023819485;9663.710088697351;9675.709728708009;399591;408362;411410;412475;412815;73035.80892573232;75126.24873751301;76505.2349476498;77264.22735772682;78876;870.664794054281;908.2234689340651;915.0757734688013;940.8917974433028;945.5225111318878;14933.626659333604;15021.924890375478;15090.471833485775;15128.773068403763;15356.308966096329;36432.81783591065;36434.27131457409;36996.44505332368;37225.6277437233;38718.41922371223;51497;52152.21771673504;53535.46464535461;55077.72461137829;57334;7578.810529736801;7668.5782281975025;7690.384769218561;7787.260210280015;7801.4929029612895;10993.560257589606;11683.474243658886;11689.123315751523;11799.587014454453;11909.52361905514;9959.203263738738;10132.645357412455;10467;10568.788624227625;10639.414832184304;9963.352382095141;10068.496575171066;10083.193344532567;10109.494525273854;10262.640807571699;10042.799144017225;10636.627718029831;10646.84029739539;10785.137189025016;10826.512806923865;7356.926430735624;7673.271039251262;7756.457048006585;7782.533048017137;7796.961015195115;8626.353023523387;9796.853047204155;9805.2646051545;10040.849387259343;10797.62208322705 23:14:19 INFO - PROCESS | 6518 | |3;mootools.html;1394.9860501394983;1408.5351234715895;1505.668752874368;1674.0625249860086;1679.9748003779937;6978.337057979496;7403.37071348936;7696.730614428496;8228.341732661387;8234.958825205873;7481;7691.384689224863;7821.100573434057;7869.685212591504;7883.132855385903;2191.9890400548015;2262.5814224368546;2262.6379779235326;2262.8416010879246;2269.500709843832;2165.263810304496;2201.3726088064905;2204.2836078274627;2211.9004644790944;2226.9888650556804;2205.184081889703;2225.4436390902274;2226.7995880370763;2262.1743063781682;2281.8859057047166;2140.2188201306412;2149.0436755643746;2160.157538559963;2161.6757486377014;2172;2132.8613640113344;2170.728658917635;2200.3948914048765;2201.570693714726;2205.151016858505;7946.801329966739;7970.282674559259;8001.19988001201;8013.599320033975;8016.879746803803;4650.953490465085;4747.406574178228;4782.689125206851;4785.282207668877;4798.208295631217;2960.3339248669095;3071.938561228785;3099.9535006974916;3109.160526657812;3110.1136176189902;1013.6198925402974;1015.7308313296909;1025.917926565873;1037.7768779712324;1046.9005444482762;10675.519601617869;10947.56209751609;10948.3978381189;10974.780504389868;10992.560297588087;4193.287141186006;4357.651387888961;4373.300271956472;4379.605835474823;4440.689151759346;9426.104520070583;9452.858207126761;9457.90542094584;9465.479398633004;9470.14768670823;4702.6708130431225;4724.173269677793;4728.432588089382;4740.478547359788;4741.644376671763;3813.3517302058717;4111.09555897702;4219.535851056443;4271.914561708749;4314.892127696833;3742.2702572998005;3769.962300377016;3818.0645741793437;3874.3219936511;3893.785841778673;1190.422645017166;1222.9571964981183;1243.4218088588668;1257.8490581130322;1274.1335891593806;730.3353947907378;864.5936409887343;866.1857853617579;886.4371124336093;886.6985225023394;5212.374515058217;5267.894642107136;5308.389535203424;5314.601404894648;5412.99859525989;421.21023081721773;426.9679774016961;427.27363482080585;431.9157764236007;434.3289617540907;3558.466230065511;3664.6152154023976;3692.8892133236045;3704.4258139988347;3717.683996860297;9828.852567211497;9989.950050249703;10059.446730429896;10140.543675534618;10191.184705223564;9938.652147174815;10016.39901605906;10025.348352357074;10026.799464010679;10049.69850904474;7365.15300740411;7490.85018299631;7549.320561149523;7567.243275672388;7592.316691497792;5438.673679579238;5578.163275508706;5633.746481408264;5670.404607516151;5678.602497825113;8691.304695624462;8977.147171018743;8999.37004409685;9168.862467063132;9174.67888623895;9008.414453060792;9120.087991200828;9191.448513089235;9539.284553658643;9563.378380405251;6018.879622407615;6712.664366781739;6772.695228714621;7116.750913717995;7520.623968801648;7334.633268336455;7491.850162996819;7537.283958023979;7554.433417493819;7602.049743782028;6579.769708060195;6614.305497922649;6667.799966001027;6687.364700353459;6771.424428923597;6617.933820661732;6624.906890363036;6637.469002479694;6651.46788256948;6659.733610655519;6561.934380656323;6573.3098024706715;6615.933840661532;6646.83382915431;6659.633720145439;4581.74800385982;4655.231886738786;4776.689515181502;4780.545848144421;4805.183118869731;4584.954150458453;4653.046125544188;4681.578657920803;4749.572538471554;4758.809647614056 23:14:19 INFO - PROCESS | 6518 | |4;prototype.html;282.26329280577704;290.69912640417164;295.8668599130392;296.8975703382332;296.9703029697032;4898.5101489850995;4993.201087825949;5073.771680274387;5163.561097306729;5183.537819535719;5043.798248070082;5062.190049592066;5064.366954130734;5065.290859279704;5078.111330517154;3941.231459865313;3948.709748345967;3953.0117470632413;3954.8022598870084;3980.800959951991;3871.55477120132;3946.881593552198;3977.1846771411792;3979.7214195006363;3986.103126796462;3881.234038512484;3899.863504777333;3902.843886244547;3911.393733971239;3915.7454765440298;3914.275858966072;3918.8236529356245;3920.4315374270855;3920.666743326821;3930.253251882133;3174.8888788892277;3324.933501329984;3351;3351.329734053199;3443.724502039856;4936.494369217387;4947.763059235192;4952;4970.353853998993;4980.825671101494;4383.786187975053;4423.225935461282;4426.667999900021;4430.29115341547;4440.4671439427475;5028.195488721787;5214.374275086976;5237.764300606482;5253.894922101536;5277.604179686539;3599.136207310227;3642.9271414571826;3649.124210189562;3653.598104208535;3663.285659296438;5434.266374039494;5525.171224316345;5525.314778992406;5561.691897862423;5582.720863956826;3635.7273204509765;3677.6138505457075;3775.8867233983024;3784.6593806557544;3786.091338078896;3742.214135031619;3758;3771.377722675728;3788.5453745550712;3816.4466152407745;4392.516823149451;4396.1867054595;4410.4927933287445;4410.779461026936;4414.668899832525;5344.518993290622;5349.545288650508;5356.196570514376;5368.651037682538;5370.087085195526;1180.6103985684704;1284.4797856867983;1302.160106731153;1302.6417735122727;1302.7199152182327;787.8857565652949;790.8971833661587;809.4576633655347;815.808285053012;817.8323443694028;4087.7138600297694;4100.794960252035;4140.730852494638;4157.230912281238;4166.312558427825;4874.927515946486;4882.951170488321;4883.413990321184;4887.144749668793;4902.705837649681;4104.979475102665;4135.60711732385;4161.9375709364385;4204.516480604709;4205.3481710334945;2484.080890070685;2569.6145578163423;2576.291519832061;2589.158523479839;2589.948201035969;4535.89081077294;4544.272916333371;4553.954460455419;4560.224761790503;4569.383133277031;4849.248366503198;4902.1176188285735;4903.798569350532;4910.263460480885;4921.3602231710365;4236.788160591958;4457.398251236042;4463.196624607602;4501.848705905879;4502.594766471033;4789.856304310876;4797.40032495938;4810.446798618063;4812.5668689818085;4827.758612069312;4635.884102897455;4684.344191813081;4684.953150468588;4688.367070445446;4718.669693121448;4237.618614324726;4474.194644963807;4497.572730590588;4508.977455112704;4593.563611456906;3385.610654774634;3395.6095049069672;3395.7962522248745;3473.166440054419;3487.2389443330953;4885.828995985124;4898.4121905371585;4900.95099049005;4924.679895806761;5247.55395791362;5141.845744627667;5244.187150991603;5264.89470210586;5265.973670131625;5276.208568714724;5240.423553409199;5262.868428289324;5387.784488620411;5390.353157621111;5401.702906340031;5096.719680417613;5180.662437216523;5208.609354298367;5215.504527069922;5251.501107394792;5361.5710743141235;5376.892462150657;5378.435264297193;5394.460553944574;5414.242006119068;5239.214117882349;5251.264822924717;5277.182036784305;5289;5303.5757139429525 23:14:19 INFO - PROCESS | 6518 | |5;yui.html;659.2352870670023;698.7624207769358;704.1655638068888;720.2761721897788;724.5073350121917;12000.339981301026;12868.806967895489;12901;12912.74174516509;12913.483460661573;12787.552435664731;12872.549460768874;12914.806277905815;12932.676683082927;12950.35248237589;602.7860109661073;745.7613563659631;764.3846703403772;770.4568279363064;778.875379939207;770.9344705700022;774.5120574038348;777.2577188784725;781.8084569280534;783.3967844759532;833.2584000239762;834.6452757578005;834.8580741273998;835.5822088955522;837.3677873205721;825.558326295432;827.8385714785619;828.6892415344246;829.1045670675655;830.0910502999207;600.2976517474565;601.1673831743067;601.9518438524907;601.9939800601982;603.7494439807475;12632.557860474839;12655.303958282291;12725.236485810881;12785.424655890507;12799.744005119845;13014.86985130146;13079.149855259378;13315.600531984055;13545.796813047813;13816;10283.588656453732;10443.738906527322;10452.477376131239;10521.631742889038;10617.991290827358;3311.7516186286125;3341.6992470677756;3386.0688310714504;3386.762926595139;3417.6069751978343;66666.99751368469;67486.66256668685;67608.6619566904;68286;68576.31423685749;10389.792204155874;10477.47612619366;10586.523606437575;10605.204609654307;10748.89251107479;20033.79966200319;20092.09585568653;20216.595668086557;20764.58470830575;20926.058327375304;6786.491013174032;6808.863822723617;6838.111045564145;6923.9653801730665;6941.757038503628;3562.2697347043795;3628.256207477461;3653.488511608377;3657.908552286214;3698.389765688685;2923.853807309626;3034.180771191766;3073;3074.7847650664685;3081.3991271702253;487.3883276487985;488.66526429395975;495.5267719328033;497.13498512587836;503.7506434314964;582.7698059266565;588.6732863260846;590.630855715178;590.7016956436972;633.4425705379236;6981.5461994970165;7368;7442.590657513889;7696.769096927102;7773.727919522789;522.2062465053098;540.5027374815179;541.7941182350681;552.4282367749361;578.9160571717077;3728.3848165052464;3775.1505911169766;3835.4055121456217;3886.436466712311;3900.1419687668667;57975.680972760616;85782;88026.11973880307;88382;90069;48129.278060829114;59378.703106484194;76075;76266.61866690632;76275.61862190765;45455;71182;72233.63883180551;73625;73777;8005.799855003672;8268.751937441886;8333.374996875138;8358.832823343377;8497.235248827388;37879.43180852345;42317.576824231364;42446;42756.78621606872;43538;40866.182676345714;51534.74232628813;51678.48321516737;59028;62682;10766.354018758899;10775.568977240822;10915.235933484897;11085.556577737123;11366.943165284121;12592.622221333375;12850.164739291917;13250.138740981805;13608.727825443633;13652.316098027733;11626.476808543805;11733.823992640288;12034.939825300817;12132.122574420628;12324.198927069712;11389.259698119597;11521.942390287995;11766.352850592957;12178.208416452902;12298.20061695987;11241.325520468798;11398.886011140114;11806.881931180578;11834.053275737748;11854.881451185724;9564.904350956402;9604.903950960681;9807.754806129904;9833.213342932691;10207.54066067014;9535.952320238355;9782.75543111428;9819.9018009819;9823.459709716035;9995.800083998425 23:14:19 INFO - PROCESS | 6518 | __end_tp_report 23:14:19 INFO - PROCESS | 6518 | __start_cc_report 23:14:19 INFO - PROCESS | 6518 | _x_x_mozilla_cycle_collect,399 23:14:19 INFO - PROCESS | 6518 | __end_cc_report 23:14:19 INFO - PROCESS | 6518 | __startTimestamp1465971259787__endTimestamp 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | ------- Summary: start ------- 23:14:19 INFO - PROCESS | 6518 | Number of tests: 6 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#0] dojo.html Cycles:165 Average:4792.28 Median:4940.41 stddev:519.91 (10.5%) stddev-sans-first:492.66 23:14:19 INFO - PROCESS | 6518 | Values: 2615.3 2686.0 2699.4 2703.5 2706.8 4788.3 4791.5 4837.1 4846.2 4935.2 4624.2 4782.1 4851.6 4868.3 4894.0 4367.4 4382.2 4463.3 4494.3 4495.6 4185.0 4487.4 4513.5 4561.1 4561.5 4336.6 4361.1 4367.4 4394.2 4435.9 4347.9 4359.6 4414.4 4417.6 4430.3 4389.8 4398.9 4400.0 4405.4 4463.3 4744.9 4823.5 4840.6 4859.1 4863.0 5180.6 5193.6 5195.4 5201.9 5261.0 5060.3 5234.1 5242.5 5254.2 5262.6 4901.0 4924.6 4939.8 4941.4 4954.8 5441.0 5448.8 5458.7 5467.0 5494.8 4940.5 5030.6 5077.7 5186.1 5187.0 4982.6 5165.0 5185.3 5206.4 5235.5 5070.7 5099.6 5135.8 5153.1 5163.3 4972.3 5101.5 5119.0 5150.0 5184.2 4396.5 4418.9 4420.2 4453.0 4470.1 3797.5 3811.9 3830.1 3833.7 3874.7 4298.1 4413.5 4462.1 4515.3 4523.5 5199.3 5245.1 5247.8 5261.3 5286.2 4439.3 4468.1 4486.4 4518.8 4527.5 4500.4 4643.6 4659.9 4662.1 4690.8 4931.6 4940.4 4958.8 4962.0 5005.5 5257.1 5273.5 5292.8 5295.6 5298.9 4752.8 4845.8 4864.9 4871.6 4873.1 5079.0 5112.2 5120.5 5137.3 5195.1 4991.1 5212.5 5262.2 5265.1 5266.7 4820.3 4976.6 5035.3 5100.1 5126.8 5002.3 5044.6 5057.3 5068.4 5081.6 4934.5 4957.7 4967.8 4991.6 5033.7 4925.4 5065.6 5123.4 5128.9 5129.7 4989.5 5025.8 5030.2 5040.6 5048.8 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#1] ext.html Cycles:180 Average:48700.54 Median:37349.63 stddev:90835.15 (243.2%) stddev-sans-first:91018.02 23:14:19 INFO - PROCESS | 6518 | Values: 548.8 571.4 576.1 588.3 610.5 34181.0 38022.4 38103.2 38196.0 38196.2 38143.4 38611.0 38620.8 38661.0 38732.4 7806.2 7952.2 7974.5 7994.0 7998.1 7771.5 7844.5 7905.9 7916.3 7927.4 7928.0 7942.6 7953.2 7953.7 7953.7 7820.5 7847.0 7866.2 7878.8 7929.0 7726.7 7783.0 7831.6 7862.1 7878.8 29523.7 36859.4 37313.0 37429.8 37489.8 3094.3 3147.6 3245.8 3669.1 3767.4 27805.4 28030.7 28294.7 30798.7 31063.4 3409.2 3526.1 3556.8 3560.3 3724.9 248251.0 253498.0 254801.0 255557.0 255972.7 57510.4 58099.0 58579.7 58630.0 58669.0 33316.8 33988.7 34054.7 36300.3 36373.1 13493.0 13552.5 13594.0 13596.5 13627.0 10601.2 10660.7 10723.4 10735.7 10808.2 18990.7 18991.6 19000.0 19270.5 19462.7 7300.9 7473.4 7697.6 7703.2 7734.8 837.5 887.1 899.5 930.3 976.6 28263.6 28593.4 28700.0 29107.0 29256.0 938.5 974.7 1020.9 1044.6 1093.3 14804.3 15085.5 15247.0 15316.9 15595.8 412726.0 412765.0 424424.0 424489.0 425198.0 50327.5 50730.5 50777.5 50985.0 51027.2 1164.4 1185.7 1205.4 1206.2 1214.8 26716.6 26980.2 28139.0 28359.3 28623.6 43503.8 43814.6 43897.0 43933.3 44112.8 334907.0 337546.0 339226.0 340023.0 340365.0 25905.7 25928.0 26300.5 26414.7 26632.0 43005.6 43574.3 43817.0 43930.8 44064.6 36439.8 37909.0 37955.0 38358.2 38719.4 35784.0 38016.6 38194.6 40405.2 40495.0 35924.6 36661.6 37007.3 37386.3 39429.8 28485.0 31425.5 31742.0 32035.8 32112.5 24894.9 24915.6 25008.5 25131.0 25402.9 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#2] jquery.html Cycles:180 Average:24815.84 Median:28270.47 stddev:67375.25 (238.3%) stddev-sans-first:67539.25 23:14:19 INFO - PROCESS | 6518 | Values: 368.4 371.0 372.4 381.7 381.9 16045.9 16762.7 16853.4 16989.8 17142.7 16105.7 16765.0 17462.6 17476.5 17562.9 5016.2 5169.6 5200.2 5201.5 5207.1 3702.9 5043.9 5704.7 6014.9 6020.1 6045.9 6049.0 6057.7 6083.6 6093.5 6012.0 6086.0 6096.4 6104.4 6110.8 5314.2 5348.7 5363.2 5364.4 5385.7 17825.5 18987.4 20096.6 20513.6 20642.5 1879.6 2186.9 2252.5 2319.1 2322.0 8841.0 8901.0 8982.6 9045.1 9200.7 1654.7 1677.0 1697.0 1734.3 1751.1 64854.7 66200.3 66687.0 67681.7 67954.7 9821.0 9976.1 10104.9 10119.2 10148.4 13694.9 13741.4 13779.0 13822.4 13825.5 6888.9 7167.5 7185.7 7333.0 7391.2 6712.0 6743.4 6847.6 6855.1 6930.5 4238.5 4353.6 4406.2 4447.6 4452.8 1672.6 1768.8 1818.3 1870.3 1893.7 875.3 885.3 911.4 915.2 983.9 16262.8 16338.8 16899.2 17002.5 17062.0 842.5 851.5 862.1 900.1 944.2 9151.8 9333.8 9548.8 9663.7 9675.7 399591.0 408362.0 411410.0 412475.0 412815.0 73035.8 75126.2 76505.2 77264.2 78876.0 870.7 908.2 915.1 940.9 945.5 14933.6 15021.9 15090.5 15128.8 15356.3 36432.8 36434.3 36996.4 37225.6 38718.4 51497.0 52152.2 53535.5 55077.7 57334.0 7578.8 7668.6 7690.4 7787.3 7801.5 10993.6 11683.5 11689.1 11799.6 11909.5 9959.2 10132.6 10467.0 10568.8 10639.4 9963.4 10068.5 10083.2 10109.5 10262.6 10042.8 10636.6 10646.8 10785.1 10826.5 7356.9 7673.3 7756.5 7782.5 7797.0 8626.4 9796.9 9805.3 10040.8 10797.6 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#3] mootools.html Cycles:180 Average:5245.98 Median:4734.46 stddev:2961.44 (62.6%) stddev-sans-first:2955.61 23:14:19 INFO - PROCESS | 6518 | Values: 1395.0 1408.5 1505.7 1674.1 1680.0 6978.3 7403.4 7696.7 8228.3 8235.0 7481.0 7691.4 7821.1 7869.7 7883.1 2192.0 2262.6 2262.6 2262.8 2269.5 2165.3 2201.4 2204.3 2211.9 2227.0 2205.2 2225.4 2226.8 2262.2 2281.9 2140.2 2149.0 2160.2 2161.7 2172.0 2132.9 2170.7 2200.4 2201.6 2205.2 7946.8 7970.3 8001.2 8013.6 8016.9 4651.0 4747.4 4782.7 4785.3 4798.2 2960.3 3071.9 3100.0 3109.2 3110.1 1013.6 1015.7 1025.9 1037.8 1046.9 10675.5 10947.6 10948.4 10974.8 10992.6 4193.3 4357.7 4373.3 4379.6 4440.7 9426.1 9452.9 9457.9 9465.5 9470.1 4702.7 4724.2 4728.4 4740.5 4741.6 3813.4 4111.1 4219.5 4271.9 4314.9 3742.3 3770.0 3818.1 3874.3 3893.8 1190.4 1223.0 1243.4 1257.8 1274.1 730.3 864.6 866.2 886.4 886.7 5212.4 5267.9 5308.4 5314.6 5413.0 421.2 427.0 427.3 431.9 434.3 3558.5 3664.6 3692.9 3704.4 3717.7 9828.9 9990.0 10059.4 10140.5 10191.2 9938.7 10016.4 10025.3 10026.8 10049.7 7365.2 7490.9 7549.3 7567.2 7592.3 5438.7 5578.2 5633.7 5670.4 5678.6 8691.3 8977.1 8999.4 9168.9 9174.7 9008.4 9120.1 9191.4 9539.3 9563.4 6018.9 6712.7 6772.7 7116.8 7520.6 7334.6 7491.9 7537.3 7554.4 7602.0 6579.8 6614.3 6667.8 6687.4 6771.4 6617.9 6624.9 6637.5 6651.5 6659.7 6561.9 6573.3 6615.9 6646.8 6659.6 4581.7 4655.2 4776.7 4780.5 4805.2 4585.0 4653.0 4681.6 4749.6 4758.8 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#4] prototype.html Cycles:180 Average:4193.70 Median:4549.11 stddev:1240.21 (27.3%) stddev-sans-first:1208.44 23:14:19 INFO - PROCESS | 6518 | Values: 282.3 290.7 295.9 296.9 297.0 4898.5 4993.2 5073.8 5163.6 5183.5 5043.8 5062.2 5064.4 5065.3 5078.1 3941.2 3948.7 3953.0 3954.8 3980.8 3871.6 3946.9 3977.2 3979.7 3986.1 3881.2 3899.9 3902.8 3911.4 3915.7 3914.3 3918.8 3920.4 3920.7 3930.3 3174.9 3324.9 3351.0 3351.3 3443.7 4936.5 4947.8 4952.0 4970.4 4980.8 4383.8 4423.2 4426.7 4430.3 4440.5 5028.2 5214.4 5237.8 5253.9 5277.6 3599.1 3642.9 3649.1 3653.6 3663.3 5434.3 5525.2 5525.3 5561.7 5582.7 3635.7 3677.6 3775.9 3784.7 3786.1 3742.2 3758.0 3771.4 3788.5 3816.4 4392.5 4396.2 4410.5 4410.8 4414.7 5344.5 5349.5 5356.2 5368.7 5370.1 1180.6 1284.5 1302.2 1302.6 1302.7 787.9 790.9 809.5 815.8 817.8 4087.7 4100.8 4140.7 4157.2 4166.3 4874.9 4883.0 4883.4 4887.1 4902.7 4105.0 4135.6 4161.9 4204.5 4205.3 2484.1 2569.6 2576.3 2589.2 2589.9 4535.9 4544.3 4554.0 4560.2 4569.4 4849.2 4902.1 4903.8 4910.3 4921.4 4236.8 4457.4 4463.2 4501.8 4502.6 4789.9 4797.4 4810.4 4812.6 4827.8 4635.9 4684.3 4685.0 4688.4 4718.7 4237.6 4474.2 4497.6 4509.0 4593.6 3385.6 3395.6 3395.8 3473.2 3487.2 4885.8 4898.4 4901.0 4924.7 5247.6 5141.8 5244.2 5264.9 5266.0 5276.2 5240.4 5262.9 5387.8 5390.4 5401.7 5096.7 5180.7 5208.6 5215.5 5251.5 5361.6 5376.9 5378.4 5394.5 5414.2 5239.2 5251.3 5277.2 5289.0 5303.6 23:14:19 INFO - PROCESS | 6518 | 23:14:19 INFO - PROCESS | 6518 | [#5] yui.html Cycles:180 Average:16502.84 Median:492.10 stddev:22438.52 (4559.8%) stddev-sans-first:22469.93 23:14:19 INFO - PROCESS | 6518 | Values: 659.2 698.8 704.2 720.3 724.5 12000.3 12868.8 12901.0 12912.7 12913.5 12787.6 12872.5 12914.8 12932.7 12950.4 602.8 745.8 764.4 770.5 778.9 770.9 774.5 777.3 781.8 783.4 833.3 834.6 834.9 835.6 837.4 825.6 827.8 828.7 829.1 830.1 600.3 601.2 602.0 602.0 603.7 12632.6 12655.3 12725.2 12785.4 12799.7 13014.9 13079.1 13315.6 13545.8 13816.0 10283.6 10443.7 10452.5 10521.6 10618.0 3311.8 3341.7 3386.1 3386.8 3417.6 66667.0 67486.7 67608.7 68286.0 68576.3 10389.8 10477.5 10586.5 10605.2 10748.9 20033.8 20092.1 20216.6 20764.6 20926.1 6786.5 6808.9 6838.1 6924.0 6941.8 3562.3 3628.3 3653.5 3657.9 3698.4 2923.9 3034.2 3073.0 3074.8 3081.4 487.4 488.7 495.5 497.1 503.8 582.8 588.7 590.6 590.7 633.4 6981.5 7368.0 7442.6 7696.8 7773.7 522.2 540.5 541.8 552.4 578.9 3728.4 3775.2 3835.4 3886.4 3900.1 57975.7 85782.0 88026.1 88382.0 90069.0 48129.3 59378.7 76075.0 76266.6 76275.6 45455.0 71182.0 72233.6 73625.0 73777.0 8005.8 8268.8 8333.4 8358.8 8497.2 37879.4 42317.6 42446.0 42756.8 43538.0 40866.2 51534.7 51678.5 59028.0 62682.0 10766.4 10775.6 10915.2 11085.6 11366.9 12592.6 12850.2 13250.1 13608.7 13652.3 11626.5 11733.8 12034.9 12132.1 12324.2 11389.3 11521.9 11766.4 12178.2 12298.2 11241.3 11398.9 11806.9 11834.1 11854.9 9564.9 9604.9 9807.8 9833.2 10207.5 9536.0 9782.8 9819.9 9823.5 9995.8 23:14:19 INFO - PROCESS | 6518 | -------- Summary: end -------- 23:14:19 INFO - PROCESS | 6518 | 23:14:20 INFO - TEST-INFO | 6518: exit 0 23:14:20 INFO - TEST-OK | dromaeo_css | took 1117684ms 23:14:20 INFO - TEST-START | kraken 23:14:20 INFO - operating with platform_type : linux_ 23:14:20 INFO - Initialising browser for kraken test... 23:14:20 INFO - TEST-INFO | started process 6756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkBQt9G/profile http://localhost:56515/getInfo.html) 23:14:25 INFO - PROCESS | 6756 | __metrics Screen width/height:1600/1200 23:14:25 INFO - PROCESS | 6756 | colorDepth:24 23:14:25 INFO - PROCESS | 6756 | Browser inner width/height: 1024/697 23:14:25 INFO - PROCESS | 6756 | __metrics 23:14:26 ERROR - PROCESS | 6756 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:14:27 INFO - TEST-INFO | 6756: exit 0 23:14:27 INFO - Browser initialized. 23:14:27 INFO - Running cycle 1/1 for kraken test... 23:14:27 INFO - TEST-INFO | started process 6874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkBQt9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:39 INFO - PROCESS | 6874 | RSS: Main: 185638912 23:14:39 INFO - PROCESS | 6874 | 23:14:42 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56515/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:43 INFO - PROCESS | 6874 | RSS: Main: 190238720 23:14:43 INFO - PROCESS | 6874 | 23:14:46 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56515/tests/kraken/driver.html?testName=audio-dft) 23:14:46 INFO - PROCESS | 6874 | RSS: Main: 190664704 23:14:46 INFO - PROCESS | 6874 | 23:14:49 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56515/tests/kraken/driver.html?testName=audio-fft) 23:14:50 INFO - PROCESS | 6874 | RSS: Main: 186118144 23:14:50 INFO - PROCESS | 6874 | 23:14:52 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56515/tests/kraken/driver.html?testName=audio-oscillator) 23:14:53 INFO - PROCESS | 6874 | RSS: Main: 186613760 23:14:53 INFO - PROCESS | 6874 | 23:14:55 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:55 INFO - PROCESS | 6874 | RSS: Main: 187269120 23:14:55 INFO - PROCESS | 6874 | 23:14:59 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56515/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:59 INFO - PROCESS | 6874 | RSS: Main: 187326464 23:14:59 INFO - PROCESS | 6874 | 23:15:03 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56515/tests/kraken/driver.html?testName=imaging-desaturate) 23:15:04 INFO - PROCESS | 6874 | RSS: Main: 184442880 23:15:04 INFO - PROCESS | 6874 | 23:15:06 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56515/tests/kraken/driver.html?testName=json-parse-financial) 23:15:07 INFO - PROCESS | 6874 | RSS: Main: 185622528 23:15:07 INFO - PROCESS | 6874 | 23:15:09 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:15:09 INFO - PROCESS | 6874 | RSS: Main: 186073088 23:15:09 INFO - PROCESS | 6874 | 23:15:11 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:15:12 INFO - PROCESS | 6874 | RSS: Main: 186675200 23:15:12 INFO - PROCESS | 6874 | 23:15:14 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:15:15 INFO - PROCESS | 6874 | RSS: Main: 186949632 23:15:15 INFO - PROCESS | 6874 | 23:15:18 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:15:18 INFO - PROCESS | 6874 | RSS: Main: 187219968 23:15:18 INFO - PROCESS | 6874 | 23:15:21 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:22 INFO - PROCESS | 6874 | RSS: Main: 186540032 23:15:22 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | Cycle 1(1): loaded http://localhost:56515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56515/tests/kraken/driver.html?testName=ai-astar) 23:15:24 INFO - PROCESS | 6874 | RSS: Main: 187916288 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | __start_tp_report 23:15:24 INFO - PROCESS | 6874 | _x_x_mozilla_page_load 23:15:24 INFO - PROCESS | 6874 | _x_x_mozilla_page_load_details 23:15:24 INFO - PROCESS | 6874 | |i|pagename|runs| 23:15:24 INFO - PROCESS | 6874 | |0;ai-astar;113;108;112;118;115;115;112;113;113;114 23:15:24 INFO - PROCESS | 6874 | |1;audio-beat-detection;161;131;155;179;135;163;156;151;194;133 23:15:24 INFO - PROCESS | 6874 | |2;audio-dft;164;167;178;165;165;163;163;163;163;166 23:15:24 INFO - PROCESS | 6874 | |3;audio-fft;76;76;77;160;77;76;77;77;171;76 23:15:24 INFO - PROCESS | 6874 | |4;audio-oscillator;87;86;144;86;87;86;144;85;85;143 23:15:24 INFO - PROCESS | 6874 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;117;118;119 23:15:24 INFO - PROCESS | 6874 | |6;imaging-darkroom;149;148;148;148;147;147;148;147;151;147 23:15:24 INFO - PROCESS | 6874 | |7;imaging-desaturate;95;96;95;96;95;96;95;97;95;100 23:15:24 INFO - PROCESS | 6874 | |8;json-parse-financial;63;65;64;69;64;63;64;64;64;63 23:15:24 INFO - PROCESS | 6874 | |9;json-stringify-tinderbox;66;65;66;65;66;65;67;65;65;65 23:15:24 INFO - PROCESS | 6874 | |10;stanford-crypto-aes;83;83;83;85;92;85;86;87;107;92 23:15:24 INFO - PROCESS | 6874 | |11;stanford-crypto-ccm;135;133;138;136;131;137;132;151;137;135 23:15:24 INFO - PROCESS | 6874 | |12;stanford-crypto-pbkdf2;172;169;172;168;172;169;169;173;170;170 23:15:24 INFO - PROCESS | 6874 | |13;stanford-crypto-sha256-iterative;76;69;74;68;69;71;68;69;67;66 23:15:24 INFO - PROCESS | 6874 | __end_tp_report 23:15:24 INFO - PROCESS | 6874 | __start_cc_report 23:15:24 INFO - PROCESS | 6874 | _x_x_mozilla_cycle_collect,990 23:15:24 INFO - PROCESS | 6874 | __end_cc_report 23:15:24 INFO - PROCESS | 6874 | __startTimestamp1465971324410__endTimestamp 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | ------- Summary: start ------- 23:15:24 INFO - PROCESS | 6874 | Number of tests: 14 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:2.58 (2.3%) stddev-sans-first:2.74 23:15:24 INFO - PROCESS | 6874 | Values: 113.0 108.0 112.0 118.0 115.0 115.0 112.0 113.0 113.0 114.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:158.50 stddev:20.19 (12.7%) stddev-sans-first:21.32 23:15:24 INFO - PROCESS | 6874 | Values: 161.0 131.0 155.0 179.0 135.0 163.0 156.0 151.0 194.0 133.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:4.55 (2.8%) stddev-sans-first:4.78 23:15:24 INFO - PROCESS | 6874 | Values: 164.0 167.0 178.0 165.0 165.0 163.0 163.0 163.0 163.0 166.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:37.62 (49.2%) stddev-sans-first:39.31 23:15:24 INFO - PROCESS | 6874 | Values: 76.0 76.0 77.0 160.0 77.0 76.0 77.0 77.0 171.0 76.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:27.86 (32.4%) stddev-sans-first:28.92 23:15:24 INFO - PROCESS | 6874 | Values: 87.0 86.0 144.0 86.0 87.0 86.0 144.0 85.0 85.0 143.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:15:24 INFO - PROCESS | 6874 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 119.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 23:15:24 INFO - PROCESS | 6874 | Values: 149.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 151.0 147.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.56 (1.6%) stddev-sans-first:1.62 23:15:24 INFO - PROCESS | 6874 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 97.0 95.0 100.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:1.77 (2.8%) stddev-sans-first:1.81 23:15:24 INFO - PROCESS | 6874 | Values: 63.0 65.0 64.0 69.0 64.0 63.0 64.0 64.0 64.0 63.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 23:15:24 INFO - PROCESS | 6874 | Values: 66.0 65.0 66.0 65.0 66.0 65.0 67.0 65.0 65.0 65.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:85.50 stddev:7.38 (8.6%) stddev-sans-first:7.57 23:15:24 INFO - PROCESS | 6874 | Values: 83.0 83.0 83.0 85.0 92.0 85.0 86.0 87.0 107.0 92.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:136.50 stddev:5.58 (4.1%) stddev-sans-first:5.89 23:15:24 INFO - PROCESS | 6874 | Values: 135.0 133.0 138.0 136.0 131.0 137.0 132.0 151.0 137.0 135.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:1.71 (1.0%) stddev-sans-first:1.72 23:15:24 INFO - PROCESS | 6874 | Values: 172.0 169.0 172.0 168.0 172.0 169.0 169.0 173.0 170.0 170.0 23:15:24 INFO - PROCESS | 6874 | 23:15:24 INFO - PROCESS | 6874 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:3.13 (4.5%) stddev-sans-first:2.35 23:15:24 INFO - PROCESS | 6874 | Values: 76.0 69.0 74.0 68.0 69.0 71.0 68.0 69.0 67.0 66.0 23:15:24 INFO - PROCESS | 6874 | -------- Summary: end -------- 23:15:24 INFO - PROCESS | 6874 | 23:15:25 INFO - TEST-INFO | 6874: exit 0 23:15:25 INFO - TEST-OK | kraken | took 65074ms 23:15:25 INFO - SUITE-END | took 1182s 23:15:26 INFO - Completed test suite (00:19:43) 23:15:26 INFO - javascript benchmark 23:15:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6429.100848339371, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.3330900620344, 2686.0, 2699.3521554826834, 2703.5133675938323, 2706.8375897446144, 4788.329633851259, 4791.520847915211, 4837.105135549921, 4846.248831431125, 4935.161022626153, 4624.213883639781, 4782.1153086678905, 4851.587615052716, 4868.342773725546, 4894.0, 4367.366731823891, 4382.189294980423, 4463.330500424946, 4494.258447356182, 4495.617872480843, 4185.0, 4487.371767952489, 4513.526079761627, 4561.087782443525, 4561.543845615445, 4336.588024137702, 4361.149575832714, 4367.432233809616, 4394.1870753910625, 4435.866923992269, 4347.891302717426, 4359.585839345257, 4414.448193975753, 4417.558244175557, 4430.313301438282, 4389.758563279019, 4398.912021759547, 4399.978000110011, 4405.405270288502, 4463.285874260103, 4744.928826067612, 4823.493533179036, 4840.564349208553, 4859.07677541266, 4863.0, 5180.611454140954, 5193.63644544882, 5195.376554813447, 5201.921971170435, 5261.0, 5060.266261392115, 5234.136367499358, 5242.475752424765, 5254.185601231815, 5262.578993680535, 4901.0, 4924.556789888928, 4939.802407903644, 4941.382327209099, 4954.826581069645, 5440.972795136078, 5448.8365349038795, 5458.727063646802, 5467.0, 5494.80768173112, 4940.456549779521, 5030.572401345853, 5077.669951453144, 5186.066508028515, 5187.04039752647, 4982.60139188864, 5165.044466773659, 5185.325907631984, 5206.427292997767, 5235.502627250406, 5070.721110338893, 5099.617528685363, 5135.820246291362, 5153.072446959508, 5163.277141200235, 4972.254161875748, 5101.51535604117, 5119.0273847968765, 5150.047241260304, 5184.170532714747, 4396.472423309224, 4418.867433976986, 4420.248557745191, 4453.020335526179, 4470.083632855257, 3797.468354430382, 3811.866584669523, 3830.0999265172663, 3833.674137698271, 3874.728768986144, 4298.140371925628, 4413.470383553929, 4462.129884672458, 4515.345274935116, 4523.5024147343765, 5199.272101905736, 5245.0558899398475, 5247.790088396498, 5261.342332208474, 5286.233496143038, 4439.263925400513, 4468.106378724268, 4486.394336764561, 4518.751468669255, 4527.479339875957, 4500.414946057057, 4643.605293550018, 4659.906801863944, 4662.114198302312, 4690.7654617269, 4931.556159945622, 4940.407151141814, 4958.752062396938, 4961.975190124026, 5005.524475174852, 5257.053730328577, 5273.525382715574, 5292.788288468418, 5295.576353891603, 5298.920516192337, 4752.809887604457, 4845.830395936126, 4864.902701946012, 4871.561559459666, 4873.074115918106, 5078.97460512695, 5112.207607820794, 5120.539151476385, 5137.33214682089, 5195.064888319987, 4991.101601711727, 5212.478752124757, 5262.184361423985, 5265.1049321614655, 5266.73666316675, 4820.301056346881, 4976.601871850316, 5035.320231768811, 5100.081985242692, 5126.846194614168, 5002.299678045004, 5044.571211447068, 5057.291979122852, 5068.417132029864, 5081.593472522115, 4934.481879402611, 4957.702537847741, 4967.7516124192925, 4991.625628077836, 5033.723145227048, 4925.38432695913, 5065.594752419724, 5123.359580052494, 5128.948710512847, 5129.743512824419, 4989.476105009067, 5025.7989680412375, 5030.170021946485, 5040.571551418024, 5048.848534543969], "value": 4758.263488052742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.8238154007256, 571.3857603076692, 576.084026398027, 588.2558563417277, 610.490240649058, 34180.99999999997, 38022.42966355507, 38103.237935241275, 38196.0, 38196.236075278546, 38143.42784858222, 38611.0, 38620.80689596555, 38661.0, 38732.41901371482, 7806.219378062206, 7952.165022672622, 7974.481658692166, 7993.960030199841, 7998.080220774627, 7771.533707977511, 7844.490108142981, 7905.881411778828, 7916.287534121928, 7927.445078844483, 7928.048634163908, 7942.6425810838655, 7953.164917683646, 7953.72161974331, 7953.72161974331, 7820.45256832022, 7846.960765196166, 7866.174051724573, 7878.80302992424, 7928.960355198187, 7726.729564465217, 7782.9610851945945, 7831.6475758591005, 7862.095858976234, 7878.842423151562, 29523.70476295231, 36859.447108293396, 37313.0, 37429.812850935574, 37489.81255093707, 3094.2883136878418, 3147.6380216275193, 3245.837708114585, 3669.101070237782, 3767.4160505121476, 27805.443891122268, 28030.719692803013, 28294.717052829415, 30798.69201308003, 31063.378732425226, 3409.2499650077193, 3526.0832183632183, 3556.822158892045, 3560.2523470071314, 3724.9068773280883, 248251.0, 253498.0, 254801.0, 255557.0, 255972.7201364, 57510.42489575134, 58099.0, 58579.70710146422, 58630.0, 58669.0, 33316.834405764035, 33988.660113398546, 34054.65945340564, 36300.273994519965, 36373.09067273286, 13493.0, 13552.45790168402, 13594.048416610742, 13596.456141754417, 13627.0, 10601.204909631808, 10660.733481662865, 10723.356598604109, 10735.677929662123, 10808.189385796097, 18990.71513927292, 18991.620167596848, 19000.0, 19270.518237044187, 19462.70805937912, 7300.926990730131, 7473.364763995121, 7697.615119244016, 7703.1911649277135, 7734.806629834186, 837.4891316297054, 887.1040249348205, 899.4827973914894, 930.2883294279882, 976.5605477535138, 28263.57604635932, 28593.428131437257, 28700.0, 29107.0, 29256.0, 938.4838338913706, 974.6832279509188, 1020.9489525523694, 1044.639599338227, 1093.316677076827, 14804.333804978802, 15085.54743357701, 15247.0, 15316.923415382851, 15595.766063509056, 412726.0, 412765.0, 424424.0, 424489.0, 425198.0, 50327.496725033016, 50730.49269507331, 50777.492225078015, 50985.0, 51027.23459148042, 1164.4352489042808, 1185.7450648110698, 1205.4153735438306, 1206.2340413837276, 1214.8117041858527, 26716.599251011638, 26980.1905942822, 28139.0, 28359.29101772472, 28623.570646439905, 43503.78248108739, 43814.56185438105, 43897.0, 43933.340999884385, 44112.77943610262, 334907.0, 337546.0, 339226.0, 340023.0, 340365.0, 25905.74094259033, 25928.0, 26300.501452361994, 26414.735852641228, 26632.002599804706, 43005.56994430141, 43574.346384804885, 43817.0, 43930.780346098065, 44064.55935440733, 36439.81780091082, 37909.0, 37955.0, 38358.2328353437, 38719.419208711326, 35784.0, 38016.619833801306, 38194.618053819104, 40405.19189616133, 40495.0, 35924.64075359213, 36661.63338366582, 37007.25985480329, 37386.252274954895, 39429.802850985565, 28485.0, 31425.52861707122, 31742.0, 32035.839820800746, 32112.518312225802, 24894.875525622258, 24915.626265606392, 25008.499830002933, 25131.0, 25402.872985634953], "value": 17620.460365312083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3958308374266, 370.9758865673732, 372.4487758117987, 381.74613881768624, 381.92934307153195, 16045.919770401146, 16762.748558771615, 16853.41013064543, 16989.830101698994, 17142.742858857095, 16105.677886442265, 16765.0, 17462.563435914075, 17476.475705728815, 17562.912185439054, 5016.172331565287, 5169.638125331228, 5200.193969934666, 5201.505856943584, 5207.114790485626, 3702.9259414811686, 5043.949560504403, 5704.71476426177, 6014.939850601503, 6020.066889632114, 6045.939540604603, 6049.0, 6057.666828324441, 6083.604565703237, 6093.451589356957, 6012.038073908176, 6086.0, 6096.35988221237, 6104.3590423005835, 6110.847228819271, 5314.202869569557, 5348.705821179834, 5363.195520671891, 5364.436734142937, 5385.7307134643115, 17825.46523604294, 18987.43037708871, 20096.59806803856, 20513.589728205352, 20642.48393790152, 1879.5864909719976, 2186.9125234990584, 2252.4931890324547, 2319.095552734435, 2321.976780232193, 8841.027486976427, 8901.0, 8982.550872456351, 9045.095490450967, 9200.677976270865, 1654.7352423612165, 1676.9916150419292, 1697.0496521947748, 1734.314945596495, 1751.098184435017, 64854.675726621535, 66200.3379966199, 66687.0, 67681.66159169222, 67954.66022669854, 9821.0, 9976.102150806462, 10104.898951010542, 10119.190464762802, 10148.441835698959, 13694.93152534231, 13741.381637826322, 13779.0, 13822.37799299014, 13825.51610693621, 6888.862222755517, 7167.498275120692, 7185.670650929595, 7333.0, 7391.186969433358, 6711.966440167866, 6743.35938085881, 6847.554908930903, 6855.108835851307, 6930.549514281555, 4238.533761286256, 4353.563324103038, 4406.162829062468, 4447.555244475527, 4452.844150454718, 1672.5985763416693, 1768.7877454705517, 1818.3181307009872, 1870.2518992402875, 1893.6591413545418, 875.2910142784365, 885.2740752582949, 911.4485736129678, 915.2129168914728, 983.8622592837008, 16262.841055437448, 16338.75491867623, 16899.23953422099, 17002.48992530226, 17062.0, 842.4608250719544, 851.5231470376609, 862.1163307609751, 900.1358695652116, 944.15498129174, 9151.816963660689, 9333.766655833522, 9548.809023819485, 9663.710088697351, 9675.709728708009, 399591.0, 408362.0, 411410.0, 412475.0, 412815.0, 73035.80892573232, 75126.24873751301, 76505.2349476498, 77264.22735772682, 78876.0, 870.664794054281, 908.2234689340651, 915.0757734688013, 940.8917974433028, 945.5225111318878, 14933.626659333604, 15021.924890375478, 15090.471833485775, 15128.773068403763, 15356.308966096329, 36432.81783591065, 36434.27131457409, 36996.44505332368, 37225.6277437233, 38718.41922371223, 51497.0, 52152.21771673504, 53535.46464535461, 55077.72461137829, 57334.0, 7578.810529736801, 7668.5782281975025, 7690.384769218561, 7787.260210280015, 7801.4929029612895, 10993.560257589606, 11683.474243658886, 11689.123315751523, 11799.587014454453, 11909.52361905514, 9959.203263738738, 10132.645357412455, 10467.0, 10568.788624227625, 10639.414832184304, 9963.352382095141, 10068.496575171066, 10083.193344532567, 10109.494525273854, 10262.640807571699, 10042.799144017225, 10636.627718029831, 10646.84029739539, 10785.137189025016, 10826.512806923865, 7356.926430735624, 7673.271039251262, 7756.457048006585, 7782.533048017137, 7796.961015195115, 8626.353023523387, 9796.853047204155, 9805.2646051545, 10040.849387259343, 10797.62208322705], "value": 8281.192553486466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.9860501394983, 1408.5351234715895, 1505.668752874368, 1674.0625249860086, 1679.9748003779937, 6978.337057979496, 7403.37071348936, 7696.730614428496, 8228.341732661387, 8234.958825205873, 7481.0, 7691.384689224863, 7821.100573434057, 7869.685212591504, 7883.132855385903, 2191.9890400548015, 2262.5814224368546, 2262.6379779235326, 2262.8416010879246, 2269.500709843832, 2165.263810304496, 2201.3726088064905, 2204.2836078274627, 2211.9004644790944, 2226.9888650556804, 2205.184081889703, 2225.4436390902274, 2226.7995880370763, 2262.1743063781682, 2281.8859057047166, 2140.2188201306412, 2149.0436755643746, 2160.157538559963, 2161.6757486377014, 2172.0, 2132.8613640113344, 2170.728658917635, 2200.3948914048765, 2201.570693714726, 2205.151016858505, 7946.801329966739, 7970.282674559259, 8001.19988001201, 8013.599320033975, 8016.879746803803, 4650.953490465085, 4747.406574178228, 4782.689125206851, 4785.282207668877, 4798.208295631217, 2960.3339248669095, 3071.938561228785, 3099.9535006974916, 3109.160526657812, 3110.1136176189902, 1013.6198925402974, 1015.7308313296909, 1025.917926565873, 1037.7768779712324, 1046.9005444482762, 10675.519601617869, 10947.56209751609, 10948.3978381189, 10974.780504389868, 10992.560297588087, 4193.287141186006, 4357.651387888961, 4373.300271956472, 4379.605835474823, 4440.689151759346, 9426.104520070583, 9452.858207126761, 9457.90542094584, 9465.479398633004, 9470.14768670823, 4702.6708130431225, 4724.173269677793, 4728.432588089382, 4740.478547359788, 4741.644376671763, 3813.3517302058717, 4111.09555897702, 4219.535851056443, 4271.914561708749, 4314.892127696833, 3742.2702572998005, 3769.962300377016, 3818.0645741793437, 3874.3219936511, 3893.785841778673, 1190.422645017166, 1222.9571964981183, 1243.4218088588668, 1257.8490581130322, 1274.1335891593806, 730.3353947907378, 864.5936409887343, 866.1857853617579, 886.4371124336093, 886.6985225023394, 5212.374515058217, 5267.894642107136, 5308.389535203424, 5314.601404894648, 5412.99859525989, 421.21023081721773, 426.9679774016961, 427.27363482080585, 431.9157764236007, 434.3289617540907, 3558.466230065511, 3664.6152154023976, 3692.8892133236045, 3704.4258139988347, 3717.683996860297, 9828.852567211497, 9989.950050249703, 10059.446730429896, 10140.543675534618, 10191.184705223564, 9938.652147174815, 10016.39901605906, 10025.348352357074, 10026.799464010679, 10049.69850904474, 7365.15300740411, 7490.85018299631, 7549.320561149523, 7567.243275672388, 7592.316691497792, 5438.673679579238, 5578.163275508706, 5633.746481408264, 5670.404607516151, 5678.602497825113, 8691.304695624462, 8977.147171018743, 8999.37004409685, 9168.862467063132, 9174.67888623895, 9008.414453060792, 9120.087991200828, 9191.448513089235, 9539.284553658643, 9563.378380405251, 6018.879622407615, 6712.664366781739, 6772.695228714621, 7116.750913717995, 7520.623968801648, 7334.633268336455, 7491.850162996819, 7537.283958023979, 7554.433417493819, 7602.049743782028, 6579.769708060195, 6614.305497922649, 6667.799966001027, 6687.364700353459, 6771.424428923597, 6617.933820661732, 6624.906890363036, 6637.469002479694, 6651.46788256948, 6659.733610655519, 6561.934380656323, 6573.3098024706715, 6615.933840661532, 6646.83382915431, 6659.633720145439, 4581.74800385982, 4655.231886738786, 4776.689515181502, 4780.545848144421, 4805.183118869731, 4584.954150458453, 4653.046125544188, 4681.578657920803, 4749.572538471554, 4758.809647614056], "value": 4162.30690573467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.26329280577704, 290.69912640417164, 295.8668599130392, 296.8975703382332, 296.9703029697032, 4898.5101489850995, 4993.201087825949, 5073.771680274387, 5163.561097306729, 5183.537819535719, 5043.798248070082, 5062.190049592066, 5064.366954130734, 5065.290859279704, 5078.111330517154, 3941.231459865313, 3948.709748345967, 3953.0117470632413, 3954.8022598870084, 3980.800959951991, 3871.55477120132, 3946.881593552198, 3977.1846771411792, 3979.7214195006363, 3986.103126796462, 3881.234038512484, 3899.863504777333, 3902.843886244547, 3911.393733971239, 3915.7454765440298, 3914.275858966072, 3918.8236529356245, 3920.4315374270855, 3920.666743326821, 3930.253251882133, 3174.8888788892277, 3324.933501329984, 3351.0, 3351.329734053199, 3443.724502039856, 4936.494369217387, 4947.763059235192, 4952.0, 4970.353853998993, 4980.825671101494, 4383.786187975053, 4423.225935461282, 4426.667999900021, 4430.29115341547, 4440.4671439427475, 5028.195488721787, 5214.374275086976, 5237.764300606482, 5253.894922101536, 5277.604179686539, 3599.136207310227, 3642.9271414571826, 3649.124210189562, 3653.598104208535, 3663.285659296438, 5434.266374039494, 5525.171224316345, 5525.314778992406, 5561.691897862423, 5582.720863956826, 3635.7273204509765, 3677.6138505457075, 3775.8867233983024, 3784.6593806557544, 3786.091338078896, 3742.214135031619, 3758.0, 3771.377722675728, 3788.5453745550712, 3816.4466152407745, 4392.516823149451, 4396.1867054595, 4410.4927933287445, 4410.779461026936, 4414.668899832525, 5344.518993290622, 5349.545288650508, 5356.196570514376, 5368.651037682538, 5370.087085195526, 1180.6103985684704, 1284.4797856867983, 1302.160106731153, 1302.6417735122727, 1302.7199152182327, 787.8857565652949, 790.8971833661587, 809.4576633655347, 815.808285053012, 817.8323443694028, 4087.7138600297694, 4100.794960252035, 4140.730852494638, 4157.230912281238, 4166.312558427825, 4874.927515946486, 4882.951170488321, 4883.413990321184, 4887.144749668793, 4902.705837649681, 4104.979475102665, 4135.60711732385, 4161.9375709364385, 4204.516480604709, 4205.3481710334945, 2484.080890070685, 2569.6145578163423, 2576.291519832061, 2589.158523479839, 2589.948201035969, 4535.89081077294, 4544.272916333371, 4553.954460455419, 4560.224761790503, 4569.383133277031, 4849.248366503198, 4902.1176188285735, 4903.798569350532, 4910.263460480885, 4921.3602231710365, 4236.788160591958, 4457.398251236042, 4463.196624607602, 4501.848705905879, 4502.594766471033, 4789.856304310876, 4797.40032495938, 4810.446798618063, 4812.5668689818085, 4827.758612069312, 4635.884102897455, 4684.344191813081, 4684.953150468588, 4688.367070445446, 4718.669693121448, 4237.618614324726, 4474.194644963807, 4497.572730590588, 4508.977455112704, 4593.563611456906, 3385.610654774634, 3395.6095049069672, 3395.7962522248745, 3473.166440054419, 3487.2389443330953, 4885.828995985124, 4898.4121905371585, 4900.95099049005, 4924.679895806761, 5247.55395791362, 5141.845744627667, 5244.187150991603, 5264.89470210586, 5265.973670131625, 5276.208568714724, 5240.423553409199, 5262.868428289324, 5387.784488620411, 5390.353157621111, 5401.702906340031, 5096.719680417613, 5180.662437216523, 5208.609354298367, 5215.504527069922, 5251.501107394792, 5361.5710743141235, 5376.892462150657, 5378.435264297193, 5394.460553944574, 5414.242006119068, 5239.214117882349, 5251.264822924717, 5277.182036784305, 5289.0, 5303.5757139429525], "value": 3793.8564378776505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.2352870670023, 698.7624207769358, 704.1655638068888, 720.2761721897788, 724.5073350121917, 12000.339981301026, 12868.806967895489, 12901.0, 12912.74174516509, 12913.483460661573, 12787.552435664731, 12872.549460768874, 12914.806277905815, 12932.676683082927, 12950.35248237589, 602.7860109661073, 745.7613563659631, 764.3846703403772, 770.4568279363064, 778.875379939207, 770.9344705700022, 774.5120574038348, 777.2577188784725, 781.8084569280534, 783.3967844759532, 833.2584000239762, 834.6452757578005, 834.8580741273998, 835.5822088955522, 837.3677873205721, 825.558326295432, 827.8385714785619, 828.6892415344246, 829.1045670675655, 830.0910502999207, 600.2976517474565, 601.1673831743067, 601.9518438524907, 601.9939800601982, 603.7494439807475, 12632.557860474839, 12655.303958282291, 12725.236485810881, 12785.424655890507, 12799.744005119845, 13014.86985130146, 13079.149855259378, 13315.600531984055, 13545.796813047813, 13816.0, 10283.588656453732, 10443.738906527322, 10452.477376131239, 10521.631742889038, 10617.991290827358, 3311.7516186286125, 3341.6992470677756, 3386.0688310714504, 3386.762926595139, 3417.6069751978343, 66666.99751368469, 67486.66256668685, 67608.6619566904, 68286.0, 68576.31423685749, 10389.792204155874, 10477.47612619366, 10586.523606437575, 10605.204609654307, 10748.89251107479, 20033.79966200319, 20092.09585568653, 20216.595668086557, 20764.58470830575, 20926.058327375304, 6786.491013174032, 6808.863822723617, 6838.111045564145, 6923.9653801730665, 6941.757038503628, 3562.2697347043795, 3628.256207477461, 3653.488511608377, 3657.908552286214, 3698.389765688685, 2923.853807309626, 3034.180771191766, 3073.0, 3074.7847650664685, 3081.3991271702253, 487.3883276487985, 488.66526429395975, 495.5267719328033, 497.13498512587836, 503.7506434314964, 582.7698059266565, 588.6732863260846, 590.630855715178, 590.7016956436972, 633.4425705379236, 6981.5461994970165, 7368.0, 7442.590657513889, 7696.769096927102, 7773.727919522789, 522.2062465053098, 540.5027374815179, 541.7941182350681, 552.4282367749361, 578.9160571717077, 3728.3848165052464, 3775.1505911169766, 3835.4055121456217, 3886.436466712311, 3900.1419687668667, 57975.680972760616, 85782.0, 88026.11973880307, 88382.0, 90069.0, 48129.278060829114, 59378.703106484194, 76075.0, 76266.61866690632, 76275.61862190765, 45455.0, 71182.0, 72233.63883180551, 73625.0, 73777.0, 8005.799855003672, 8268.751937441886, 8333.374996875138, 8358.832823343377, 8497.235248827388, 37879.43180852345, 42317.576824231364, 42446.0, 42756.78621606872, 43538.0, 40866.182676345714, 51534.74232628813, 51678.48321516737, 59028.0, 62682.0, 10766.354018758899, 10775.568977240822, 10915.235933484897, 11085.556577737123, 11366.943165284121, 12592.622221333375, 12850.164739291917, 13250.138740981805, 13608.727825443633, 13652.316098027733, 11626.476808543805, 11733.823992640288, 12034.939825300817, 12132.122574420628, 12324.198927069712, 11389.259698119597, 11521.942390287995, 11766.352850592957, 12178.208416452902, 12298.20061695987, 11241.325520468798, 11398.886011140114, 11806.881931180578, 11834.053275737748, 11854.881451185724, 9564.904350956402, 9604.903950960681, 9807.754806129904, 9833.213342932691, 10207.54066067014, 9535.952320238355, 9782.75543111428, 9819.9018009819, 9823.459709716035, 9995.800083998425], "value": 6439.891130298346, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 118.0, 115.0, 115.0, 112.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 131.0, 155.0, 179.0, 135.0, 163.0, 156.0, 151.0, 194.0, 133.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 178.0, 165.0, 165.0, 163.0, 163.0, 163.0, 163.0, 166.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 160.0, 77.0, 76.0, 77.0, 77.0, 171.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 144.0, 86.0, 87.0, 86.0, 144.0, 85.0, 85.0, 143.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 151.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 100.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 69.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 85.0, 92.0, 85.0, 86.0, 87.0, 107.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 138.0, 136.0, 131.0, 137.0, 132.0, 151.0, 137.0, 135.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 172.0, 168.0, 172.0, 169.0, 169.0, 173.0, 170.0, 170.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 74.0, 68.0, 69.0, 71.0, 68.0, 69.0, 67.0, 66.0], "value": 69.7, "unit": "score"}]}]} 23:15:26 INFO - Return code: 0 23:15:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:15:26 ERROR - # TBPL SUCCESS # 23:15:26 INFO - Running post-action listener: _resource_record_post_action 23:15:26 INFO - ##### 23:15:26 INFO - ##### Finished run-tests step (success) 23:15:26 INFO - ##### 23:15:26 INFO - Running post-run listener: _resource_record_post_run 23:15:26 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 541683712; Read time: 44; Write time: 971856 23:15:26 INFO - TinderboxPrint: CPU usage
13.6% 23:15:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 23:15:26 INFO - TinderboxPrint: I/O write bytes / time
541,683,712 / 971,856 23:15:26 INFO - TinderboxPrint: CPU idle
8,269.5 (86.4%) 23:15:26 INFO - TinderboxPrint: CPU user
1,239.9 (13.0%) 23:15:26 INFO - TinderboxPrint: Swap in / out
0 / 0 23:15:26 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 245080064; Read time: 0; Write time: 626688 23:15:26 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 4096; Write bytes: 296603648; Read time: 44; Write time: 345168 23:15:26 INFO - Running post-run listener: _upload_blobber_files 23:15:26 INFO - Blob upload gear active. 23:15:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:15:26 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 23:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:15:27 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:15:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:31 INFO - (blobuploader) - INFO - Done attempting. 23:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:15:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:32 INFO - (blobuploader) - INFO - Done attempting. 23:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:32 INFO - (blobuploader) - INFO - Done attempting. 23:15:32 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:32 INFO - Return code: 0 23:15:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:15:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1094a4f708e42a68b6da8f9f4a8c820a8fc580a9b811e75999adc44433f8e51cfac210a3b3b890a38b57ed863e991f71b89091849c172637d6cf13501f50b940", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589f0b761b2c6fb3f9c47adf4e2d47e3e2aa9aa0b4444c6752d5121ceeebe04a345caee9b0817448f1abd1722922b599e62d9f4d4d04bec8a859a67726bfb12d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c662822f7ca4fbcc7bc002f8d01a6d42cc2b16b9d8f127e19d5db3eda062f690ed4a318ad20d73a52bd3955f07c00c50c8ef1470ec5e81d846e856bc8acf38c"} 23:15:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:15:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:15:32 INFO - Contents: 23:15:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1094a4f708e42a68b6da8f9f4a8c820a8fc580a9b811e75999adc44433f8e51cfac210a3b3b890a38b57ed863e991f71b89091849c172637d6cf13501f50b940", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589f0b761b2c6fb3f9c47adf4e2d47e3e2aa9aa0b4444c6752d5121ceeebe04a345caee9b0817448f1abd1722922b599e62d9f4d4d04bec8a859a67726bfb12d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c662822f7ca4fbcc7bc002f8d01a6d42cc2b16b9d8f127e19d5db3eda062f690ed4a318ad20d73a52bd3955f07c00c50c8ef1470ec5e81d846e856bc8acf38c"} 23:15:32 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:32 INFO - Copying logs to upload dir... 23:15:32 INFO - mkdir: /builds/slave/test/build/upload/logs 23:15:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.079102 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-14 23:15:32.274799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 23:15:32.277931) ========= 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=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 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-Non-PGO/sha512/1094a4f708e42a68b6da8f9f4a8c820a8fc580a9b811e75999adc44433f8e51cfac210a3b3b890a38b57ed863e991f71b89091849c172637d6cf13501f50b940", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589f0b761b2c6fb3f9c47adf4e2d47e3e2aa9aa0b4444c6752d5121ceeebe04a345caee9b0817448f1abd1722922b599e62d9f4d4d04bec8a859a67726bfb12d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c662822f7ca4fbcc7bc002f8d01a6d42cc2b16b9d8f127e19d5db3eda062f690ed4a318ad20d73a52bd3955f07c00c50c8ef1470ec5e81d846e856bc8acf38c"} build_url:https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/NdYyA0FXTfKBTFZ-EuVEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1094a4f708e42a68b6da8f9f4a8c820a8fc580a9b811e75999adc44433f8e51cfac210a3b3b890a38b57ed863e991f71b89091849c172637d6cf13501f50b940", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589f0b761b2c6fb3f9c47adf4e2d47e3e2aa9aa0b4444c6752d5121ceeebe04a345caee9b0817448f1abd1722922b599e62d9f4d4d04bec8a859a67726bfb12d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c662822f7ca4fbcc7bc002f8d01a6d42cc2b16b9d8f127e19d5db3eda062f690ed4a318ad20d73a52bd3955f07c00c50c8ef1470ec5e81d846e856bc8acf38c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 23:15:32.307892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:15:32.308226) ========= 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=af724c981e2a0f424dbabf99000001e7-1465964316.380000-1395510484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:15:32.391580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 23:15:32.391920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 23:15:32.392243) ========= ========= Total master_lag: 0.17 =========