builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1466888725.68 results: success (0) buildid: 20160625113008 builduid: 8566c87712764df8ae2d38cbf57d28f0 revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.678787) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.679356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.679685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.736512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.736772) ========= 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=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 14:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.9M=0s 2016-06-25 14:05:26 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.879475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.879774) ========= 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=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023316 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.929024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:25.929366) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 14:05:27,078 truncating revision to first 12 chars 2016-06-25 14:05:27,078 Setting DEBUG logging. 2016-06-25 14:05:27,078 attempt 1/10 2016-06-25 14:05:27,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/59bc5cd1caa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 14:05:27,387 unpacking tar archive at: fx-team-59bc5cd1caa6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:26.682677) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:26.682980) ========= script_repo_revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:26.683400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:26.683703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 14:05:26.695261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-25 14:05:26.695592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:05:27 INFO - MultiFileLogger online at 20160625 14:05:27 in /builds/slave/test 14:05:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:05:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:27 INFO - {'append_to_log': False, 14:05:27 INFO - 'base_work_dir': '/builds/slave/test', 14:05:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:05:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:27 INFO - 'branch': 'Fx-Team', 14:05:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:27 INFO - 'config_files': ('talos/linux_config.py',), 14:05:27 INFO - 'default_actions': ('clobber', 14:05:27 INFO - 'read-buildbot-config', 14:05:27 INFO - 'download-and-extract', 14:05:27 INFO - 'populate-webroot', 14:05:27 INFO - 'create-virtualenv', 14:05:27 INFO - 'install', 14:05:27 INFO - 'run-tests'), 14:05:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:27 INFO - 'download_minidump_stackwalk': True, 14:05:27 INFO - 'download_symbols': 'ondemand', 14:05:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:27 INFO - 'installer_path': 'installer.exe', 14:05:27 INFO - 'log_level': 'info', 14:05:27 INFO - 'log_name': 'talos', 14:05:27 INFO - 'log_to_console': True, 14:05:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:05:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:05:27 INFO - 'opt_config_files': (), 14:05:27 INFO - 'pip_index': False, 14:05:27 INFO - 'sps_profile': False, 14:05:27 INFO - 'sps_profile_interval': 0, 14:05:27 INFO - 'suite': 'dromaeojs-e10s', 14:05:27 INFO - 'system_bits': '32', 14:05:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:27 INFO - 'title': 'talos-linux64-ix-010', 14:05:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:27 INFO - 'use_talos_json': True, 14:05:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:27 INFO - 'work_dir': 'build'} 14:05:27 INFO - ##### 14:05:27 INFO - ##### Running clobber step. 14:05:27 INFO - ##### 14:05:27 INFO - Running pre-action listener: _resource_record_pre_action 14:05:27 INFO - Running main action method: clobber 14:05:27 INFO - rmtree: /builds/slave/test/build 14:05:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:28 INFO - Running post-action listener: _resource_record_post_action 14:05:28 INFO - ##### 14:05:28 INFO - ##### Finished clobber step (success) 14:05:28 INFO - ##### 14:05:28 INFO - ##### 14:05:28 INFO - ##### Running read-buildbot-config step. 14:05:28 INFO - ##### 14:05:28 INFO - Running pre-action listener: _resource_record_pre_action 14:05:28 INFO - Running main action method: read_buildbot_config 14:05:28 INFO - Using buildbot properties: 14:05:28 INFO - { 14:05:28 INFO - "project": "", 14:05:28 INFO - "product": "firefox", 14:05:28 INFO - "script_repo_revision": "production", 14:05:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:05:28 INFO - "repository": "", 14:05:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:05:28 INFO - "buildid": "20160625113008", 14:05:28 INFO - "pgo_build": "True", 14:05:28 INFO - "basedir": "/builds/slave/test", 14:05:28 INFO - "buildnumber": 505, 14:05:28 INFO - "slavename": "talos-linux64-ix-010", 14:05:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:05:28 INFO - "platform": "ubuntu64_hw", 14:05:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:05:28 INFO - "branch": "fx-team", 14:05:28 INFO - "repo_path": "integration/fx-team", 14:05:28 INFO - "revision": "59bc5cd1caa619e2be168d5fa67803f9e96c4309", 14:05:28 INFO - "stage_platform": "linux64-pgo", 14:05:28 INFO - "builduid": "8566c87712764df8ae2d38cbf57d28f0", 14:05:28 INFO - "slavebuilddir": "test" 14:05:28 INFO - } 14:05:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:05:28 INFO - Running post-action listener: _resource_record_post_action 14:05:28 INFO - ##### 14:05:28 INFO - ##### Finished read-buildbot-config step (success) 14:05:28 INFO - ##### 14:05:28 INFO - ##### 14:05:28 INFO - ##### Running download-and-extract step. 14:05:28 INFO - ##### 14:05:28 INFO - Running pre-action listener: _resource_record_pre_action 14:05:28 INFO - Running main action method: download_and_extract 14:05:28 INFO - mkdir: /builds/slave/test/build/tests 14:05:28 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')]} 14:05:28 INFO - https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:34 INFO - Downloaded 1361 bytes. 14:05:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:05:34 INFO - Using the following test package requirements: 14:05:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:05:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:05:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'jsshell-linux-x86_64.zip'], 14:05:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:05:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:05:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:05:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:05:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:05:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:05:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:05:34 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')]} 14:05:34 INFO - https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:36 INFO - Downloaded 24279471 bytes. 14:05:36 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'] 14:05:36 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 14:05:37 INFO - Return code: 0 14:05:37 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 14:05:37 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')]} 14:05:37 INFO - https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:40 INFO - Downloaded 24279471 bytes. 14:05:40 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'] 14:05:40 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 14:05:41 INFO - Return code: 0 14:05: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')]} 14:05:41 INFO - https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:42 INFO - Downloaded 14405188 bytes. 14:05:42 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'] 14:05:42 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 14:05:42 INFO - Return code: 0 14:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:42 INFO - https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSqcQT4_TqGvmNudpoNLfA/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 14:05:44 INFO - Downloaded 60165783 bytes. 14:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:05:44 INFO - mkdir: /builds/slave/test/properties 14:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:44 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:44 INFO - Contents: 14:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:05:45 INFO - Running post-action listener: _resource_record_post_action 14:05:45 INFO - Running post-action listener: set_extra_try_arguments 14:05:45 INFO - ##### 14:05:45 INFO - ##### Finished download-and-extract step (success) 14:05:45 INFO - ##### 14:05:45 INFO - ##### 14:05:45 INFO - ##### Running populate-webroot step. 14:05:45 INFO - ##### 14:05:45 INFO - Running pre-action listener: _resource_record_pre_action 14:05:45 INFO - Running main action method: populate_webroot 14:05:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:45 INFO - '--tppagecycles', 14:05:45 INFO - '7'], 14:05:45 INFO - 'tests': ['tsvgm']}}, 14:05:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['damp', 'tps']}, 14:05:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['damp', 'tps']}, 14:05:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['dromaeo_dom']}, 14:05:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['basic_compositor_video']}, 14:05:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['a11yr', 14:05:45 INFO - 'ts_paint', 14:05:45 INFO - 'tpaint', 14:05:45 INFO - 'sessionrestore', 14:05:45 INFO - 'sessionrestore_no_auto_restore', 14:05:45 INFO - 'tabpaint']}, 14:05:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tsvgx', 14:05:45 INFO - 'tsvgr_opacity', 14:05:45 INFO - 'tart', 14:05:45 INFO - 'tscrollx', 14:05:45 INFO - 'cart']}, 14:05:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:45 INFO - 'tsvgr_opacity', 14:05:45 INFO - 'tart', 14:05:45 INFO - 'tscrollx', 14:05:45 INFO - 'cart']}, 14:05:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s'], 14:05:45 INFO - 'tests': ['tp5o']}, 14:05:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'tests': ['tp5o']}, 14:05:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--disable-e10s', 14:05:45 INFO - '--xperf_path', 14:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:45 INFO - 'tests': ['tp5n']}, 14:05:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:45 INFO - 'talos_options': ['--xperf_path', 14:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:45 INFO - 'tests': ['tp5n']}}, 14:05:45 INFO - 'talos.zip': {'path': '', 14:05:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:45 INFO - Running post-action listener: _resource_record_post_action 14:05:45 INFO - ##### 14:05:45 INFO - ##### Finished populate-webroot step (success) 14:05:45 INFO - ##### 14:05:45 INFO - ##### 14:05:45 INFO - ##### Running create-virtualenv step. 14:05:45 INFO - ##### 14:05:45 INFO - Running pre-action listener: _resource_record_pre_action 14:05:45 INFO - Running main action method: create_virtualenv 14:05:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:45 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 14:05:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:45 INFO - Using real prefix '/usr' 14:05:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:47 INFO - Installing pip.................done. 14:05:47 INFO - Return code: 0 14:05:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:47 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')]} 14:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 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')]} 14:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:47 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 14:05:47 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 14:05:47 INFO - Using env: {'DISPLAY': ':0', 14:05:47 INFO - 'HOME': '/home/cltbld', 14:05:47 INFO - 'LANG': 'en_US.UTF-8', 14:05:47 INFO - 'LANGUAGE': 'en_US:en', 14:05:47 INFO - 'LOGNAME': 'cltbld', 14:05:47 INFO - 'MAIL': '/var/mail/cltbld', 14:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:47 INFO - 'MOZ_NO_REMOTE': '1', 14:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:47 INFO - 'NO_EM_RESTART': '1', 14:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:47 INFO - 'PWD': '/builds/slave/test', 14:05:47 INFO - 'SHELL': '/bin/bash', 14:05:47 INFO - 'SHLVL': '1', 14:05:47 INFO - 'TERM': 'linux', 14:05:47 INFO - 'TMOUT': '86400', 14:05:47 INFO - 'USER': 'cltbld', 14:05:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:47 INFO - '_': '/tools/buildbot/bin/python'} 14:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:47 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 14:05:47 INFO - Cleaning up... 14:05:47 INFO - Return code: 0 14:05:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:47 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')]} 14:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 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')]} 14:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:47 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 14:05:47 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 14:05:47 INFO - Using env: {'DISPLAY': ':0', 14:05:47 INFO - 'HOME': '/home/cltbld', 14:05:47 INFO - 'LANG': 'en_US.UTF-8', 14:05:47 INFO - 'LANGUAGE': 'en_US:en', 14:05:47 INFO - 'LOGNAME': 'cltbld', 14:05:47 INFO - 'MAIL': '/var/mail/cltbld', 14:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:47 INFO - 'MOZ_NO_REMOTE': '1', 14:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:47 INFO - 'NO_EM_RESTART': '1', 14:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:47 INFO - 'PWD': '/builds/slave/test', 14:05:47 INFO - 'SHELL': '/bin/bash', 14:05:47 INFO - 'SHLVL': '1', 14:05:47 INFO - 'TERM': 'linux', 14:05:47 INFO - 'TMOUT': '86400', 14:05:47 INFO - 'USER': 'cltbld', 14:05:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:47 INFO - '_': '/tools/buildbot/bin/python'} 14:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:48 INFO - Downloading/unpacking psutil>=3.1.1 14:05:48 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 14:05:48 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 14:05:48 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 14:05:48 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 14:05:48 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 14:05:48 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 14:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:50 INFO - Installing collected packages: psutil 14:05:50 INFO - Running setup.py install for psutil 14:05:50 INFO - building 'psutil._psutil_linux' extension 14:05:50 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 14:05:50 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 14:05:50 INFO - building 'psutil._psutil_posix' extension 14:05:50 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 14:05:50 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 14:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:50 INFO - Successfully installed psutil 14:05:50 INFO - Cleaning up... 14:05:50 INFO - Return code: 0 14:05:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:50 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:50 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 14:05:50 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 14:05:50 INFO - Using env: {'DISPLAY': ':0', 14:05:50 INFO - 'HOME': '/home/cltbld', 14:05:50 INFO - 'LANG': 'en_US.UTF-8', 14:05:50 INFO - 'LANGUAGE': 'en_US:en', 14:05:50 INFO - 'LOGNAME': 'cltbld', 14:05:50 INFO - 'MAIL': '/var/mail/cltbld', 14:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:50 INFO - 'MOZ_NO_REMOTE': '1', 14:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:50 INFO - 'NO_EM_RESTART': '1', 14:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:50 INFO - 'PWD': '/builds/slave/test', 14:05:50 INFO - 'SHELL': '/bin/bash', 14:05:50 INFO - 'SHLVL': '1', 14:05:50 INFO - 'TERM': 'linux', 14:05:50 INFO - 'TMOUT': '86400', 14:05:50 INFO - 'USER': 'cltbld', 14:05:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:50 INFO - '_': '/tools/buildbot/bin/python'} 14:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:50 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 14:05:50 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 14:05:50 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 14:05:50 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 14:05:50 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 14:05:50 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 14:05:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:52 INFO - Installing collected packages: mozsystemmonitor 14:05:52 INFO - Running setup.py install for mozsystemmonitor 14:05:52 INFO - Successfully installed mozsystemmonitor 14:05:52 INFO - Cleaning up... 14:05:52 INFO - Return code: 0 14:05:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:52 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:52 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 14:05:52 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 14:05:52 INFO - Using env: {'DISPLAY': ':0', 14:05:52 INFO - 'HOME': '/home/cltbld', 14:05:52 INFO - 'LANG': 'en_US.UTF-8', 14:05:52 INFO - 'LANGUAGE': 'en_US:en', 14:05:52 INFO - 'LOGNAME': 'cltbld', 14:05:52 INFO - 'MAIL': '/var/mail/cltbld', 14:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:52 INFO - 'MOZ_NO_REMOTE': '1', 14:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:52 INFO - 'NO_EM_RESTART': '1', 14:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:52 INFO - 'PWD': '/builds/slave/test', 14:05:52 INFO - 'SHELL': '/bin/bash', 14:05:52 INFO - 'SHLVL': '1', 14:05:52 INFO - 'TERM': 'linux', 14:05:52 INFO - 'TMOUT': '86400', 14:05:52 INFO - 'USER': 'cltbld', 14:05:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:52 INFO - '_': '/tools/buildbot/bin/python'} 14:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:53 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:53 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 14:05:53 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 14:05:53 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 14:05:53 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 14:05:53 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 14:05:53 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 14:05:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:55 INFO - warning: no files found matching '*.txt' 14:05:55 INFO - no previously-included directories found matching 'build' 14:05:55 INFO - no previously-included directories found matching 'dist' 14:05:55 INFO - no previously-included directories found matching '.git*' 14:05:55 INFO - Installing collected packages: jsonschema, functools32 14:05:55 INFO - Running setup.py install for functools32 14:05:55 INFO - warning: no files found matching '*.txt' 14:05:55 INFO - no previously-included directories found matching 'build' 14:05:55 INFO - no previously-included directories found matching 'dist' 14:05:55 INFO - no previously-included directories found matching '.git*' 14:05:55 INFO - Successfully installed jsonschema functools32 14:05:55 INFO - Cleaning up... 14:05:55 INFO - Return code: 0 14:05:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:05:55 INFO - Using env: {'DISPLAY': ':0', 14:05:55 INFO - 'HOME': '/home/cltbld', 14:05:55 INFO - 'LANG': 'en_US.UTF-8', 14:05:55 INFO - 'LANGUAGE': 'en_US:en', 14:05:55 INFO - 'LOGNAME': 'cltbld', 14:05:55 INFO - 'MAIL': '/var/mail/cltbld', 14:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:55 INFO - 'MOZ_NO_REMOTE': '1', 14:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:55 INFO - 'NO_EM_RESTART': '1', 14:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:55 INFO - 'PWD': '/builds/slave/test', 14:05:55 INFO - 'SHELL': '/bin/bash', 14:05:55 INFO - 'SHLVL': '1', 14:05:55 INFO - 'TERM': 'linux', 14:05:55 INFO - 'TMOUT': '86400', 14:05:55 INFO - 'USER': 'cltbld', 14:05:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:55 INFO - '_': '/tools/buildbot/bin/python'} 14:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:57 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 14:05:57 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 14:05:57 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 14:05:57 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 14:05:57 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 14:05:57 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 14:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:58 INFO - Downloading docopt-0.6.1.tar.gz 14:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:58 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:58 INFO - Running setup.py install for blobuploader 14:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:58 INFO - Running setup.py install for requests 14:05:58 INFO - Running setup.py install for docopt 14:05:58 INFO - Successfully installed blobuploader requests docopt 14:05:58 INFO - Cleaning up... 14:05:58 INFO - Return code: 0 14:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:58 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:05:58 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 14:05:58 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 14:05:58 INFO - Using env: {'DISPLAY': ':0', 14:05:58 INFO - 'HOME': '/home/cltbld', 14:05:58 INFO - 'LANG': 'en_US.UTF-8', 14:05:58 INFO - 'LANGUAGE': 'en_US:en', 14:05:58 INFO - 'LOGNAME': 'cltbld', 14:05:58 INFO - 'MAIL': '/var/mail/cltbld', 14:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:58 INFO - 'MOZ_NO_REMOTE': '1', 14:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:58 INFO - 'NO_EM_RESTART': '1', 14:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:58 INFO - 'PWD': '/builds/slave/test', 14:05:58 INFO - 'SHELL': '/bin/bash', 14:05:58 INFO - 'SHLVL': '1', 14:05:58 INFO - 'TERM': 'linux', 14:05:58 INFO - 'TMOUT': '86400', 14:05:58 INFO - 'USER': 'cltbld', 14:05:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:58 INFO - '_': '/tools/buildbot/bin/python'} 14:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:59 INFO - Running setup.py (path:/tmp/pip-CHk14d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:59 INFO - Running setup.py (path:/tmp/pip-GlimGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:59 INFO - Running setup.py (path:/tmp/pip-oReoAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:59 INFO - Running setup.py (path:/tmp/pip-EmGkOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:59 INFO - Running setup.py (path:/tmp/pip-ENZDir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:59 INFO - Running setup.py (path:/tmp/pip-K4ufvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:59 INFO - Running setup.py (path:/tmp/pip-K10q39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:59 INFO - Running setup.py (path:/tmp/pip-voq1So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:59 INFO - Running setup.py (path:/tmp/pip-JWXKiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:59 INFO - Running setup.py (path:/tmp/pip-2YeCyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:59 INFO - Running setup.py (path:/tmp/pip-SWHtO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:59 INFO - Running setup.py (path:/tmp/pip-SBVa9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:00 INFO - Running setup.py (path:/tmp/pip-K9DguE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:00 INFO - Running setup.py (path:/tmp/pip-d1lLJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:00 INFO - Running setup.py (path:/tmp/pip-5JKNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:00 INFO - Running setup.py (path:/tmp/pip-KQ1qRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:00 INFO - Running setup.py (path:/tmp/pip-FolDWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:00 INFO - Running setup.py install for manifestparser 14:06:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozcrash 14:06:00 INFO - Running setup.py install for mozdebug 14:06:00 INFO - Running setup.py install for mozdevice 14:06:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozfile 14:06:00 INFO - Running setup.py install for mozhttpd 14:06:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:00 INFO - Running setup.py install for mozinfo 14:06:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for mozInstall 14:06:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for mozleak 14:06:01 INFO - Running setup.py install for mozlog 14:06:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for moznetwork 14:06:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for mozprocess 14:06:01 INFO - Running setup.py install for mozprofile 14:06:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for mozrunner 14:06:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:01 INFO - Running setup.py install for mozscreenshot 14:06:01 INFO - Running setup.py install for moztest 14:06:02 INFO - Running setup.py install for mozversion 14:06:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:02 INFO - Cleaning up... 14:06:02 INFO - Return code: 0 14:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:02 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')]} 14:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 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')]} 14:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:06:02 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 14:06:02 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 14:06:02 INFO - Using env: {'DISPLAY': ':0', 14:06:02 INFO - 'HOME': '/home/cltbld', 14:06:02 INFO - 'LANG': 'en_US.UTF-8', 14:06:02 INFO - 'LANGUAGE': 'en_US:en', 14:06:02 INFO - 'LOGNAME': 'cltbld', 14:06:02 INFO - 'MAIL': '/var/mail/cltbld', 14:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:02 INFO - 'MOZ_NO_REMOTE': '1', 14:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:02 INFO - 'NO_EM_RESTART': '1', 14:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:02 INFO - 'PWD': '/builds/slave/test', 14:06:02 INFO - 'SHELL': '/bin/bash', 14:06:02 INFO - 'SHLVL': '1', 14:06:02 INFO - 'TERM': 'linux', 14:06:02 INFO - 'TMOUT': '86400', 14:06:02 INFO - 'USER': 'cltbld', 14:06:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:02 INFO - '_': '/tools/buildbot/bin/python'} 14:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:02 INFO - Running setup.py (path:/tmp/pip-bHzm8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:02 INFO - Running setup.py (path:/tmp/pip-cET_ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:02 INFO - Running setup.py (path:/tmp/pip-FKv4K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:02 INFO - Running setup.py (path:/tmp/pip-f5W_H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:02 INFO - Running setup.py (path:/tmp/pip-h0Pi8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:02 INFO - Running setup.py (path:/tmp/pip-UNenJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:02 INFO - Running setup.py (path:/tmp/pip-5FFaio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:02 INFO - Running setup.py (path:/tmp/pip-QQLUte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:02 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)) 14:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:02 INFO - Running setup.py (path:/tmp/pip-8KFwQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:03 INFO - Running setup.py (path:/tmp/pip-hbaZO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:03 INFO - Running setup.py (path:/tmp/pip-KL4Tmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:03 INFO - Running setup.py (path:/tmp/pip-rekv1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:03 INFO - Running setup.py (path:/tmp/pip-pcN2gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:03 INFO - Running setup.py (path:/tmp/pip-9JbbXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:03 INFO - Running setup.py (path:/tmp/pip-fFqqFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:03 INFO - Running setup.py (path:/tmp/pip-mpDBUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:03 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)) 14:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:03 INFO - Running setup.py (path:/tmp/pip-ACTdbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:03 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)) 14:06:03 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)) 14:06:03 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)) 14:06:03 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)) 14:06:03 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)) 14:06:03 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)) 14:06:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:05 INFO - Downloading blessings-1.6.tar.gz 14:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:05 INFO - Installing collected packages: blessings 14:06:05 INFO - Running setup.py install for blessings 14:06:05 INFO - Successfully installed blessings 14:06:05 INFO - Cleaning up... 14:06:05 INFO - Return code: 0 14:06:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:05 INFO - Reading from file tmpfile_stdout 14:06:05 INFO - Current package versions: 14:06:05 INFO - argparse == 1.2.1 14:06:05 INFO - blessings == 1.6 14:06:05 INFO - blobuploader == 1.2.4 14:06:05 INFO - docopt == 0.6.1 14:06:05 INFO - functools32 == 3.2.3-2 14:06:05 INFO - jsonschema == 2.5.1 14:06:05 INFO - manifestparser == 1.1 14:06:05 INFO - mozInstall == 1.12 14:06:05 INFO - mozcrash == 0.17 14:06:05 INFO - mozdebug == 0.1 14:06:05 INFO - mozdevice == 0.48 14:06:05 INFO - mozfile == 1.2 14:06:05 INFO - mozhttpd == 0.7 14:06:05 INFO - mozinfo == 0.9 14:06:05 INFO - mozleak == 0.1 14:06:05 INFO - mozlog == 3.2 14:06:05 INFO - moznetwork == 0.27 14:06:05 INFO - mozprocess == 0.22 14:06:05 INFO - mozprofile == 0.28 14:06:05 INFO - mozrunner == 6.11 14:06:05 INFO - mozscreenshot == 0.1 14:06:05 INFO - mozsystemmonitor == 0.3 14:06:05 INFO - moztest == 0.7 14:06:05 INFO - mozversion == 1.4 14:06:05 INFO - psutil == 3.1.1 14:06:05 INFO - requests == 1.2.3 14:06:05 INFO - wsgiref == 0.1.2 14:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:05 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')]} 14:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:05 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')]} 14:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:05 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 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:06:05 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 14:06:05 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 14:06:05 INFO - Using env: {'DISPLAY': ':0', 14:06:05 INFO - 'HOME': '/home/cltbld', 14:06:05 INFO - 'LANG': 'en_US.UTF-8', 14:06:05 INFO - 'LANGUAGE': 'en_US:en', 14:06:05 INFO - 'LOGNAME': 'cltbld', 14:06:05 INFO - 'MAIL': '/var/mail/cltbld', 14:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:05 INFO - 'MOZ_NO_REMOTE': '1', 14:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:05 INFO - 'NO_EM_RESTART': '1', 14:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:05 INFO - 'PWD': '/builds/slave/test', 14:06:05 INFO - 'SHELL': '/bin/bash', 14:06:05 INFO - 'SHLVL': '1', 14:06:05 INFO - 'TERM': 'linux', 14:06:05 INFO - 'TMOUT': '86400', 14:06:05 INFO - 'USER': 'cltbld', 14:06:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:05 INFO - '_': '/tools/buildbot/bin/python'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 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)) 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:06: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', 'jsonschema'] in /builds/slave/test/build 14:06: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 jsonschema 14:06:06 INFO - Using env: {'DISPLAY': ':0', 14:06:06 INFO - 'HOME': '/home/cltbld', 14:06:06 INFO - 'LANG': 'en_US.UTF-8', 14:06:06 INFO - 'LANGUAGE': 'en_US:en', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MAIL': '/var/mail/cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SHLVL': '1', 14:06:06 INFO - 'TERM': 'linux', 14:06:06 INFO - 'TMOUT': '86400', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - '_': '/tools/buildbot/bin/python'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f606aa8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', '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 14:06: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', 'flake8'] in /builds/slave/test/build 14:06: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 flake8 14:06:06 INFO - Using env: {'DISPLAY': ':0', 14:06:06 INFO - 'HOME': '/home/cltbld', 14:06:06 INFO - 'LANG': 'en_US.UTF-8', 14:06:06 INFO - 'LANGUAGE': 'en_US:en', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MAIL': '/var/mail/cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SHLVL': '1', 14:06:06 INFO - 'TERM': 'linux', 14:06:06 INFO - 'TMOUT': '86400', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - '_': '/tools/buildbot/bin/python'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Downloading/unpacking flake8 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:06:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:06:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:08 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 14:06:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:09 INFO - no previously-included directories found matching 'docs/_build' 14:06:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:06:09 INFO - Running setup.py install for pep8 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:09 INFO - no previously-included directories found matching 'docs/_build' 14:06:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:06:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Running post-action listener: _resource_record_post_action 14:06:09 INFO - Running post-action listener: _start_resource_monitoring 14:06:09 INFO - Starting resource monitoring. 14:06:09 INFO - ##### 14:06:09 INFO - ##### Finished create-virtualenv step (success) 14:06:09 INFO - ##### 14:06:09 INFO - ##### 14:06:09 INFO - ##### Running install step. 14:06:09 INFO - ##### 14:06:09 INFO - Running pre-action listener: _resource_record_pre_action 14:06:09 INFO - Running main action method: install 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:09 INFO - Reading from file tmpfile_stdout 14:06:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:10 INFO - Reading from file tmpfile_stdout 14:06:10 INFO - Output received: 14:06:10 INFO - Usage: mozinstall [options] installer 14:06:10 INFO - Options: 14:06:10 INFO - -h, --help show this help message and exit 14:06:10 INFO - -d DEST, --destination=DEST 14:06:10 INFO - Directory to install application into. [default: 14:06:10 INFO - "/builds/slave/test"] 14:06:10 INFO - --app=APP Application being installed. [default: firefox] 14:06:10 INFO - mkdir: /builds/slave/test/build/application 14:06:10 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'] 14:06:10 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 14:06:27 INFO - Reading from file tmpfile_stdout 14:06:27 INFO - Output received: 14:06:27 INFO - /builds/slave/test/build/application/firefox/firefox 14:06:27 INFO - Running post-action listener: _resource_record_post_action 14:06:27 INFO - ##### 14:06:27 INFO - ##### Finished install step (success) 14:06:27 INFO - ##### 14:06:27 INFO - ##### 14:06:27 INFO - ##### Running run-tests step. 14:06:27 INFO - ##### 14:06:27 INFO - Running pre-action listener: _resource_record_pre_action 14:06:27 INFO - Running main action method: run_tests 14:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:27 INFO - Python 2.7.3 14:06:27 INFO - Return code: 0 14:06:27 INFO - grabbing minidump binary from tooltool 14:06:27 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')]} 14:06:27 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 0x11661c0>, '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 0x11670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1167550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:27 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 14:06:27 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 14:06:27 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 14:06:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:27 INFO - Return code: 0 14:06:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:06:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:06:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:06:28 INFO - Return code: 0 14:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 14:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 14:06:28 INFO - Using env: {'DISPLAY': ':0', 14:06:28 INFO - 'HOME': '/home/cltbld', 14:06:28 INFO - 'LANG': 'en_US.UTF-8', 14:06:28 INFO - 'LANGUAGE': 'en_US:en', 14:06:28 INFO - 'LOGNAME': 'cltbld', 14:06:28 INFO - 'MAIL': '/var/mail/cltbld', 14:06:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:28 INFO - 'MOZ_NO_REMOTE': '1', 14:06:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:28 INFO - 'NO_EM_RESTART': '1', 14:06:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:28 INFO - 'PWD': '/builds/slave/test', 14:06:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:28 INFO - 'SHELL': '/bin/bash', 14:06:28 INFO - 'SHLVL': '1', 14:06:28 INFO - 'TERM': 'linux', 14:06:28 INFO - 'TMOUT': '86400', 14:06:28 INFO - 'USER': 'cltbld', 14:06:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801', 14:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:28 INFO - '_': '/tools/buildbot/bin/python'} 14:06:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 14:06:28 INFO - mozversion application_buildid: 20160625113008 14:06:28 INFO - mozversion application_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 14:06:28 INFO - mozversion application_display_name: Nightly 14:06:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:28 INFO - mozversion application_name: Firefox 14:06:28 INFO - mozversion application_remotingname: firefox 14:06:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:06:28 INFO - mozversion application_vendor: Mozilla 14:06:28 INFO - mozversion application_version: 50.0a1 14:06:28 INFO - mozversion platform_buildid: 20160625113008 14:06:28 INFO - mozversion platform_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 14:06:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:06:28 INFO - mozversion platform_version: 50.0a1 14:06:28 INFO - using testdate: 1466888788 14:06:28 INFO - actual date: 1466888788 14:06:28 INFO - starting webserver on 'localhost:36337' 14:06:28 INFO - SUITE-START | Running 2 tests 14:06:28 INFO - TEST-START | dromaeo_css 14:06:28 INFO - operating with platform_type : linux_ 14:06:28 INFO - Initialising browser for dromaeo_css test... 14:06:28 INFO - TEST-INFO | started process 13573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_m8wn1/profile http://localhost:36337/getInfo.html) 14:06:33 INFO - PROCESS | 13573 | __metrics Screen width/height:1600/1200 14:06:33 INFO - PROCESS | 13573 | colorDepth:24 14:06:33 INFO - PROCESS | 13573 | Browser inner width/height: 1024/697 14:06:33 INFO - PROCESS | 13573 | __metrics 14:06:34 ERROR - PROCESS | 13573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:06:35 INFO - TEST-INFO | 13573: exit 0 14:06:35 INFO - Browser initialized. 14:06:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:35 INFO - TEST-INFO | started process 13693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_m8wn1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:47 INFO - PROCESS | 13693 | RSS: Main: 184848384 14:06:47 INFO - PROCESS | 13693 | 14:07:37 INFO - PROCESS | 13693 | 1466888857148 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] 14:09:45 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36337/tests/dromaeo/cssquery-ext.html) 14:09:46 INFO - PROCESS | 13693 | RSS: Main: 188932096 14:09:46 INFO - PROCESS | 13693 | 14:12:48 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-ext.html (next: http://localhost:36337/tests/dromaeo/cssquery-jquery.html) 14:12:48 INFO - PROCESS | 13693 | RSS: Main: 187617280 14:12:48 INFO - PROCESS | 13693 | 14:15:50 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36337/tests/dromaeo/cssquery-mootools.html) 14:15:51 INFO - PROCESS | 13693 | RSS: Main: 189452288 14:15:51 INFO - PROCESS | 13693 | 14:18:53 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36337/tests/dromaeo/cssquery-prototype.html) 14:18:53 INFO - PROCESS | 13693 | RSS: Main: 186249216 14:18:53 INFO - PROCESS | 13693 | 14:21:56 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36337/tests/dromaeo/cssquery-yui.html) 14:21:56 INFO - PROCESS | 13693 | RSS: Main: 188231680 14:21:56 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | Cycle 1(1): loaded http://localhost:36337/tests/dromaeo/cssquery-yui.html (next: http://localhost:36337/tests/dromaeo/cssquery-dojo.html) 14:24:59 INFO - PROCESS | 13693 | RSS: Main: 189038592 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | __start_tp_report 14:24:59 INFO - PROCESS | 13693 | _x_x_mozilla_page_load 14:24:59 INFO - PROCESS | 13693 | _x_x_mozilla_page_load_details 14:24:59 INFO - PROCESS | 13693 | |i|pagename|runs| 14:24:59 INFO - PROCESS | 13693 | |0;dojo.html;3060.1737530866667;3066.6779988101234;3106.5961425014757;3110.3623757129785;3121.859516321765;5369.087255166626;5383.353997520293;5393.244945707599;5397.4332695067;5398.379186393566;5244.947550524503;5300.92048619271;5351.785928562863;5357.357117145938;5467.589930755189;4815.951840481585;4863.294822250771;4935.802567897298;4990.4011518617635;5033.11920413928;729.346077727708;4789.928151077736;4846.442659094197;4869.464358920516;4926.827561035365;4892.804287828482;4911.5088491150955;4916.754162291871;4918.729469879156;4938.530839570235;4889.211696697744;4910.042541704369;4915.483874193194;4942.555170034714;4955.925661115086;4747.192977193886;4781.115493633689;4796.904061918777;4812.975935120337;4913.705177689314;5288.0745869472685;5297.788088476456;5342.599305052097;5387.4073851876265;5418.106012507931;5592.245046918654;5763.452472015152;5774.5091667208335;5776.191333213312;5781.219535362714;5701.059325211335;5724.570657200685;5761.078227483583;5782.768689252425;5810.215620891167;5433.972830135864;5438.075527160392;5444.5916556258435;5451.563874889999;5454.127339625641;5707.6575405475805;5876.823695289148;5892.351841297454;5893.410658934158;5907.911381329283;5727.570432217601;5731.713414329267;5754.223179870748;5766.279215098113;5795.681237531976;5753.741081651336;5771.365149833515;5823.388544202882;5827.79602713903;5831.970840145772;5540.7783688652;5702.942970570324;5746.798862039808;5790.449907258803;5818.679972601548;5687.7156142192725;5688.23208866806;5694.174344719992;5694.743736531866;5701.857453563694;4355.80398882051;4388.670849686287;4403;4407.162639098561;4412.095520418371;3884.7863367515056;3894.4742459767567;3915.7258991870294;3936.566977632458;3964.7224694271126;5314.946850531445;5367.114426119724;5387.622866399314;5415.4313797050745;5450.482204190595;5710.885782284414;5768.3366412862215;5773.8556536086935;5778.971105144447;5788;5316.3354580677415;5426.321709786277;5434.673919564839;5464.153056276284;5499.367572729107;4943.65394422387;4966.1061009018;4983.177775667047;4994.625403094782;5066.771995260148;5879.647221166743;5972.104184372379;5986.102084687332;5988;5994.67029313392;5718.714064296852;5759.625624334405;5768.451997060272;5806.477417032487;5822.82531524055;5989.760409583742;5991.520678345635;5993.9700301498215;6012.128241405059;6020.6688632123905;5492.725363731717;5624.128260119688;5724.284464441945;5732.5413966881715;5737.254156959735;5765.077587585966;5830.591858569859;5830.82507524775;5833.649981001154;5884.882302353843;5615.410381910004;5623.606347555632;5625.353084395347;5653.547716182778;5665;5522.861928451821;5594.440555944373;5612.074007788669;5675.489205971482;5676.659400435987;5532;5539.335279766454;5539.750711217925;5542.667439953616;5582.385937546947;5604.3835178131185;5615.101583746581;5623.2127502148915;5640.238567793295;5648.2092507049865;5398.1093119634825;5481.424450432647;5507.201455788808;5530.714044396723;5560.666360018412 14:24:59 INFO - PROCESS | 13693 | |1;ext.html;566.9092945128778;614.1800696070745;618.1130078337583;637.8086574027792;652.0610321137565;37396.439053414186;41479.37780933289;41501;41510.377344339824;41522.37716434252;41910.79044604773;42195.57804421955;42294.788526057324;42368.78815605918;42622.57377426225;8593.355498337634;8776.517291548962;8804.251638610725;8827;8832.293416526694;8735.21383075523;8822.823543529157;8826.691065812698;8833.20501154896;8835.64657413706;8852.822943541125;8867.955660221689;8892.421992570462;8898;8903.554822258893;8787.912120878806;8801.735947921605;8812.471251724854;8825.161609647073;8849.159329863653;8624.956875215647;8693.478391296543;8723.781905452352;8726.956365218197;8760.561971901443;38851.611483885084;39119.80440097781;39236.411453828216;39334.80332598319;39344.80327598344;2942.396808654221;3314.685104915029;3526.2066035142143;3552.928941421183;3590.2281009582803;29664.406711865642;30198.69801301981;30226.84886575575;30588.54117188244;31089.37821243585;4008.8997775055564;4153.335466325373;4193.1404062167185;4246.8725938221905;4328.069465065026;316390;318521;319544;319648;321132;29646.55530167049;29848.25379365533;29849.701502985128;29968.400631987675;33257.3348533028;34085.659143408746;35902.64097358993;36011;36067;36216.637833621855;14526.20105894186;14683.265836708122;14685.926570367294;14704.117752934859;14717;11192.832107518394;11300.886991130148;11308.71728206785;11336.036436902956;11341.886581134248;6907.481938854606;6927.653617319113;6976.720931162697;6998.790036298919;7032.08582884232;3190.920226994344;3247.8863239786965;3250.236194494292;3285.4414749492644;3286.802791832498;993.1607791416242;1029.5161274201114;1086.4513420722485;1088.450332582041;1108.5731993182521;30232.395352092833;31360;31910.521342179887;32053.19867003297;32764.67235327616;1064.5209655654987;1092.2136062035322;1151.3609946479617;1206.2943178240653;1213.50246398976;16012;16910.57723556921;16912.57718557046;17028.404005859982;17046.914765426092;534871;534875.9537213889;544767;545038;547020;55590;56172.719136404055;56431.43568564344;56456;56500.71749641225;1315.1451556488169;1353.350391811916;1357.2195987307339;1374.1892283552752;1379.5516457151266;30342.241443964078;31486.425678715514;31649.683503164673;31806.68193318037;32155.51766723548;50576.74711626566;51101.744491277306;51295.48704512907;51396.48603513917;51472.22791658053;481537;486415;488611;492883;493670;24039.879800600884;24134.396640083436;24198.51602967966;24326.756732433158;24350.02599896055;45561.31658025199;46776.7661161692;47339.289910652056;47874.281885771044;48194.51805482041;40436.393454097626;40853;41021.179576408904;41834.79082604689;42161.57838421576;39783.00542486461;39879.17214977803;41295;41468.585314146476;41634.375484368364;40282.395764064146;40384.79807600943;40502.79748601238;40586.594134059465;41352.58647413487;35038.82480587683;37049.44425833668;37189;38952.80523597364;39348.40977385284;27996.58005129884;28231.294217644725;28331.57502637421;28583.714162858105;28680.856595716887 14:24:59 INFO - PROCESS | 13693 | |2;jquery.html;380.4521489055761;380.9921712574731;386.33550293495193;397.4554859842017;400.18961602754416;17525.386611468602;18536.258549657996;19510;19912.303069392576;19942.40172794815;16787.91606041971;17047.829521704778;17111.40110096147;17213.22540485678;18420.355287564937;5618.12918997555;5727.570432217601;5817.331006934214;5843.883122337551;5851.970740146293;5532.3914369419535;5642.6614403135945;5643.5767317451355;5672.631278966875;5675.2622159119255;5545.861353466175;5575.776968921238;5634.3802181760175;5638.351589567191;5647.915281270784;5572.60991730579;5585.497305242528;5637.098064309732;5764.365919748824;5766.740496677659;5022.096022715909;5096.694198348111;5103.8468845934685;5106.055379754757;5135.563477104451;16398.344066237336;16423;20508.38474845757;21827.271591051118;22368;2544.834585751939;2594.2087663262696;2626.0808716949105;2926.3708302714804;2946.911592652224;14011.929940350234;14210.289485525682;14333.78499322511;14526.346314415876;14543.27283635814;1935.680612698917;1937.4962509747427;1946.26042104001;2003.729496517966;2044.2640649366217;48317.516824831655;53512.464875351136;60481.395186048016;72278.27721722767;73924.6303768483;10031.799364012679;10208;10278.640247591298;10358.637447689294;10499.107575855985;13640.113392629448;13701.45194192241;13778.379972901244;13878.375473103735;13882.583522494342;7738.651760670783;7875.212478752193;7911.960440197762;8016;8047.356211503065;7736.110347310131;7767.72812951544;7833.1775163608145;7882.645280962371;8006.279434850891;6390.776322828771;6411.198600174978;6434.099226108348;6521.380468855451;6556.475481961432;1746.8469412709926;1805.954851128706;1813.7007393780143;1927.633749587574;1948.259661328686;807.4428644235459;857.7083791510792;864.2826454043254;900.4822227219375;910.1444642036464;17601.074145904615;17895.194716237802;17929.551761205814;17942.641147176982;18120.184591693407;857.691231156783;862.2886118951765;862.4307956748515;902.5442151713474;916.3997581584073;9788.951055244679;10082.647107351208;10084.546195421077;10111.140553052926;10140.492975351202;429114;430215;433695;452443;459902;74588.62705686437;76544.2345576537;76891.61554192193;77027.61486192534;77680;913.7578541686325;961.9038096190325;969.4958621516772;972.3193764364831;983.9409635421897;16714.247858846138;17210.91394543019;17217.91391043037;17671.558211044827;17873.73189402134;29191.562126568544;38481;40364.394534081424;41569;42746.35880461733;58153.12770308364;59662.40337596568;59717.701411492664;59747.701261493414;59977.40022599718;8054.516728996279;8183.71357002502;8351.916480835114;8359.955005624297;8421.19998600132;8813.515256660688;12425.62723118308;12878.67803304925;12950.935245323713;13255.204687718768;10851.67444976652;10887.945560272148;11394.772104558027;11609.477573509044;11652.88347116518;11200.10399168081;11424.657260282205;11690.649280521598;11807.350595717318;11825.822612660644;11548.59579914699;11773.52905883755;11819.349935753617;11834.881651183377;11895.583654572049;8186.7953301167945;8229.218224268685;8233.300169485661;8264;8578.871316930126;10211;11535.884641153481;11536.538538458703;11686.532538698357;11688.532458701897 14:24:59 INFO - PROCESS | 13693 | |3;mootools.html;1373.2653030628612;1396.3297617143771;1447.8986470947032;1605.6547842213922;1606.3735143294118;6802.863942721143;7872.76381708549;7940.2853743163105;8378.497290162586;8381.41330106892;8013.439059265854;8223.588820558964;8247.876281855777;8310.376721745863;8338.374621903351;2201.6477363621825;2209.1826024371007;2223.1552010236087;2225.94435139122;2228.888555572223;2165.4261620670536;2173.7608863025052;2220.622494175986;2224.2659922225625;2226.7661895500983;2168.3169801512554;2175.445261458334;2180.563887222554;2185.7049298344677;2186.0381432169875;2174.858634188781;2175.4778853075304;2177.433867194533;2189.5839790439763;2194.7366316042176;2108.2726459371493;2123.9256626018014;2147.452399638082;2152.2789865394957;2157.8597391169683;8304.916950830475;8358.331333493366;8369.037560680477;8380.413371064027;8406.537640429773;4703.553162449562;4787.760611969387;4819.879503012453;4824.782884770194;4830.058138662962;3142.073088438916;3173.9682603173906;3205.1506350817053;3263.102646772133;3283.4746440569634;1093.4150229627191;1118.759466714652;1130.6494986554194;1147.6671765188084;1155.2779512804498;11383.260088094248;11409.828852567218;11443.828342574869;11458.541658333657;11482.540698372055;4190.161967606491;4273.97863010683;4294.82820687169;4304.332828411601;4322.1139666368945;9597.896241932127;9651.372660777168;9665.90334096664;9698.70903872885;9761.951190244003;4801.567858892717;4827.710337379768;4892.461829198785;4892.68197567157;4893.119238537098;3786.583475817658;4357.869263922087;4412.602865742098;4507.977460112678;4518.88702782433;3626.256617393428;3644.9635503645154;3737.32728108943;3758.3986562149926;3860.324443222481;1139.2367114033618;1145.5646854195352;1163.8894305041008;1167.3287859480834;1173.6244401791516;907.7140700679265;918.0681608167581;928.0626567167075;929.4655573045391;938.7043081429327;5433.26650902131;6014.338422773491;6106.969465152734;6196;6388.840278993062;929.0987741890356;943.7687766497252;946.9573869175766;992.5930368549004;996.6262651505685;3937.2912875682077;4144.129732756155;4371.30059190528;4463.955360446419;4486.282194848808;9847.473641585566;9863.112319891245;10005.749856253651;10016.699499015042;10079.193664506822;9802.313838031268;9891.159251463563;9942.154916832005;9942.552585133686;10001.899981000242;7325.084364454443;7616.543007419684;7661.195574464712;7719.691212351443;7921.168277330912;5874.353821079592;6020.066889632114;6136.417040381157;6138.478229350555;6155.84610384744;9491.572879220314;9516.19112375428;9545.522723863918;9555.283353748358;9589.808203836024;9325.440473571607;9497.762555936157;9743.512824358895;9793.755156121155;9854.802903942025;6332.778352757631;7067.893981590178;7148.535345202546;7200.71197152108;7346.191918889025;7964;8023.6790528378215;8076.394270429624;8084.7574572762915;8120.187981201832;7123.643817809192;7382.778516644509;7416.147143078615;7443.330100290783;7571.659275332733;7331.114196010392;7370.705171793068;7449.627518623939;7489.550626962399;7497.475176737794;6891.173059232724;6904.378605925491;6953.478489113236;6985.126859142607;7013.929860701532;4955.925661115014;4998.525140111684;5140.074786538309;5142.04872098663;5146.150885103916;5076.441591425014;5101.3113229715;5178;5227.320448341691;5328.280682107866 14:24:59 INFO - PROCESS | 13693 | |4;prototype.html;291.714120162241;302.8697660006198;307.40977323538806;307.64620686210867;308.03277707996887;5453.727313634322;5562.721863906809;5617.707927176747;5639.069553523669;5642.605017648766;5643.915341269884;5644.633098848582;5655.095184770437;5657.23627310314;5700.486956173943;4251.4898212214575;4326.178026175016;4336.392904993311;4339.566043395666;4343.956560434387;4054.2499637567;4272.957270427302;4295.1839150561445;4315.892102697427;4318.654507639381;4228.196642637904;4230.788460576974;4235.2800023996;4257.191133684605;4267.4452321198205;4266.656003358948;4281.336392859112;4304.827806887721;4313.956860431387;4325.567443255681;3544.432890737495;3773.8301776419853;3775.432705760082;3784.1485665725268;3789.3368660484307;5506.944930550683;5532.119079512985;5536.474034966672;5578.748956296977;5581.5813813963705;4910.337104490919;4917.557419832232;4945.23348880924;4955.975220123913;4962.826301079445;5625.606207565472;5912.3496415394275;5940.851478713023;5965.910511342333;6005.249343832021;4010.418489319062;4027.2146931348398;4077.97961010196;4078.2047500737367;4102.425660407545;6193.87612247757;6259.7777788885205;6295.811125666283;6302.653354065525;6312;4107.466029416157;4163.562825903297;4176.33178691414;4222.535521092677;4233.809478573472;4188.204241194224;4221.155768846182;4238.279492486223;4244.8514301999285;4253.894322310476;4900.950990490121;4940.7035577865445;4941.555260026615;4957.082939656103;4963.875903102379;5865.618734782311;5977.521798256129;5979.4618484336615;6014.248218972629;6030.517558595302;1401.3763875075697;1419.5386499387741;1423.843377228504;1444.5521888214687;1447.6163816588612;878.4202426398547;887.2148148888151;911.9635214591475;918.4626993208914;921.9769505762409;4956.463496316153;4994.600431965507;5000.549950504472;5024;5126;5377.973110134424;5484.506394424521;5491.643043202179;5500.3949565547755;5509;4952.811325281907;5113.821016264487;5116.9744151279;5132.561184006724;5158.690478571298;2891.334992951633;2918.2558447596152;2944.7938644294695;2947.4504553561014;2951.2621844538867;5441.945580544223;5529.30883639545;5529.834104976857;5575.888482230333;5598.944010559842;5237.895242095136;5470.370907345627;5498.395176530578;5518.117101263779;5533.810230800397;5543.805966791143;5552.7223638817895;5585.1901474286005;5587.413321601254;5595.832125036174;5153.871153221199;5357.044678692328;5379.9778042171865;5487.75305111263;5531.695756733418;5299.44355842631;5313.459096861867;5318.760655770422;5400.513953744182;5403.756830942696;5651.745671444877;5652.7738890443925;5677.5457963362005;5681.886362272814;6044.153818465506;4089.711740801638;4165.791710414528;4166.458360413127;4178.603032711888;4191.7484950903045;6018.548608854266;6077.848053798691;6118.980736357081;6150.785717141915;6170.81487555374;5801.883962320646;5849.795257165979;5968.46283834457;5990.191324171181;5998.970005149947;5840.561957853263;5924.52603791687;5935.436133567304;5940.257467816523;5977.701114944322;5759.683217422914;5777;5801.781625858617;5805.593608447368;5842.941570584239;5646.689432081111;6019.638821670714;6021.277446706248;6044.395560443921;6090.20339000005;5911.408859114226;5945.167676525203;5962.1951036611235;5980.9401905980385;6000.909986350295 14:24:59 INFO - PROCESS | 13693 | |5;yui.html;744.9942577520349;758.7875394889431;789.1516619633892;807.3097501636097;813.9023317201935;14581.70836583269;15043.699126017473;15898.20508974551;15910.522684319489;16007.19964001801;13988.930055349734;14108;14108.717825643482;14166.716665666681;14201.786973195385;739.9112106547221;741.5995362504241;743.4015617427968;746.283567774934;749.6439191384103;627.4572494792018;709.8686742952544;721.9602921839297;723.4284914917209;731.2614259597818;785.4030936488282;789.1161898673465;790.9683612655487;791.4657606115877;793.1909452358591;780.5706861226303;783.2637320918348;783.902012248469;787.3347021766598;790.9683612655487;567.3305499510576;569.4533248081847;569.9458551437607;570.1020892094925;572.4247131632724;14287;14337.35481903317;14406.207658578774;14417.13497190172;14473.42106315746;14567.781483277759;14747.926260368737;15101.773473397909;15286.388544458208;15286.617834554114;12182.390880455941;12270.877291227063;12272.631821045383;12353.135280530367;12426.5650702225;3846.5961074087377;3883.262180185756;3907.433422153772;3910.432987216838;3944;70225;70392.2960770396;70622.29377706209;72704.27295727028;75108.99999999945;11263.887361126448;11273.830892536618;11387.316760994367;11456.99502587044;11575.594854180063;21394.35816925495;21522.461938451663;21608.459788505414;21645.242416515346;21845.781542184694;8644.567771611395;8794.736157915273;8845.115488451103;8896.110388961182;8962.596683149273;4603.700759450692;4749.121412538691;4888.437829649564;5076.695398276115;5125.051865404912;3464.34177506273;3587.5694916610173;3588.049166970755;3589.3718599245026;3600.1539638185004;583.8102616649605;594.7918228619949;601.2994860986988;609.7073404765737;610.9205803245638;693.2478261086777;723.479095051562;741.3735393592406;765.2806362019684;765.4412279036223;9871.605135794487;10021.448820314807;10110.090091891765;10202.693919182437;10258.333208341433;635.659921941759;671.2917871645363;709.7409445552336;728.1517032656895;728.639323534843;4910.189818679878;4985.252212168204;5089.160288552422;5115.309433226541;5141.2545180948555;112575.43712281386;113488;116142;118824.40587797179;120504.39747801205;101689;102169;102480.48759756153;103926;104070;86461.99999999875;87093;87282.56358718166;88403.11596883948;89752.10247897437;8986.955065224633;9060.456372617664;9231.399959002643;9598.712038638852;9632.229421646392;44098.338524922794;47480;49172;49506.25740613822;51497.7425112887;72716.63641681758;76187.61906190433;76192.23807761852;76417;77085.22914770781;11453.885461145283;11483.483243253906;11488.368139752394;11607;11714.531418743154;12871.292078935749;13451.932740336235;13501.729965400833;13642.386092625657;13810.10234334765;12209.877901220874;12556.497740090294;12599.18105323151;12697.779086186994;12836.486540538273;12132.696682583006;12251.203671761306;12285.57000504978;12975.675608109872;12988;12221.755564888475;12377.876221237673;12500.06249531307;12838.42227099764;12839.037072219808;10072.395656260647;10425;10512.811553110567;10660.573577056832;10660.774010988836;9983.750406239902;10653;10698;10756.892431075588;10903.83644245321 14:24:59 INFO - PROCESS | 13693 | __end_tp_report 14:24:59 INFO - PROCESS | 13693 | __start_cc_report 14:24:59 INFO - PROCESS | 13693 | _x_x_mozilla_cycle_collect,350 14:24:59 INFO - PROCESS | 13693 | __end_cc_report 14:24:59 INFO - PROCESS | 13693 | __startTimestamp1466889899448__endTimestamp 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | ------- Summary: start ------- 14:24:59 INFO - PROCESS | 13693 | Number of tests: 6 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#0] dojo.html Cycles:165 Average:5320.67 Median:5539.75 stddev:709.64 (12.8%) stddev-sans-first:689.30 14:24:59 INFO - PROCESS | 13693 | Values: 3060.2 3066.7 3106.6 3110.4 3121.9 5369.1 5383.4 5393.2 5397.4 5398.4 5244.9 5300.9 5351.8 5357.4 5467.6 4816.0 4863.3 4935.8 4990.4 5033.1 729.3 4789.9 4846.4 4869.5 4926.8 4892.8 4911.5 4916.8 4918.7 4938.5 4889.2 4910.0 4915.5 4942.6 4955.9 4747.2 4781.1 4796.9 4813.0 4913.7 5288.1 5297.8 5342.6 5387.4 5418.1 5592.2 5763.5 5774.5 5776.2 5781.2 5701.1 5724.6 5761.1 5782.8 5810.2 5434.0 5438.1 5444.6 5451.6 5454.1 5707.7 5876.8 5892.4 5893.4 5907.9 5727.6 5731.7 5754.2 5766.3 5795.7 5753.7 5771.4 5823.4 5827.8 5832.0 5540.8 5702.9 5746.8 5790.4 5818.7 5687.7 5688.2 5694.2 5694.7 5701.9 4355.8 4388.7 4403.0 4407.2 4412.1 3884.8 3894.5 3915.7 3936.6 3964.7 5314.9 5367.1 5387.6 5415.4 5450.5 5710.9 5768.3 5773.9 5779.0 5788.0 5316.3 5426.3 5434.7 5464.2 5499.4 4943.7 4966.1 4983.2 4994.6 5066.8 5879.6 5972.1 5986.1 5988.0 5994.7 5718.7 5759.6 5768.5 5806.5 5822.8 5989.8 5991.5 5994.0 6012.1 6020.7 5492.7 5624.1 5724.3 5732.5 5737.3 5765.1 5830.6 5830.8 5833.6 5884.9 5615.4 5623.6 5625.4 5653.5 5665.0 5522.9 5594.4 5612.1 5675.5 5676.7 5532.0 5539.3 5539.8 5542.7 5582.4 5604.4 5615.1 5623.2 5640.2 5648.2 5398.1 5481.4 5507.2 5530.7 5560.7 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#1] ext.html Cycles:180 Average:58523.01 Median:39831.09 stddev:122514.14 (307.6%) stddev-sans-first:122780.54 14:24:59 INFO - PROCESS | 13693 | Values: 566.9 614.2 618.1 637.8 652.1 37396.4 41479.4 41501.0 41510.4 41522.4 41910.8 42195.6 42294.8 42368.8 42622.6 8593.4 8776.5 8804.3 8827.0 8832.3 8735.2 8822.8 8826.7 8833.2 8835.6 8852.8 8868.0 8892.4 8898.0 8903.6 8787.9 8801.7 8812.5 8825.2 8849.2 8625.0 8693.5 8723.8 8727.0 8760.6 38851.6 39119.8 39236.4 39334.8 39344.8 2942.4 3314.7 3526.2 3552.9 3590.2 29664.4 30198.7 30226.8 30588.5 31089.4 4008.9 4153.3 4193.1 4246.9 4328.1 316390.0 318521.0 319544.0 319648.0 321132.0 29646.6 29848.3 29849.7 29968.4 33257.3 34085.7 35902.6 36011.0 36067.0 36216.6 14526.2 14683.3 14685.9 14704.1 14717.0 11192.8 11300.9 11308.7 11336.0 11341.9 6907.5 6927.7 6976.7 6998.8 7032.1 3190.9 3247.9 3250.2 3285.4 3286.8 993.2 1029.5 1086.5 1088.5 1108.6 30232.4 31360.0 31910.5 32053.2 32764.7 1064.5 1092.2 1151.4 1206.3 1213.5 16012.0 16910.6 16912.6 17028.4 17046.9 534871.0 534876.0 544767.0 545038.0 547020.0 55590.0 56172.7 56431.4 56456.0 56500.7 1315.1 1353.4 1357.2 1374.2 1379.6 30342.2 31486.4 31649.7 31806.7 32155.5 50576.7 51101.7 51295.5 51396.5 51472.2 481537.0 486415.0 488611.0 492883.0 493670.0 24039.9 24134.4 24198.5 24326.8 24350.0 45561.3 46776.8 47339.3 47874.3 48194.5 40436.4 40853.0 41021.2 41834.8 42161.6 39783.0 39879.2 41295.0 41468.6 41634.4 40282.4 40384.8 40502.8 40586.6 41352.6 35038.8 37049.4 37189.0 38952.8 39348.4 27996.6 28231.3 28331.6 28583.7 28680.9 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#2] jquery.html Cycles:180 Average:26418.40 Median:40966.70 stddev:72431.07 (176.8%) stddev-sans-first:72607.87 14:24:59 INFO - PROCESS | 13693 | Values: 380.5 381.0 386.3 397.5 400.2 17525.4 18536.3 19510.0 19912.3 19942.4 16787.9 17047.8 17111.4 17213.2 18420.4 5618.1 5727.6 5817.3 5843.9 5852.0 5532.4 5642.7 5643.6 5672.6 5675.3 5545.9 5575.8 5634.4 5638.4 5647.9 5572.6 5585.5 5637.1 5764.4 5766.7 5022.1 5096.7 5103.8 5106.1 5135.6 16398.3 16423.0 20508.4 21827.3 22368.0 2544.8 2594.2 2626.1 2926.4 2946.9 14011.9 14210.3 14333.8 14526.3 14543.3 1935.7 1937.5 1946.3 2003.7 2044.3 48317.5 53512.5 60481.4 72278.3 73924.6 10031.8 10208.0 10278.6 10358.6 10499.1 13640.1 13701.5 13778.4 13878.4 13882.6 7738.7 7875.2 7912.0 8016.0 8047.4 7736.1 7767.7 7833.2 7882.6 8006.3 6390.8 6411.2 6434.1 6521.4 6556.5 1746.8 1806.0 1813.7 1927.6 1948.3 807.4 857.7 864.3 900.5 910.1 17601.1 17895.2 17929.6 17942.6 18120.2 857.7 862.3 862.4 902.5 916.4 9789.0 10082.6 10084.5 10111.1 10140.5 429114.0 430215.0 433695.0 452443.0 459902.0 74588.6 76544.2 76891.6 77027.6 77680.0 913.8 961.9 969.5 972.3 983.9 16714.2 17210.9 17217.9 17671.6 17873.7 29191.6 38481.0 40364.4 41569.0 42746.4 58153.1 59662.4 59717.7 59747.7 59977.4 8054.5 8183.7 8351.9 8360.0 8421.2 8813.5 12425.6 12878.7 12950.9 13255.2 10851.7 10887.9 11394.8 11609.5 11652.9 11200.1 11424.7 11690.6 11807.4 11825.8 11548.6 11773.5 11819.3 11834.9 11895.6 8186.8 8229.2 8233.3 8264.0 8578.9 10211.0 11535.9 11536.5 11686.5 11688.5 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#3] mootools.html Cycles:180 Average:5486.75 Median:5162.08 stddev:3062.07 (59.3%) stddev-sans-first:3055.05 14:24:59 INFO - PROCESS | 13693 | Values: 1373.3 1396.3 1447.9 1605.7 1606.4 6802.9 7872.8 7940.3 8378.5 8381.4 8013.4 8223.6 8247.9 8310.4 8338.4 2201.6 2209.2 2223.2 2225.9 2228.9 2165.4 2173.8 2220.6 2224.3 2226.8 2168.3 2175.4 2180.6 2185.7 2186.0 2174.9 2175.5 2177.4 2189.6 2194.7 2108.3 2123.9 2147.5 2152.3 2157.9 8304.9 8358.3 8369.0 8380.4 8406.5 4703.6 4787.8 4819.9 4824.8 4830.1 3142.1 3174.0 3205.2 3263.1 3283.5 1093.4 1118.8 1130.6 1147.7 1155.3 11383.3 11409.8 11443.8 11458.5 11482.5 4190.2 4274.0 4294.8 4304.3 4322.1 9597.9 9651.4 9665.9 9698.7 9762.0 4801.6 4827.7 4892.5 4892.7 4893.1 3786.6 4357.9 4412.6 4508.0 4518.9 3626.3 3645.0 3737.3 3758.4 3860.3 1139.2 1145.6 1163.9 1167.3 1173.6 907.7 918.1 928.1 929.5 938.7 5433.3 6014.3 6107.0 6196.0 6388.8 929.1 943.8 947.0 992.6 996.6 3937.3 4144.1 4371.3 4464.0 4486.3 9847.5 9863.1 10005.7 10016.7 10079.2 9802.3 9891.2 9942.2 9942.6 10001.9 7325.1 7616.5 7661.2 7719.7 7921.2 5874.4 6020.1 6136.4 6138.5 6155.8 9491.6 9516.2 9545.5 9555.3 9589.8 9325.4 9497.8 9743.5 9793.8 9854.8 6332.8 7067.9 7148.5 7200.7 7346.2 7964.0 8023.7 8076.4 8084.8 8120.2 7123.6 7382.8 7416.1 7443.3 7571.7 7331.1 7370.7 7449.6 7489.6 7497.5 6891.2 6904.4 6953.5 6985.1 7013.9 4955.9 4998.5 5140.1 5142.0 5146.2 5076.4 5101.3 5178.0 5227.3 5328.3 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#4] prototype.html Cycles:180 Average:4781.65 Median:5447.84 stddev:1424.15 (26.1%) stddev-sans-first:1387.70 14:24:59 INFO - PROCESS | 13693 | Values: 291.7 302.9 307.4 307.6 308.0 5453.7 5562.7 5617.7 5639.1 5642.6 5643.9 5644.6 5655.1 5657.2 5700.5 4251.5 4326.2 4336.4 4339.6 4344.0 4054.2 4273.0 4295.2 4315.9 4318.7 4228.2 4230.8 4235.3 4257.2 4267.4 4266.7 4281.3 4304.8 4314.0 4325.6 3544.4 3773.8 3775.4 3784.1 3789.3 5506.9 5532.1 5536.5 5578.7 5581.6 4910.3 4917.6 4945.2 4956.0 4962.8 5625.6 5912.3 5940.9 5965.9 6005.2 4010.4 4027.2 4078.0 4078.2 4102.4 6193.9 6259.8 6295.8 6302.7 6312.0 4107.5 4163.6 4176.3 4222.5 4233.8 4188.2 4221.2 4238.3 4244.9 4253.9 4901.0 4940.7 4941.6 4957.1 4963.9 5865.6 5977.5 5979.5 6014.2 6030.5 1401.4 1419.5 1423.8 1444.6 1447.6 878.4 887.2 912.0 918.5 922.0 4956.5 4994.6 5000.5 5024.0 5126.0 5378.0 5484.5 5491.6 5500.4 5509.0 4952.8 5113.8 5117.0 5132.6 5158.7 2891.3 2918.3 2944.8 2947.5 2951.3 5441.9 5529.3 5529.8 5575.9 5598.9 5237.9 5470.4 5498.4 5518.1 5533.8 5543.8 5552.7 5585.2 5587.4 5595.8 5153.9 5357.0 5380.0 5487.8 5531.7 5299.4 5313.5 5318.8 5400.5 5403.8 5651.7 5652.8 5677.5 5681.9 6044.2 4089.7 4165.8 4166.5 4178.6 4191.7 6018.5 6077.8 6119.0 6150.8 6170.8 5801.9 5849.8 5968.5 5990.2 5999.0 5840.6 5924.5 5935.4 5940.3 5977.7 5759.7 5777.0 5801.8 5805.6 5842.9 5646.7 6019.6 6021.3 6044.4 6090.2 5911.4 5945.2 5962.2 5980.9 6000.9 14:24:59 INFO - PROCESS | 13693 | 14:24:59 INFO - PROCESS | 13693 | [#5] yui.html Cycles:180 Average:20636.09 Median:3908.93 stddev:30229.90 (773.4%) stddev-sans-first:30277.80 14:24:59 INFO - PROCESS | 13693 | Values: 745.0 758.8 789.2 807.3 813.9 14581.7 15043.7 15898.2 15910.5 16007.2 13988.9 14108.0 14108.7 14166.7 14201.8 739.9 741.6 743.4 746.3 749.6 627.5 709.9 722.0 723.4 731.3 785.4 789.1 791.0 791.5 793.2 780.6 783.3 783.9 787.3 791.0 567.3 569.5 569.9 570.1 572.4 14287.0 14337.4 14406.2 14417.1 14473.4 14567.8 14747.9 15101.8 15286.4 15286.6 12182.4 12270.9 12272.6 12353.1 12426.6 3846.6 3883.3 3907.4 3910.4 3944.0 70225.0 70392.3 70622.3 72704.3 75109.0 11263.9 11273.8 11387.3 11457.0 11575.6 21394.4 21522.5 21608.5 21645.2 21845.8 8644.6 8794.7 8845.1 8896.1 8962.6 4603.7 4749.1 4888.4 5076.7 5125.1 3464.3 3587.6 3588.0 3589.4 3600.2 583.8 594.8 601.3 609.7 610.9 693.2 723.5 741.4 765.3 765.4 9871.6 10021.4 10110.1 10202.7 10258.3 635.7 671.3 709.7 728.2 728.6 4910.2 4985.3 5089.2 5115.3 5141.3 112575.4 113488.0 116142.0 118824.4 120504.4 101689.0 102169.0 102480.5 103926.0 104070.0 86462.0 87093.0 87282.6 88403.1 89752.1 8987.0 9060.5 9231.4 9598.7 9632.2 44098.3 47480.0 49172.0 49506.3 51497.7 72716.6 76187.6 76192.2 76417.0 77085.2 11453.9 11483.5 11488.4 11607.0 11714.5 12871.3 13451.9 13501.7 13642.4 13810.1 12209.9 12556.5 12599.2 12697.8 12836.5 12132.7 12251.2 12285.6 12975.7 12988.0 12221.8 12377.9 12500.1 12838.4 12839.0 10072.4 10425.0 10512.8 10660.6 10660.8 9983.8 10653.0 10698.0 10756.9 10903.8 14:24:59 INFO - PROCESS | 13693 | -------- Summary: end -------- 14:24:59 INFO - PROCESS | 13693 | 14:25:00 INFO - TEST-INFO | 13693: exit 0 14:25:00 INFO - TEST-OK | dromaeo_css | took 1111881ms 14:25:00 INFO - TEST-START | kraken 14:25:00 INFO - operating with platform_type : linux_ 14:25:00 INFO - Initialising browser for kraken test... 14:25:00 INFO - TEST-INFO | started process 13932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoI4PLa/profile http://localhost:36337/getInfo.html) 14:25:05 INFO - PROCESS | 13932 | __metrics Screen width/height:1600/1200 14:25:05 INFO - PROCESS | 13932 | colorDepth:24 14:25:05 INFO - PROCESS | 13932 | Browser inner width/height: 1024/697 14:25:05 INFO - PROCESS | 13932 | __metrics 14:25:06 ERROR - PROCESS | 13932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:25:07 INFO - TEST-INFO | 13932: exit 0 14:25:07 INFO - Browser initialized. 14:25:07 INFO - Running cycle 1/1 for kraken test... 14:25:07 INFO - TEST-INFO | started process 14052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoI4PLa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:19 INFO - PROCESS | 14052 | RSS: Main: 184975360 14:25:19 INFO - PROCESS | 14052 | 14:25:21 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36337/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:22 INFO - PROCESS | 14052 | RSS: Main: 190300160 14:25:22 INFO - PROCESS | 14052 | 14:25:25 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36337/tests/kraken/driver.html?testName=audio-dft) 14:25:25 INFO - PROCESS | 14052 | RSS: Main: 189542400 14:25:25 INFO - PROCESS | 14052 | 14:25:28 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36337/tests/kraken/driver.html?testName=audio-fft) 14:25:29 INFO - PROCESS | 14052 | RSS: Main: 184356864 14:25:29 INFO - PROCESS | 14052 | 14:25:31 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36337/tests/kraken/driver.html?testName=audio-oscillator) 14:25:32 INFO - PROCESS | 14052 | RSS: Main: 185499648 14:25:32 INFO - PROCESS | 14052 | 14:25:34 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:35 INFO - PROCESS | 14052 | RSS: Main: 185618432 14:25:35 INFO - PROCESS | 14052 | 14:25:38 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36337/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:38 INFO - PROCESS | 14052 | RSS: Main: 186179584 14:25:38 INFO - PROCESS | 14052 | 14:25:42 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36337/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:42 INFO - PROCESS | 14052 | RSS: Main: 183562240 14:25:42 INFO - PROCESS | 14052 | 14:25:45 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36337/tests/kraken/driver.html?testName=json-parse-financial) 14:25:46 INFO - PROCESS | 14052 | RSS: Main: 184799232 14:25:46 INFO - PROCESS | 14052 | 14:25:48 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:48 INFO - PROCESS | 14052 | RSS: Main: 185233408 14:25:48 INFO - PROCESS | 14052 | 14:25:50 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:51 INFO - PROCESS | 14052 | RSS: Main: 185257984 14:25:51 INFO - PROCESS | 14052 | 14:25:53 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:53 INFO - PROCESS | 14052 | RSS: Main: 186142720 14:25:53 INFO - PROCESS | 14052 | 14:25:56 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:57 INFO - PROCESS | 14052 | RSS: Main: 186208256 14:25:57 INFO - PROCESS | 14052 | 14:25:59 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:00 INFO - PROCESS | 14052 | RSS: Main: 185851904 14:26:00 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | Cycle 1(1): loaded http://localhost:36337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36337/tests/kraken/driver.html?testName=ai-astar) 14:26:02 INFO - PROCESS | 14052 | RSS: Main: 186011648 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | __start_tp_report 14:26:02 INFO - PROCESS | 14052 | _x_x_mozilla_page_load 14:26:02 INFO - PROCESS | 14052 | _x_x_mozilla_page_load_details 14:26:02 INFO - PROCESS | 14052 | |i|pagename|runs| 14:26:02 INFO - PROCESS | 14052 | |0;ai-astar;101;111;105;112;113;114;114;112;110;109 14:26:02 INFO - PROCESS | 14052 | |1;audio-beat-detection;159;141;151;175;130;160;151;129;185;131 14:26:02 INFO - PROCESS | 14052 | |2;audio-dft;162;166;162;161;166;168;163;161;162;162 14:26:02 INFO - PROCESS | 14052 | |3;audio-fft;75;75;75;166;75;76;76;77;164;75 14:26:02 INFO - PROCESS | 14052 | |4;audio-oscillator;86;86;151;85;87;86;151;86;86;152 14:26:02 INFO - PROCESS | 14052 | |5;imaging-gaussian-blur;118;117;118;118;118;117;117;117;117;118 14:26:02 INFO - PROCESS | 14052 | |6;imaging-darkroom;147;148;147;150;147;146;149;147;147;146 14:26:02 INFO - PROCESS | 14052 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;96;96 14:26:02 INFO - PROCESS | 14052 | |8;json-parse-financial;62;62;55;56;55;54;57;55;64;55 14:26:02 INFO - PROCESS | 14052 | |9;json-stringify-tinderbox;63;63;63;62;63;62;62;62;62;63 14:26:02 INFO - PROCESS | 14052 | |10;stanford-crypto-aes;79;86;79;81;80;80;80;81;94;81 14:26:02 INFO - PROCESS | 14052 | |11;stanford-crypto-ccm;131;124;133;137;125;122;121;122;126;121 14:26:02 INFO - PROCESS | 14052 | |12;stanford-crypto-pbkdf2;166;161;163;163;159;158;161;161;159;157 14:26:02 INFO - PROCESS | 14052 | |13;stanford-crypto-sha256-iterative;65;63;65;64;71;62;68;63;63;61 14:26:02 INFO - PROCESS | 14052 | __end_tp_report 14:26:02 INFO - PROCESS | 14052 | __start_cc_report 14:26:02 INFO - PROCESS | 14052 | _x_x_mozilla_cycle_collect,886 14:26:02 INFO - PROCESS | 14052 | __end_cc_report 14:26:02 INFO - PROCESS | 14052 | __startTimestamp1466889962364__endTimestamp 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | ------- Summary: start ------- 14:26:02 INFO - PROCESS | 14052 | Number of tests: 14 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:4.18 (3.7%) stddev-sans-first:2.85 14:26:02 INFO - PROCESS | 14052 | Values: 101.0 111.0 105.0 112.0 113.0 114.0 114.0 112.0 110.0 109.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:19.15 (12.4%) stddev-sans-first:20.11 14:26:02 INFO - PROCESS | 14052 | Values: 159.0 141.0 151.0 175.0 130.0 160.0 151.0 129.0 185.0 131.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:2.45 (1.5%) stddev-sans-first:2.55 14:26:02 INFO - PROCESS | 14052 | Values: 162.0 166.0 162.0 161.0 166.0 168.0 163.0 161.0 162.0 162.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:37.75 (50.3%) stddev-sans-first:39.44 14:26:02 INFO - PROCESS | 14052 | Values: 75.0 75.0 75.0 166.0 75.0 76.0 76.0 77.0 164.0 75.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:86.00 stddev:31.56 (36.7%) stddev-sans-first:32.67 14:26:02 INFO - PROCESS | 14052 | Values: 86.0 86.0 151.0 85.0 87.0 86.0 151.0 86.0 86.0 152.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:26:02 INFO - PROCESS | 14052 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 14:26:02 INFO - PROCESS | 14052 | Values: 147.0 148.0 147.0 150.0 147.0 146.0 149.0 147.0 147.0 146.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:26:02 INFO - PROCESS | 14052 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:3.69 (6.5%) stddev-sans-first:3.54 14:26:02 INFO - PROCESS | 14052 | Values: 62.0 62.0 55.0 56.0 55.0 54.0 57.0 55.0 64.0 55.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:26:02 INFO - PROCESS | 14052 | Values: 63.0 63.0 63.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:4.63 (5.7%) stddev-sans-first:4.77 14:26:02 INFO - PROCESS | 14052 | Values: 79.0 86.0 79.0 81.0 80.0 80.0 80.0 81.0 94.0 81.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.50 stddev:5.59 (4.5%) stddev-sans-first:5.66 14:26:02 INFO - PROCESS | 14052 | Values: 131.0 124.0 133.0 137.0 125.0 122.0 121.0 122.0 126.0 121.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.70 (1.7%) stddev-sans-first:2.11 14:26:02 INFO - PROCESS | 14052 | Values: 166.0 161.0 163.0 163.0 159.0 158.0 161.0 161.0 159.0 157.0 14:26:02 INFO - PROCESS | 14052 | 14:26:02 INFO - PROCESS | 14052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:2.99 (4.6%) stddev-sans-first:3.17 14:26:02 INFO - PROCESS | 14052 | Values: 65.0 63.0 65.0 64.0 71.0 62.0 68.0 63.0 63.0 61.0 14:26:02 INFO - PROCESS | 14052 | -------- Summary: end -------- 14:26:02 INFO - PROCESS | 14052 | 14:26:03 INFO - TEST-INFO | 14052: exit 0 14:26:03 INFO - TEST-OK | kraken | took 63200ms 14:26:03 INFO - SUITE-END | took 1175s 14:26:03 INFO - Completed test suite (00:19:35) 14:26:03 INFO - javascript benchmark 14:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7023.302790495149, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.1737530866667, 3066.6779988101234, 3106.5961425014757, 3110.3623757129785, 3121.859516321765, 5369.087255166626, 5383.353997520293, 5393.244945707599, 5397.4332695067, 5398.379186393566, 5244.947550524503, 5300.92048619271, 5351.785928562863, 5357.357117145938, 5467.589930755189, 4815.951840481585, 4863.294822250771, 4935.802567897298, 4990.4011518617635, 5033.11920413928, 729.346077727708, 4789.928151077736, 4846.442659094197, 4869.464358920516, 4926.827561035365, 4892.804287828482, 4911.5088491150955, 4916.754162291871, 4918.729469879156, 4938.530839570235, 4889.211696697744, 4910.042541704369, 4915.483874193194, 4942.555170034714, 4955.925661115086, 4747.192977193886, 4781.115493633689, 4796.904061918777, 4812.975935120337, 4913.705177689314, 5288.0745869472685, 5297.788088476456, 5342.599305052097, 5387.4073851876265, 5418.106012507931, 5592.245046918654, 5763.452472015152, 5774.5091667208335, 5776.191333213312, 5781.219535362714, 5701.059325211335, 5724.570657200685, 5761.078227483583, 5782.768689252425, 5810.215620891167, 5433.972830135864, 5438.075527160392, 5444.5916556258435, 5451.563874889999, 5454.127339625641, 5707.6575405475805, 5876.823695289148, 5892.351841297454, 5893.410658934158, 5907.911381329283, 5727.570432217601, 5731.713414329267, 5754.223179870748, 5766.279215098113, 5795.681237531976, 5753.741081651336, 5771.365149833515, 5823.388544202882, 5827.79602713903, 5831.970840145772, 5540.7783688652, 5702.942970570324, 5746.798862039808, 5790.449907258803, 5818.679972601548, 5687.7156142192725, 5688.23208866806, 5694.174344719992, 5694.743736531866, 5701.857453563694, 4355.80398882051, 4388.670849686287, 4403.0, 4407.162639098561, 4412.095520418371, 3884.7863367515056, 3894.4742459767567, 3915.7258991870294, 3936.566977632458, 3964.7224694271126, 5314.946850531445, 5367.114426119724, 5387.622866399314, 5415.4313797050745, 5450.482204190595, 5710.885782284414, 5768.3366412862215, 5773.8556536086935, 5778.971105144447, 5788.0, 5316.3354580677415, 5426.321709786277, 5434.673919564839, 5464.153056276284, 5499.367572729107, 4943.65394422387, 4966.1061009018, 4983.177775667047, 4994.625403094782, 5066.771995260148, 5879.647221166743, 5972.104184372379, 5986.102084687332, 5988.0, 5994.67029313392, 5718.714064296852, 5759.625624334405, 5768.451997060272, 5806.477417032487, 5822.82531524055, 5989.760409583742, 5991.520678345635, 5993.9700301498215, 6012.128241405059, 6020.6688632123905, 5492.725363731717, 5624.128260119688, 5724.284464441945, 5732.5413966881715, 5737.254156959735, 5765.077587585966, 5830.591858569859, 5830.82507524775, 5833.649981001154, 5884.882302353843, 5615.410381910004, 5623.606347555632, 5625.353084395347, 5653.547716182778, 5665.0, 5522.861928451821, 5594.440555944373, 5612.074007788669, 5675.489205971482, 5676.659400435987, 5532.0, 5539.335279766454, 5539.750711217925, 5542.667439953616, 5582.385937546947, 5604.3835178131185, 5615.101583746581, 5623.2127502148915, 5640.238567793295, 5648.2092507049865, 5398.1093119634825, 5481.424450432647, 5507.201455788808, 5530.714044396723, 5560.666360018412], "value": 5273.928655308159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9092945128778, 614.1800696070745, 618.1130078337583, 637.8086574027792, 652.0610321137565, 37396.439053414186, 41479.37780933289, 41501.0, 41510.377344339824, 41522.37716434252, 41910.79044604773, 42195.57804421955, 42294.788526057324, 42368.78815605918, 42622.57377426225, 8593.355498337634, 8776.517291548962, 8804.251638610725, 8827.0, 8832.293416526694, 8735.21383075523, 8822.823543529157, 8826.691065812698, 8833.20501154896, 8835.64657413706, 8852.822943541125, 8867.955660221689, 8892.421992570462, 8898.0, 8903.554822258893, 8787.912120878806, 8801.735947921605, 8812.471251724854, 8825.161609647073, 8849.159329863653, 8624.956875215647, 8693.478391296543, 8723.781905452352, 8726.956365218197, 8760.561971901443, 38851.611483885084, 39119.80440097781, 39236.411453828216, 39334.80332598319, 39344.80327598344, 2942.396808654221, 3314.685104915029, 3526.2066035142143, 3552.928941421183, 3590.2281009582803, 29664.406711865642, 30198.69801301981, 30226.84886575575, 30588.54117188244, 31089.37821243585, 4008.8997775055564, 4153.335466325373, 4193.1404062167185, 4246.8725938221905, 4328.069465065026, 316390.0, 318521.0, 319544.0, 319648.0, 321132.0, 29646.55530167049, 29848.25379365533, 29849.701502985128, 29968.400631987675, 33257.3348533028, 34085.659143408746, 35902.64097358993, 36011.0, 36067.0, 36216.637833621855, 14526.20105894186, 14683.265836708122, 14685.926570367294, 14704.117752934859, 14717.0, 11192.832107518394, 11300.886991130148, 11308.71728206785, 11336.036436902956, 11341.886581134248, 6907.481938854606, 6927.653617319113, 6976.720931162697, 6998.790036298919, 7032.08582884232, 3190.920226994344, 3247.8863239786965, 3250.236194494292, 3285.4414749492644, 3286.802791832498, 993.1607791416242, 1029.5161274201114, 1086.4513420722485, 1088.450332582041, 1108.5731993182521, 30232.395352092833, 31360.0, 31910.521342179887, 32053.19867003297, 32764.67235327616, 1064.5209655654987, 1092.2136062035322, 1151.3609946479617, 1206.2943178240653, 1213.50246398976, 16012.0, 16910.57723556921, 16912.57718557046, 17028.404005859982, 17046.914765426092, 534871.0, 534875.9537213889, 544767.0, 545038.0, 547020.0, 55590.0, 56172.719136404055, 56431.43568564344, 56456.0, 56500.71749641225, 1315.1451556488169, 1353.350391811916, 1357.2195987307339, 1374.1892283552752, 1379.5516457151266, 30342.241443964078, 31486.425678715514, 31649.683503164673, 31806.68193318037, 32155.51766723548, 50576.74711626566, 51101.744491277306, 51295.48704512907, 51396.48603513917, 51472.22791658053, 481537.0, 486415.0, 488611.0, 492883.0, 493670.0, 24039.879800600884, 24134.396640083436, 24198.51602967966, 24326.756732433158, 24350.02599896055, 45561.31658025199, 46776.7661161692, 47339.289910652056, 47874.281885771044, 48194.51805482041, 40436.393454097626, 40853.0, 41021.179576408904, 41834.79082604689, 42161.57838421576, 39783.00542486461, 39879.17214977803, 41295.0, 41468.585314146476, 41634.375484368364, 40282.395764064146, 40384.79807600943, 40502.79748601238, 40586.594134059465, 41352.58647413487, 35038.82480587683, 37049.44425833668, 37189.0, 38952.80523597364, 39348.40977385284, 27996.58005129884, 28231.294217644725, 28331.57502637421, 28583.714162858105, 28680.856595716887], "value": 18165.559870578792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4521489055761, 380.9921712574731, 386.33550293495193, 397.4554859842017, 400.18961602754416, 17525.386611468602, 18536.258549657996, 19510.0, 19912.303069392576, 19942.40172794815, 16787.91606041971, 17047.829521704778, 17111.40110096147, 17213.22540485678, 18420.355287564937, 5618.12918997555, 5727.570432217601, 5817.331006934214, 5843.883122337551, 5851.970740146293, 5532.3914369419535, 5642.6614403135945, 5643.5767317451355, 5672.631278966875, 5675.2622159119255, 5545.861353466175, 5575.776968921238, 5634.3802181760175, 5638.351589567191, 5647.915281270784, 5572.60991730579, 5585.497305242528, 5637.098064309732, 5764.365919748824, 5766.740496677659, 5022.096022715909, 5096.694198348111, 5103.8468845934685, 5106.055379754757, 5135.563477104451, 16398.344066237336, 16423.0, 20508.38474845757, 21827.271591051118, 22368.0, 2544.834585751939, 2594.2087663262696, 2626.0808716949105, 2926.3708302714804, 2946.911592652224, 14011.929940350234, 14210.289485525682, 14333.78499322511, 14526.346314415876, 14543.27283635814, 1935.680612698917, 1937.4962509747427, 1946.26042104001, 2003.729496517966, 2044.2640649366217, 48317.516824831655, 53512.464875351136, 60481.395186048016, 72278.27721722767, 73924.6303768483, 10031.799364012679, 10208.0, 10278.640247591298, 10358.637447689294, 10499.107575855985, 13640.113392629448, 13701.45194192241, 13778.379972901244, 13878.375473103735, 13882.583522494342, 7738.651760670783, 7875.212478752193, 7911.960440197762, 8016.0, 8047.356211503065, 7736.110347310131, 7767.72812951544, 7833.1775163608145, 7882.645280962371, 8006.279434850891, 6390.776322828771, 6411.198600174978, 6434.099226108348, 6521.380468855451, 6556.475481961432, 1746.8469412709926, 1805.954851128706, 1813.7007393780143, 1927.633749587574, 1948.259661328686, 807.4428644235459, 857.7083791510792, 864.2826454043254, 900.4822227219375, 910.1444642036464, 17601.074145904615, 17895.194716237802, 17929.551761205814, 17942.641147176982, 18120.184591693407, 857.691231156783, 862.2886118951765, 862.4307956748515, 902.5442151713474, 916.3997581584073, 9788.951055244679, 10082.647107351208, 10084.546195421077, 10111.140553052926, 10140.492975351202, 429114.0, 430215.0, 433695.0, 452443.0, 459902.0, 74588.62705686437, 76544.2345576537, 76891.61554192193, 77027.61486192534, 77680.0, 913.7578541686325, 961.9038096190325, 969.4958621516772, 972.3193764364831, 983.9409635421897, 16714.247858846138, 17210.91394543019, 17217.91391043037, 17671.558211044827, 17873.73189402134, 29191.562126568544, 38481.0, 40364.394534081424, 41569.0, 42746.35880461733, 58153.12770308364, 59662.40337596568, 59717.701411492664, 59747.701261493414, 59977.40022599718, 8054.516728996279, 8183.71357002502, 8351.916480835114, 8359.955005624297, 8421.19998600132, 8813.515256660688, 12425.62723118308, 12878.67803304925, 12950.935245323713, 13255.204687718768, 10851.67444976652, 10887.945560272148, 11394.772104558027, 11609.477573509044, 11652.88347116518, 11200.10399168081, 11424.657260282205, 11690.649280521598, 11807.350595717318, 11825.822612660644, 11548.59579914699, 11773.52905883755, 11819.349935753617, 11834.881651183377, 11895.583654572049, 8186.7953301167945, 8229.218224268685, 8233.300169485661, 8264.0, 8578.871316930126, 10211.0, 11535.884641153481, 11536.538538458703, 11686.532538698357, 11688.532458701897], "value": 8928.777002148958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.2653030628612, 1396.3297617143771, 1447.8986470947032, 1605.6547842213922, 1606.3735143294118, 6802.863942721143, 7872.76381708549, 7940.2853743163105, 8378.497290162586, 8381.41330106892, 8013.439059265854, 8223.588820558964, 8247.876281855777, 8310.376721745863, 8338.374621903351, 2201.6477363621825, 2209.1826024371007, 2223.1552010236087, 2225.94435139122, 2228.888555572223, 2165.4261620670536, 2173.7608863025052, 2220.622494175986, 2224.2659922225625, 2226.7661895500983, 2168.3169801512554, 2175.445261458334, 2180.563887222554, 2185.7049298344677, 2186.0381432169875, 2174.858634188781, 2175.4778853075304, 2177.433867194533, 2189.5839790439763, 2194.7366316042176, 2108.2726459371493, 2123.9256626018014, 2147.452399638082, 2152.2789865394957, 2157.8597391169683, 8304.916950830475, 8358.331333493366, 8369.037560680477, 8380.413371064027, 8406.537640429773, 4703.553162449562, 4787.760611969387, 4819.879503012453, 4824.782884770194, 4830.058138662962, 3142.073088438916, 3173.9682603173906, 3205.1506350817053, 3263.102646772133, 3283.4746440569634, 1093.4150229627191, 1118.759466714652, 1130.6494986554194, 1147.6671765188084, 1155.2779512804498, 11383.260088094248, 11409.828852567218, 11443.828342574869, 11458.541658333657, 11482.540698372055, 4190.161967606491, 4273.97863010683, 4294.82820687169, 4304.332828411601, 4322.1139666368945, 9597.896241932127, 9651.372660777168, 9665.90334096664, 9698.70903872885, 9761.951190244003, 4801.567858892717, 4827.710337379768, 4892.461829198785, 4892.68197567157, 4893.119238537098, 3786.583475817658, 4357.869263922087, 4412.602865742098, 4507.977460112678, 4518.88702782433, 3626.256617393428, 3644.9635503645154, 3737.32728108943, 3758.3986562149926, 3860.324443222481, 1139.2367114033618, 1145.5646854195352, 1163.8894305041008, 1167.3287859480834, 1173.6244401791516, 907.7140700679265, 918.0681608167581, 928.0626567167075, 929.4655573045391, 938.7043081429327, 5433.26650902131, 6014.338422773491, 6106.969465152734, 6196.0, 6388.840278993062, 929.0987741890356, 943.7687766497252, 946.9573869175766, 992.5930368549004, 996.6262651505685, 3937.2912875682077, 4144.129732756155, 4371.30059190528, 4463.955360446419, 4486.282194848808, 9847.473641585566, 9863.112319891245, 10005.749856253651, 10016.699499015042, 10079.193664506822, 9802.313838031268, 9891.159251463563, 9942.154916832005, 9942.552585133686, 10001.899981000242, 7325.084364454443, 7616.543007419684, 7661.195574464712, 7719.691212351443, 7921.168277330912, 5874.353821079592, 6020.066889632114, 6136.417040381157, 6138.478229350555, 6155.84610384744, 9491.572879220314, 9516.19112375428, 9545.522723863918, 9555.283353748358, 9589.808203836024, 9325.440473571607, 9497.762555936157, 9743.512824358895, 9793.755156121155, 9854.802903942025, 6332.778352757631, 7067.893981590178, 7148.535345202546, 7200.71197152108, 7346.191918889025, 7964.0, 8023.6790528378215, 8076.394270429624, 8084.7574572762915, 8120.187981201832, 7123.643817809192, 7382.778516644509, 7416.147143078615, 7443.330100290783, 7571.659275332733, 7331.114196010392, 7370.705171793068, 7449.627518623939, 7489.550626962399, 7497.475176737794, 6891.173059232724, 6904.378605925491, 6953.478489113236, 6985.126859142607, 7013.929860701532, 4955.925661115014, 4998.525140111684, 5140.074786538309, 5142.04872098663, 5146.150885103916, 5076.441591425014, 5101.3113229715, 5178.0, 5227.320448341691, 5328.280682107866], "value": 4414.1625961216905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.714120162241, 302.8697660006198, 307.40977323538806, 307.64620686210867, 308.03277707996887, 5453.727313634322, 5562.721863906809, 5617.707927176747, 5639.069553523669, 5642.605017648766, 5643.915341269884, 5644.633098848582, 5655.095184770437, 5657.23627310314, 5700.486956173943, 4251.4898212214575, 4326.178026175016, 4336.392904993311, 4339.566043395666, 4343.956560434387, 4054.2499637567, 4272.957270427302, 4295.1839150561445, 4315.892102697427, 4318.654507639381, 4228.196642637904, 4230.788460576974, 4235.2800023996, 4257.191133684605, 4267.4452321198205, 4266.656003358948, 4281.336392859112, 4304.827806887721, 4313.956860431387, 4325.567443255681, 3544.432890737495, 3773.8301776419853, 3775.432705760082, 3784.1485665725268, 3789.3368660484307, 5506.944930550683, 5532.119079512985, 5536.474034966672, 5578.748956296977, 5581.5813813963705, 4910.337104490919, 4917.557419832232, 4945.23348880924, 4955.975220123913, 4962.826301079445, 5625.606207565472, 5912.3496415394275, 5940.851478713023, 5965.910511342333, 6005.249343832021, 4010.418489319062, 4027.2146931348398, 4077.97961010196, 4078.2047500737367, 4102.425660407545, 6193.87612247757, 6259.7777788885205, 6295.811125666283, 6302.653354065525, 6312.0, 4107.466029416157, 4163.562825903297, 4176.33178691414, 4222.535521092677, 4233.809478573472, 4188.204241194224, 4221.155768846182, 4238.279492486223, 4244.8514301999285, 4253.894322310476, 4900.950990490121, 4940.7035577865445, 4941.555260026615, 4957.082939656103, 4963.875903102379, 5865.618734782311, 5977.521798256129, 5979.4618484336615, 6014.248218972629, 6030.517558595302, 1401.3763875075697, 1419.5386499387741, 1423.843377228504, 1444.5521888214687, 1447.6163816588612, 878.4202426398547, 887.2148148888151, 911.9635214591475, 918.4626993208914, 921.9769505762409, 4956.463496316153, 4994.600431965507, 5000.549950504472, 5024.0, 5126.0, 5377.973110134424, 5484.506394424521, 5491.643043202179, 5500.3949565547755, 5509.0, 4952.811325281907, 5113.821016264487, 5116.9744151279, 5132.561184006724, 5158.690478571298, 2891.334992951633, 2918.2558447596152, 2944.7938644294695, 2947.4504553561014, 2951.2621844538867, 5441.945580544223, 5529.30883639545, 5529.834104976857, 5575.888482230333, 5598.944010559842, 5237.895242095136, 5470.370907345627, 5498.395176530578, 5518.117101263779, 5533.810230800397, 5543.805966791143, 5552.7223638817895, 5585.1901474286005, 5587.413321601254, 5595.832125036174, 5153.871153221199, 5357.044678692328, 5379.9778042171865, 5487.75305111263, 5531.695756733418, 5299.44355842631, 5313.459096861867, 5318.760655770422, 5400.513953744182, 5403.756830942696, 5651.745671444877, 5652.7738890443925, 5677.5457963362005, 5681.886362272814, 6044.153818465506, 4089.711740801638, 4165.791710414528, 4166.458360413127, 4178.603032711888, 4191.7484950903045, 6018.548608854266, 6077.848053798691, 6118.980736357081, 6150.785717141915, 6170.81487555374, 5801.883962320646, 5849.795257165979, 5968.46283834457, 5990.191324171181, 5998.970005149947, 5840.561957853263, 5924.52603791687, 5935.436133567304, 5940.257467816523, 5977.701114944322, 5759.683217422914, 5777.0, 5801.781625858617, 5805.593608447368, 5842.941570584239, 5646.689432081111, 6019.638821670714, 6021.277446706248, 6044.395560443921, 6090.20339000005, 5911.408859114226, 5945.167676525203, 5962.1951036611235, 5980.9401905980385, 6000.909986350295], "value": 4310.521495666906, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9942577520349, 758.7875394889431, 789.1516619633892, 807.3097501636097, 813.9023317201935, 14581.70836583269, 15043.699126017473, 15898.20508974551, 15910.522684319489, 16007.19964001801, 13988.930055349734, 14108.0, 14108.717825643482, 14166.716665666681, 14201.786973195385, 739.9112106547221, 741.5995362504241, 743.4015617427968, 746.283567774934, 749.6439191384103, 627.4572494792018, 709.8686742952544, 721.9602921839297, 723.4284914917209, 731.2614259597818, 785.4030936488282, 789.1161898673465, 790.9683612655487, 791.4657606115877, 793.1909452358591, 780.5706861226303, 783.2637320918348, 783.902012248469, 787.3347021766598, 790.9683612655487, 567.3305499510576, 569.4533248081847, 569.9458551437607, 570.1020892094925, 572.4247131632724, 14287.0, 14337.35481903317, 14406.207658578774, 14417.13497190172, 14473.42106315746, 14567.781483277759, 14747.926260368737, 15101.773473397909, 15286.388544458208, 15286.617834554114, 12182.390880455941, 12270.877291227063, 12272.631821045383, 12353.135280530367, 12426.5650702225, 3846.5961074087377, 3883.262180185756, 3907.433422153772, 3910.432987216838, 3944.0, 70225.0, 70392.2960770396, 70622.29377706209, 72704.27295727028, 75108.99999999945, 11263.887361126448, 11273.830892536618, 11387.316760994367, 11456.99502587044, 11575.594854180063, 21394.35816925495, 21522.461938451663, 21608.459788505414, 21645.242416515346, 21845.781542184694, 8644.567771611395, 8794.736157915273, 8845.115488451103, 8896.110388961182, 8962.596683149273, 4603.700759450692, 4749.121412538691, 4888.437829649564, 5076.695398276115, 5125.051865404912, 3464.34177506273, 3587.5694916610173, 3588.049166970755, 3589.3718599245026, 3600.1539638185004, 583.8102616649605, 594.7918228619949, 601.2994860986988, 609.7073404765737, 610.9205803245638, 693.2478261086777, 723.479095051562, 741.3735393592406, 765.2806362019684, 765.4412279036223, 9871.605135794487, 10021.448820314807, 10110.090091891765, 10202.693919182437, 10258.333208341433, 635.659921941759, 671.2917871645363, 709.7409445552336, 728.1517032656895, 728.639323534843, 4910.189818679878, 4985.252212168204, 5089.160288552422, 5115.309433226541, 5141.2545180948555, 112575.43712281386, 113488.0, 116142.0, 118824.40587797179, 120504.39747801205, 101689.0, 102169.0, 102480.48759756153, 103926.0, 104070.0, 86461.99999999875, 87093.0, 87282.56358718166, 88403.11596883948, 89752.10247897437, 8986.955065224633, 9060.456372617664, 9231.399959002643, 9598.712038638852, 9632.229421646392, 44098.338524922794, 47480.0, 49172.0, 49506.25740613822, 51497.7425112887, 72716.63641681758, 76187.61906190433, 76192.23807761852, 76417.0, 77085.22914770781, 11453.885461145283, 11483.483243253906, 11488.368139752394, 11607.0, 11714.531418743154, 12871.292078935749, 13451.932740336235, 13501.729965400833, 13642.386092625657, 13810.10234334765, 12209.877901220874, 12556.497740090294, 12599.18105323151, 12697.779086186994, 12836.486540538273, 12132.696682583006, 12251.203671761306, 12285.57000504978, 12975.675608109872, 12988.0, 12221.755564888475, 12377.876221237673, 12500.06249531307, 12838.42227099764, 12839.037072219808, 10072.395656260647, 10425.0, 10512.811553110567, 10660.573577056832, 10660.774010988836, 9983.750406239902, 10653.0, 10698.0, 10756.892431075588, 10903.83644245321], "value": 7373.153754341909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 112.0, 113.0, 114.0, 114.0, 112.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 141.0, 151.0, 175.0, 130.0, 160.0, 151.0, 129.0, 185.0, 131.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 161.0, 166.0, 168.0, 163.0, 161.0, 162.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 166.0, 75.0, 76.0, 76.0, 77.0, 164.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 151.0, 85.0, 87.0, 86.0, 151.0, 86.0, 86.0, 152.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 150.0, 147.0, 146.0, 149.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 55.0, 56.0, 55.0, 54.0, 57.0, 55.0, 64.0, 55.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 79.0, 81.0, 80.0, 80.0, 80.0, 81.0, 94.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 124.0, 133.0, 137.0, 125.0, 122.0, 121.0, 122.0, 126.0, 121.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 163.0, 163.0, 159.0, 158.0, 161.0, 161.0, 159.0, 157.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 71.0, 62.0, 68.0, 63.0, 63.0, 61.0], "value": 64.5, "unit": "score"}]}]} 14:26:03 INFO - Return code: 0 14:26:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:03 ERROR - # TBPL SUCCESS # 14:26:03 INFO - Running post-action listener: _resource_record_post_action 14:26:03 INFO - ##### 14:26:03 INFO - ##### Finished run-tests step (success) 14:26:03 INFO - ##### 14:26:03 INFO - Running post-run listener: _resource_record_post_run 14:26:03 INFO - Total resource usage - Wall time: 1193s; CPU: 14.0%; Read bytes: 4096; Write bytes: 551165952; Read time: 16; Write time: 732944 14:26:03 INFO - TinderboxPrint: CPU usage
13.5% 14:26:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:26:03 INFO - TinderboxPrint: I/O write bytes / time
551,165,952 / 732,944 14:26:03 INFO - TinderboxPrint: CPU idle
8,227.6 (86.5%) 14:26:03 INFO - TinderboxPrint: CPU user
1,226.3 (12.9%) 14:26:03 INFO - TinderboxPrint: Swap in / out
0 / 0 14:26:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256499712; Read time: 0; Write time: 344028 14:26:03 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294539264; Read time: 16; Write time: 388892 14:26:04 INFO - Running post-run listener: _upload_blobber_files 14:26:04 INFO - Blob upload gear active. 14:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:04 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 14:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:26:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:07 INFO - (blobuploader) - INFO - Done attempting. 14:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:08 INFO - (blobuploader) - INFO - Done attempting. 14:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:09 INFO - (blobuploader) - INFO - Done attempting. 14:26:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:09 INFO - Return code: 0 14:26:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa225fa42cec2b16872c90280113fac57ad0154b2c31260bd70ec8c6f8fddef9422c7fd3b273fe7b6338a39c98e0aeadc779a0886237665eed605da0c12cc1d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/820eef0e759ef87bc46d54bbb35a1aaf312ceb053435a39e7317cd705f09c4d252156bc1fc229a1dff22c63727ad9cd3fa31ea06927080d310dc50eeb4a3edd0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52cbe8c3343fb0fb11d5ebda7921a42249ece47675458a62081e67150fd1f80203c9e4ec8cb7badf055b48993647d4b7b4e2373d782983757219977c3b61bb9a"} 14:26:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:09 INFO - Contents: 14:26:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa225fa42cec2b16872c90280113fac57ad0154b2c31260bd70ec8c6f8fddef9422c7fd3b273fe7b6338a39c98e0aeadc779a0886237665eed605da0c12cc1d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/820eef0e759ef87bc46d54bbb35a1aaf312ceb053435a39e7317cd705f09c4d252156bc1fc229a1dff22c63727ad9cd3fa31ea06927080d310dc50eeb4a3edd0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52cbe8c3343fb0fb11d5ebda7921a42249ece47675458a62081e67150fd1f80203c9e4ec8cb7badf055b48993647d4b7b4e2373d782983757219977c3b61bb9a"} 14:26:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:09 INFO - Copying logs to upload dir... 14:26:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.675271 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-25 14:26:08.384110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 14:26:08.387972) ========= 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=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa225fa42cec2b16872c90280113fac57ad0154b2c31260bd70ec8c6f8fddef9422c7fd3b273fe7b6338a39c98e0aeadc779a0886237665eed605da0c12cc1d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/820eef0e759ef87bc46d54bbb35a1aaf312ceb053435a39e7317cd705f09c4d252156bc1fc229a1dff22c63727ad9cd3fa31ea06927080d310dc50eeb4a3edd0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52cbe8c3343fb0fb11d5ebda7921a42249ece47675458a62081e67150fd1f80203c9e4ec8cb7badf055b48993647d4b7b4e2373d782983757219977c3b61bb9a"} build_url:https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/LSqcQT4_TqGvmNudpoNLfA/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/sha512/aa225fa42cec2b16872c90280113fac57ad0154b2c31260bd70ec8c6f8fddef9422c7fd3b273fe7b6338a39c98e0aeadc779a0886237665eed605da0c12cc1d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/820eef0e759ef87bc46d54bbb35a1aaf312ceb053435a39e7317cd705f09c4d252156bc1fc229a1dff22c63727ad9cd3fa31ea06927080d310dc50eeb4a3edd0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52cbe8c3343fb0fb11d5ebda7921a42249ece47675458a62081e67150fd1f80203c9e4ec8cb7badf055b48993647d4b7b4e2373d782983757219977c3b61bb9a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 14:26:08.413736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:26:08.414068) ========= 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=eca2ab57546de7b41f256b19000001ef-1466880569.575001-340757801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 14:26:08.498876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 14:26:08.499450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 14:26:08.499892) ========= ========= Total master_lag: 0.17 =========