builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1465474101.98 results: success (0) buildid: 20160609043328 builduid: d8866705666f4b9287bc69ac21565cdb revision: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:21.980851) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:21.981284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:21.981573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:22.018579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:22.018857) ========= 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=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 05:08:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.2M=0s 2016-06-09 05:08:22 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118500 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:22.292629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:22.292948) ========= 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=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:22.343262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:08:22.343587) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a --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 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a --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=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 05:08:22,361 truncating revision to first 12 chars 2016-06-09 05:08:22,361 Setting DEBUG logging. 2016-06-09 05:08:22,361 attempt 1/10 2016-06-09 05:08:22,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1c86ba5d7a5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 05:08:23,147 unpacking tar archive at: fx-team-1c86ba5d7a5b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462301 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:08:23.833829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:23.834183) ========= script_repo_revision: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:23.834666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:23.834950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:08:23.845348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-09 05:08:23.845639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:08:23 INFO - MultiFileLogger online at 20160609 05:08:23 in /builds/slave/test 05:08:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:08:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:23 INFO - {'append_to_log': False, 05:08:23 INFO - 'base_work_dir': '/builds/slave/test', 05:08:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:08:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:23 INFO - 'branch': 'Fx-Team-Non-PGO', 05:08:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:23 INFO - 'config_files': ('talos/linux_config.py',), 05:08:23 INFO - 'default_actions': ('clobber', 05:08:23 INFO - 'read-buildbot-config', 05:08:23 INFO - 'download-and-extract', 05:08:23 INFO - 'populate-webroot', 05:08:23 INFO - 'create-virtualenv', 05:08:23 INFO - 'install', 05:08:23 INFO - 'run-tests'), 05:08:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:23 INFO - 'download_minidump_stackwalk': True, 05:08:23 INFO - 'download_symbols': 'ondemand', 05:08:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:23 INFO - 'installer_path': 'installer.exe', 05:08:23 INFO - 'log_level': 'info', 05:08:23 INFO - 'log_name': 'talos', 05:08:23 INFO - 'log_to_console': True, 05:08:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:08:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:08:23 INFO - 'opt_config_files': (), 05:08:23 INFO - 'pip_index': False, 05:08:23 INFO - 'sps_profile': False, 05:08:23 INFO - 'sps_profile_interval': 0, 05:08:23 INFO - 'suite': 'dromaeojs-e10s', 05:08:23 INFO - 'system_bits': '32', 05:08:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:23 INFO - 'title': 'talos-linux64-ix-026', 05:08:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:23 INFO - 'use_talos_json': True, 05:08:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:23 INFO - 'work_dir': 'build'} 05:08:23 INFO - ##### 05:08:23 INFO - ##### Running clobber step. 05:08:23 INFO - ##### 05:08:23 INFO - Running pre-action listener: _resource_record_pre_action 05:08:23 INFO - Running main action method: clobber 05:08:23 INFO - rmtree: /builds/slave/test/build 05:08:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:24 INFO - Running post-action listener: _resource_record_post_action 05:08:24 INFO - ##### 05:08:24 INFO - ##### Finished clobber step (success) 05:08:24 INFO - ##### 05:08:24 INFO - ##### 05:08:24 INFO - ##### Running read-buildbot-config step. 05:08:24 INFO - ##### 05:08:24 INFO - Running pre-action listener: _resource_record_pre_action 05:08:24 INFO - Running main action method: read_buildbot_config 05:08:24 INFO - Using buildbot properties: 05:08:24 INFO - { 05:08:24 INFO - "project": "", 05:08:24 INFO - "product": "firefox", 05:08:24 INFO - "script_repo_revision": "production", 05:08:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:08:24 INFO - "repository": "", 05:08:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:08:24 INFO - "buildid": "20160609043328", 05:08:24 INFO - "pgo_build": "False", 05:08:24 INFO - "basedir": "/builds/slave/test", 05:08:24 INFO - "buildnumber": 1389, 05:08:24 INFO - "slavename": "talos-linux64-ix-026", 05:08:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:08:24 INFO - "platform": "ubuntu64_hw", 05:08:24 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:08:24 INFO - "branch": "fx-team", 05:08:24 INFO - "repo_path": "integration/fx-team", 05:08:24 INFO - "revision": "1c86ba5d7a5b9cb16ef3ad77ff740688a923108a", 05:08:24 INFO - "stage_platform": "linux64", 05:08:24 INFO - "builduid": "d8866705666f4b9287bc69ac21565cdb", 05:08:24 INFO - "slavebuilddir": "test" 05:08:24 INFO - } 05:08:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:08:24 INFO - Running post-action listener: _resource_record_post_action 05:08:24 INFO - ##### 05:08:24 INFO - ##### Finished read-buildbot-config step (success) 05:08:24 INFO - ##### 05:08:24 INFO - ##### 05:08:24 INFO - ##### Running download-and-extract step. 05:08:24 INFO - ##### 05:08:24 INFO - Running pre-action listener: _resource_record_pre_action 05:08:24 INFO - Running main action method: download_and_extract 05:08:24 INFO - mkdir: /builds/slave/test/build/tests 05:08:24 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')]} 05:08:24 INFO - https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:26 INFO - Downloaded 1361 bytes. 05:08:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:08:26 INFO - Using the following test package requirements: 05:08:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:08:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:08:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'jsshell-linux-x86_64.zip'], 05:08:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:08:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:08:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:08:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:08:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:08:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:08:26 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')]} 05:08:26 INFO - https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:29 INFO - Downloaded 22879604 bytes. 05:08:29 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'] 05:08:29 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 05:08:30 INFO - Return code: 0 05:08:30 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 05:08:30 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')]} 05:08:30 INFO - https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:31 INFO - Downloaded 22879604 bytes. 05:08:31 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'] 05:08:31 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 05:08:33 INFO - Return code: 0 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:34 INFO - Downloaded 10833377 bytes. 05:08:34 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'] 05:08:34 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 05:08:35 INFO - Return code: 0 05:08:35 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')]} 05:08:35 INFO - https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VihdZ2z7RSyseir6WMAZEA/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 05:08:38 INFO - Downloaded 55447367 bytes. 05:08:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:08:38 INFO - mkdir: /builds/slave/test/properties 05:08:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:38 INFO - Contents: 05:08:38 INFO - build_url:https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:08:39 INFO - Running post-action listener: _resource_record_post_action 05:08:39 INFO - Running post-action listener: set_extra_try_arguments 05:08:39 INFO - ##### 05:08:39 INFO - ##### Finished download-and-extract step (success) 05:08:39 INFO - ##### 05:08:39 INFO - ##### 05:08:39 INFO - ##### Running populate-webroot step. 05:08:39 INFO - ##### 05:08:39 INFO - Running pre-action listener: _resource_record_pre_action 05:08:39 INFO - Running main action method: populate_webroot 05:08:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:39 INFO - '--tppagecycles', 05:08:39 INFO - '7'], 05:08:39 INFO - 'tests': ['tsvgm']}}, 05:08:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['damp', 'tps']}, 05:08:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'tests': ['damp', 'tps']}, 05:08:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['dromaeo_dom']}, 05:08:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['a11yr', 05:08:39 INFO - 'ts_paint', 05:08:39 INFO - 'tpaint', 05:08:39 INFO - 'sessionrestore', 05:08:39 INFO - 'sessionrestore_no_auto_restore', 05:08:39 INFO - 'tabpaint']}, 05:08:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['tsvgx', 05:08:39 INFO - 'tsvgr_opacity', 05:08:39 INFO - 'tart', 05:08:39 INFO - 'tscrollx', 05:08:39 INFO - 'cart']}, 05:08:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:39 INFO - 'tsvgr_opacity', 05:08:39 INFO - 'tart', 05:08:39 INFO - 'tscrollx', 05:08:39 INFO - 'cart']}, 05:08:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'talos_options': ['--disable-e10s'], 05:08:39 INFO - 'tests': ['tp5o']}, 05:08:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'tests': ['tp5o']}, 05:08:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'talos_options': ['--disable-e10s', 05:08:39 INFO - '--xperf_path', 05:08:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:39 INFO - 'tests': ['tp5n']}, 05:08:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:39 INFO - 'talos_options': ['--xperf_path', 05:08:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:39 INFO - 'tests': ['tp5n']}}, 05:08:39 INFO - 'talos.zip': {'path': '', 05:08:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:39 INFO - Running post-action listener: _resource_record_post_action 05:08:39 INFO - ##### 05:08:39 INFO - ##### Finished populate-webroot step (success) 05:08:39 INFO - ##### 05:08:39 INFO - ##### 05:08:39 INFO - ##### Running create-virtualenv step. 05:08:39 INFO - ##### 05:08:39 INFO - Running pre-action listener: _resource_record_pre_action 05:08:39 INFO - Running main action method: create_virtualenv 05:08:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:39 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 05:08:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:39 INFO - Using real prefix '/usr' 05:08:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:41 INFO - Installing pip.................done. 05:08:41 INFO - Return code: 0 05:08:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:41 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:41 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 05:08:41 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 05:08:41 INFO - Using env: {'DISPLAY': ':0', 05:08:41 INFO - 'HOME': '/home/cltbld', 05:08:41 INFO - 'LANG': 'en_US.UTF-8', 05:08:41 INFO - 'LANGUAGE': 'en_US:en', 05:08:41 INFO - 'LOGNAME': 'cltbld', 05:08:41 INFO - 'MAIL': '/var/mail/cltbld', 05:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:41 INFO - 'MOZ_NO_REMOTE': '1', 05:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:41 INFO - 'NO_EM_RESTART': '1', 05:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:41 INFO - 'PWD': '/builds/slave/test', 05:08:41 INFO - 'SHELL': '/bin/bash', 05:08:41 INFO - 'SHLVL': '1', 05:08:41 INFO - 'TERM': 'linux', 05:08:41 INFO - 'TMOUT': '86400', 05:08:41 INFO - 'USER': 'cltbld', 05:08:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:41 INFO - '_': '/tools/buildbot/bin/python'} 05:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:41 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 05:08:41 INFO - Cleaning up... 05:08:41 INFO - Return code: 0 05:08:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:41 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:41 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 05:08:41 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 05:08:41 INFO - Using env: {'DISPLAY': ':0', 05:08:41 INFO - 'HOME': '/home/cltbld', 05:08:41 INFO - 'LANG': 'en_US.UTF-8', 05:08:41 INFO - 'LANGUAGE': 'en_US:en', 05:08:41 INFO - 'LOGNAME': 'cltbld', 05:08:41 INFO - 'MAIL': '/var/mail/cltbld', 05:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:41 INFO - 'MOZ_NO_REMOTE': '1', 05:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:41 INFO - 'NO_EM_RESTART': '1', 05:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:41 INFO - 'PWD': '/builds/slave/test', 05:08:41 INFO - 'SHELL': '/bin/bash', 05:08:41 INFO - 'SHLVL': '1', 05:08:41 INFO - 'TERM': 'linux', 05:08:41 INFO - 'TMOUT': '86400', 05:08:41 INFO - 'USER': 'cltbld', 05:08:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:41 INFO - '_': '/tools/buildbot/bin/python'} 05:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:42 INFO - Downloading/unpacking psutil>=3.1.1 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:44 INFO - Installing collected packages: psutil 05:08:44 INFO - Running setup.py install for psutil 05:08:44 INFO - building 'psutil._psutil_linux' extension 05:08:44 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 05:08:44 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 05:08:44 INFO - building 'psutil._psutil_posix' extension 05:08:44 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 05:08:44 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 05:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:44 INFO - Successfully installed psutil 05:08:44 INFO - Cleaning up... 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08:44 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')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'DISPLAY': ':0', 05:08:44 INFO - 'HOME': '/home/cltbld', 05:08:44 INFO - 'LANG': 'en_US.UTF-8', 05:08:44 INFO - 'LANGUAGE': 'en_US:en', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MAIL': '/var/mail/cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SHLVL': '1', 05:08:44 INFO - 'TERM': 'linux', 05:08:44 INFO - 'TMOUT': '86400', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:46 INFO - Installing collected packages: mozsystemmonitor 05:08:46 INFO - Running setup.py install for mozsystemmonitor 05:08:46 INFO - Successfully installed mozsystemmonitor 05:08:46 INFO - Cleaning up... 05:08:47 INFO - Return code: 0 05:08:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', '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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:08: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 jsonschema==2.5.1 05:08:47 INFO - Using env: {'DISPLAY': ':0', 05:08:47 INFO - 'HOME': '/home/cltbld', 05:08:47 INFO - 'LANG': 'en_US.UTF-8', 05:08:47 INFO - 'LANGUAGE': 'en_US:en', 05:08:47 INFO - 'LOGNAME': 'cltbld', 05:08:47 INFO - 'MAIL': '/var/mail/cltbld', 05:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:47 INFO - 'MOZ_NO_REMOTE': '1', 05:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:47 INFO - 'NO_EM_RESTART': '1', 05:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:47 INFO - 'PWD': '/builds/slave/test', 05:08:47 INFO - 'SHELL': '/bin/bash', 05:08:47 INFO - 'SHLVL': '1', 05:08:47 INFO - 'TERM': 'linux', 05:08:47 INFO - 'TMOUT': '86400', 05:08:47 INFO - 'USER': 'cltbld', 05:08:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:47 INFO - '_': '/tools/buildbot/bin/python'} 05:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:47 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 05:08:47 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 05:08:47 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 05:08:47 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 05:08:47 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 05:08:47 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 05:08:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:49 INFO - warning: no files found matching '*.txt' 05:08:49 INFO - no previously-included directories found matching 'build' 05:08:49 INFO - no previously-included directories found matching 'dist' 05:08:49 INFO - no previously-included directories found matching '.git*' 05:08:49 INFO - Installing collected packages: jsonschema, functools32 05:08:49 INFO - Running setup.py install for functools32 05:08:49 INFO - warning: no files found matching '*.txt' 05:08:49 INFO - no previously-included directories found matching 'build' 05:08:49 INFO - no previously-included directories found matching 'dist' 05:08:49 INFO - no previously-included directories found matching '.git*' 05:08:49 INFO - Successfully installed jsonschema functools32 05:08:49 INFO - Cleaning up... 05:08:49 INFO - Return code: 0 05:08:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:49 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:49 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 05:08:49 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 05:08:49 INFO - Using env: {'DISPLAY': ':0', 05:08:49 INFO - 'HOME': '/home/cltbld', 05:08:49 INFO - 'LANG': 'en_US.UTF-8', 05:08:49 INFO - 'LANGUAGE': 'en_US:en', 05:08:49 INFO - 'LOGNAME': 'cltbld', 05:08:49 INFO - 'MAIL': '/var/mail/cltbld', 05:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:49 INFO - 'MOZ_NO_REMOTE': '1', 05:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:49 INFO - 'NO_EM_RESTART': '1', 05:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:49 INFO - 'PWD': '/builds/slave/test', 05:08:49 INFO - 'SHELL': '/bin/bash', 05:08:49 INFO - 'SHLVL': '1', 05:08:49 INFO - 'TERM': 'linux', 05:08:49 INFO - 'TMOUT': '86400', 05:08:49 INFO - 'USER': 'cltbld', 05:08:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:49 INFO - '_': '/tools/buildbot/bin/python'} 05:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 INFO - Downloading docopt-0.6.1.tar.gz 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:52 INFO - Running setup.py install for blobuploader 05:08:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:52 INFO - Running setup.py install for requests 05:08:53 INFO - Running setup.py install for docopt 05:08:53 INFO - Successfully installed blobuploader requests docopt 05:08:53 INFO - Cleaning up... 05:08:53 INFO - Return code: 0 05:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:53 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')]} 05:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:53 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')]} 05:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:53 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:53 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 05:08:53 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 05:08:53 INFO - Using env: {'DISPLAY': ':0', 05:08:53 INFO - 'HOME': '/home/cltbld', 05:08:53 INFO - 'LANG': 'en_US.UTF-8', 05:08:53 INFO - 'LANGUAGE': 'en_US:en', 05:08:53 INFO - 'LOGNAME': 'cltbld', 05:08:53 INFO - 'MAIL': '/var/mail/cltbld', 05:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:53 INFO - 'MOZ_NO_REMOTE': '1', 05:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:53 INFO - 'NO_EM_RESTART': '1', 05:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:53 INFO - 'PWD': '/builds/slave/test', 05:08:53 INFO - 'SHELL': '/bin/bash', 05:08:53 INFO - 'SHLVL': '1', 05:08:53 INFO - 'TERM': 'linux', 05:08:53 INFO - 'TMOUT': '86400', 05:08:53 INFO - 'USER': 'cltbld', 05:08:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:53 INFO - '_': '/tools/buildbot/bin/python'} 05:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Running setup.py (path:/tmp/pip-4T5Lyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Running setup.py (path:/tmp/pip-SXW0aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:53 INFO - Running setup.py (path:/tmp/pip-dH2W5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:53 INFO - Running setup.py (path:/tmp/pip-VqCz7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:53 INFO - Running setup.py (path:/tmp/pip-4WOJkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:53 INFO - Running setup.py (path:/tmp/pip-xiBTxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:53 INFO - Running setup.py (path:/tmp/pip-myapsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:53 INFO - Running setup.py (path:/tmp/pip-7ot02Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:54 INFO - Running setup.py (path:/tmp/pip-guF08w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:54 INFO - Running setup.py (path:/tmp/pip-k5IsTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Running setup.py (path:/tmp/pip-M7SiDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Running setup.py (path:/tmp/pip-j2g1B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Running setup.py (path:/tmp/pip-ochLWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Running setup.py (path:/tmp/pip-z3vwH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Running setup.py (path:/tmp/pip-iZxLV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Running setup.py (path:/tmp/pip-WKay0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:54 INFO - Running setup.py (path:/tmp/pip-vzGGbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:54 INFO - Running setup.py install for manifestparser 05:08:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Running setup.py install for mozcrash 05:08:54 INFO - Running setup.py install for mozdebug 05:08:54 INFO - Running setup.py install for mozdevice 05:08:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozfile 05:08:55 INFO - Running setup.py install for mozhttpd 05:08:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozinfo 05:08:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozInstall 05:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozleak 05:08:55 INFO - Running setup.py install for mozlog 05:08:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for moznetwork 05:08:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozprocess 05:08:55 INFO - Running setup.py install for mozprofile 05:08:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozrunner 05:08:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Running setup.py install for mozscreenshot 05:08:56 INFO - Running setup.py install for moztest 05:08:56 INFO - Running setup.py install for mozversion 05:08:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:56 INFO - Cleaning up... 05:08:56 INFO - Return code: 0 05:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:56 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:08:56 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 05:08:56 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 05:08:56 INFO - Using env: {'DISPLAY': ':0', 05:08:56 INFO - 'HOME': '/home/cltbld', 05:08:56 INFO - 'LANG': 'en_US.UTF-8', 05:08:56 INFO - 'LANGUAGE': 'en_US:en', 05:08:56 INFO - 'LOGNAME': 'cltbld', 05:08:56 INFO - 'MAIL': '/var/mail/cltbld', 05:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:56 INFO - 'MOZ_NO_REMOTE': '1', 05:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:56 INFO - 'NO_EM_RESTART': '1', 05:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:56 INFO - 'PWD': '/builds/slave/test', 05:08:56 INFO - 'SHELL': '/bin/bash', 05:08:56 INFO - 'SHLVL': '1', 05:08:56 INFO - 'TERM': 'linux', 05:08:56 INFO - 'TMOUT': '86400', 05:08:56 INFO - 'USER': 'cltbld', 05:08:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:56 INFO - '_': '/tools/buildbot/bin/python'} 05:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:56 INFO - Running setup.py (path:/tmp/pip-8i8bdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:56 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)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 INFO - Running setup.py (path:/tmp/pip-6BTgIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 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)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 INFO - Running setup.py (path:/tmp/pip-CIhaAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 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)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 INFO - Running setup.py (path:/tmp/pip-24EkI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 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)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:56 INFO - Running setup.py (path:/tmp/pip-xECBuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:57 INFO - Running setup.py (path:/tmp/pip-ScPoJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:57 INFO - Running setup.py (path:/tmp/pip-kKl_37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:57 INFO - Running setup.py (path:/tmp/pip-SKgDDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:57 INFO - Running setup.py (path:/tmp/pip-GtnkVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Running setup.py (path:/tmp/pip-5KQLMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Running setup.py (path:/tmp/pip-G4JCak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Running setup.py (path:/tmp/pip-s5euAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Running setup.py (path:/tmp/pip-YW8Q0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Running setup.py (path:/tmp/pip-WbwLVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 INFO - Running setup.py (path:/tmp/pip-l1Kjgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:57 INFO - Running setup.py (path:/tmp/pip-bLtJhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:57 INFO - Running setup.py (path:/tmp/pip-yOSVjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:57 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)) 05:08:57 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)) 05:08:57 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)) 05:08:57 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)) 05:08:57 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)) 05:08:57 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)) 05:08:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:59 INFO - Downloading blessings-1.6.tar.gz 05:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:59 INFO - Installing collected packages: blessings 05:08:59 INFO - Running setup.py install for blessings 05:08:59 INFO - Successfully installed blessings 05:08:59 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:00 INFO - Reading from file tmpfile_stdout 05:09:00 INFO - Current package versions: 05:09:00 INFO - argparse == 1.2.1 05:09:00 INFO - blessings == 1.6 05:09:00 INFO - blobuploader == 1.2.4 05:09:00 INFO - docopt == 0.6.1 05:09:00 INFO - functools32 == 3.2.3-2 05:09:00 INFO - jsonschema == 2.5.1 05:09:00 INFO - manifestparser == 1.1 05:09:00 INFO - mozInstall == 1.12 05:09:00 INFO - mozcrash == 0.17 05:09:00 INFO - mozdebug == 0.1 05:09:00 INFO - mozdevice == 0.48 05:09:00 INFO - mozfile == 1.2 05:09:00 INFO - mozhttpd == 0.7 05:09:00 INFO - mozinfo == 0.9 05:09:00 INFO - mozleak == 0.1 05:09:00 INFO - mozlog == 3.2 05:09:00 INFO - moznetwork == 0.27 05:09:00 INFO - mozprocess == 0.22 05:09:00 INFO - mozprofile == 0.28 05:09:00 INFO - mozrunner == 6.11 05:09:00 INFO - mozscreenshot == 0.1 05:09:00 INFO - mozsystemmonitor == 0.3 05:09:00 INFO - moztest == 0.7 05:09:00 INFO - mozversion == 1.4 05:09:00 INFO - psutil == 3.1.1 05:09:00 INFO - requests == 1.2.3 05:09:00 INFO - wsgiref == 0.1.2 05:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 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 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:09:00 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 05:09:00 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 05:09:00 INFO - Using env: {'DISPLAY': ':0', 05:09:00 INFO - 'HOME': '/home/cltbld', 05:09:00 INFO - 'LANG': 'en_US.UTF-8', 05:09:00 INFO - 'LANGUAGE': 'en_US:en', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MAIL': '/var/mail/cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SHLVL': '1', 05:09:00 INFO - 'TERM': 'linux', 05:09:00 INFO - 'TMOUT': '86400', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - '_': '/tools/buildbot/bin/python'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:09:00 INFO - Using env: {'DISPLAY': ':0', 05:09:00 INFO - 'HOME': '/home/cltbld', 05:09:00 INFO - 'LANG': 'en_US.UTF-8', 05:09:00 INFO - 'LANGUAGE': 'en_US:en', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MAIL': '/var/mail/cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SHLVL': '1', 05:09:00 INFO - 'TERM': 'linux', 05:09:00 INFO - 'TMOUT': '86400', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - '_': '/tools/buildbot/bin/python'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee71c7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, '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': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', '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 05:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:09:00 INFO - Using env: {'DISPLAY': ':0', 05:09:00 INFO - 'HOME': '/home/cltbld', 05:09:00 INFO - 'LANG': 'en_US.UTF-8', 05:09:00 INFO - 'LANGUAGE': 'en_US:en', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MAIL': '/var/mail/cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SHLVL': '1', 05:09:00 INFO - 'TERM': 'linux', 05:09:00 INFO - 'TMOUT': '86400', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - '_': '/tools/buildbot/bin/python'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 INFO - Downloading/unpacking flake8 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:03 INFO - no previously-included directories found matching 'docs/_build' 05:09:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:03 INFO - Running setup.py install for pep8 05:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:03 INFO - no previously-included directories found matching 'docs/_build' 05:09:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:09:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:03 INFO - Cleaning up... 05:09:03 INFO - Return code: 0 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - Running post-action listener: _start_resource_monitoring 05:09:03 INFO - Starting resource monitoring. 05:09:03 INFO - ##### 05:09:03 INFO - ##### Finished create-virtualenv step (success) 05:09:03 INFO - ##### 05:09:03 INFO - ##### 05:09:03 INFO - ##### Running install step. 05:09:03 INFO - ##### 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: install 05:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:03 INFO - Reading from file tmpfile_stdout 05:09:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:04 INFO - Reading from file tmpfile_stdout 05:09:04 INFO - Output received: 05:09:04 INFO - Usage: mozinstall [options] installer 05:09:04 INFO - Options: 05:09:04 INFO - -h, --help show this help message and exit 05:09:04 INFO - -d DEST, --destination=DEST 05:09:04 INFO - Directory to install application into. [default: 05:09:04 INFO - "/builds/slave/test"] 05:09:04 INFO - --app=APP Application being installed. [default: firefox] 05:09:04 INFO - mkdir: /builds/slave/test/build/application 05:09:04 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'] 05:09:04 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 05:09:20 INFO - Reading from file tmpfile_stdout 05:09:20 INFO - Output received: 05:09:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:20 INFO - Running post-action listener: _resource_record_post_action 05:09:20 INFO - ##### 05:09:20 INFO - ##### Finished install step (success) 05:09:20 INFO - ##### 05:09:20 INFO - ##### 05:09:20 INFO - ##### Running run-tests step. 05:09:20 INFO - ##### 05:09:20 INFO - Running pre-action listener: _resource_record_pre_action 05:09:20 INFO - Running main action method: run_tests 05:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:20 INFO - Python 2.7.3 05:09:20 INFO - Return code: 0 05:09:20 INFO - grabbing minidump binary from tooltool 05:09:20 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')]} 05:09:20 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 0x26621c0>, '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 0x26630c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2663550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:20 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 05:09:20 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 05:09:20 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 05:09:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:20 INFO - Return code: 0 05:09:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:21 INFO - Return code: 0 05:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 05:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 05:09:21 INFO - Using env: {'DISPLAY': ':0', 05:09:21 INFO - 'HOME': '/home/cltbld', 05:09:21 INFO - 'LANG': 'en_US.UTF-8', 05:09:21 INFO - 'LANGUAGE': 'en_US:en', 05:09:21 INFO - 'LOGNAME': 'cltbld', 05:09:21 INFO - 'MAIL': '/var/mail/cltbld', 05:09:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:21 INFO - 'MOZ_NO_REMOTE': '1', 05:09:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:21 INFO - 'NO_EM_RESTART': '1', 05:09:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:21 INFO - 'PWD': '/builds/slave/test', 05:09:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:21 INFO - 'SHELL': '/bin/bash', 05:09:21 INFO - 'SHLVL': '1', 05:09:21 INFO - 'TERM': 'linux', 05:09:21 INFO - 'TMOUT': '86400', 05:09:21 INFO - 'USER': 'cltbld', 05:09:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107', 05:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:21 INFO - '_': '/tools/buildbot/bin/python'} 05:09:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 05:09:21 INFO - mozversion application_buildid: 20160609043328 05:09:21 INFO - mozversion application_changeset: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a 05:09:21 INFO - mozversion application_display_name: Nightly 05:09:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:21 INFO - mozversion application_name: Firefox 05:09:21 INFO - mozversion application_remotingname: firefox 05:09:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:09:21 INFO - mozversion application_vendor: Mozilla 05:09:21 INFO - mozversion application_version: 50.0a1 05:09:21 INFO - mozversion platform_buildid: 20160609043328 05:09:21 INFO - mozversion platform_changeset: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a 05:09:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:09:21 INFO - mozversion platform_version: 50.0a1 05:09:21 INFO - using testdate: 1465474161 05:09:21 INFO - actual date: 1465474161 05:09:21 INFO - starting webserver on 'localhost:49129' 05:09:21 INFO - SUITE-START | Running 2 tests 05:09:21 INFO - TEST-START | dromaeo_css 05:09:21 INFO - operating with platform_type : linux_ 05:09:21 INFO - Initialising browser for dromaeo_css test... 05:09:21 INFO - TEST-INFO | started process 7142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAcGUc/profile http://localhost:49129/getInfo.html) 05:09:26 INFO - PROCESS | 7142 | __metrics Screen width/height:1600/1200 05:09:26 INFO - PROCESS | 7142 | colorDepth:24 05:09:26 INFO - PROCESS | 7142 | Browser inner width/height: 1024/697 05:09:26 INFO - PROCESS | 7142 | __metrics 05:09:26 ERROR - PROCESS | 7142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:09:27 INFO - TEST-INFO | 7142: exit 0 05:09:27 INFO - Browser initialized. 05:09:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:27 INFO - TEST-INFO | started process 7263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAcGUc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:39 INFO - PROCESS | 7263 | RSS: Main: 185606144 05:09:39 INFO - PROCESS | 7263 | 05:10:29 INFO - PROCESS | 7263 | 1465474229545 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] 05:12:41 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49129/tests/dromaeo/cssquery-ext.html) 05:12:42 INFO - PROCESS | 7263 | RSS: Main: 187674624 05:12:42 INFO - PROCESS | 7263 | 05:15:44 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-ext.html (next: http://localhost:49129/tests/dromaeo/cssquery-jquery.html) 05:15:44 INFO - PROCESS | 7263 | RSS: Main: 186916864 05:15:44 INFO - PROCESS | 7263 | 05:18:46 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49129/tests/dromaeo/cssquery-mootools.html) 05:18:47 INFO - PROCESS | 7263 | RSS: Main: 188719104 05:18:47 INFO - PROCESS | 7263 | 05:21:49 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49129/tests/dromaeo/cssquery-prototype.html) 05:21:49 INFO - PROCESS | 7263 | RSS: Main: 186134528 05:21:49 INFO - PROCESS | 7263 | 05:24:52 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49129/tests/dromaeo/cssquery-yui.html) 05:24:53 INFO - PROCESS | 7263 | RSS: Main: 188370944 05:24:53 INFO - PROCESS | 7263 | 05:27:55 INFO - PROCESS | 7263 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-yui.html (next: http://localhost:49129/tests/dromaeo/cssquery-dojo.html) 05:27:56 INFO - PROCESS | 7263 | RSS: Main: 189239296 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | __start_tp_report 05:27:56 INFO - PROCESS | 7263 | _x_x_mozilla_page_load 05:27:56 INFO - PROCESS | 7263 | _x_x_mozilla_page_load_details 05:27:56 INFO - PROCESS | 7263 | |i|pagename|runs| 05:27:56 INFO - PROCESS | 7263 | |0;dojo.html;2579.1230981466306;2636.301380134264;2639.1818536253763;2644.8677566121687;2653.164253260224;4600.815967361302;4713.98649290403;4745.525447455253;4800.543948324904;4820.783064762085;4676.883077923054;4756.429228492577;4762.7856746446405;4773.785179666915;4795.328653988436;4341.218580655481;4370.344448332744;4456.3315502674695;4481.1037792441475;4485.573870482315;4164.604362585549;4491.842785502508;4520.434945631796;4535.183666939949;4536.183486972343;4315.201687687788;4381.518033016366;4389.758563279019;4407.625351845097;4473.2842745160615;4333.263345231318;4338.934915976263;4345.348197770328;4349.543297953701;4378.9562104378865;4364.869053928387;4374.059577190919;4389.780510974439;4395.868123956255;4414.139242847646;4687.601553867926;4768.713877167381;4778.5699287064335;4787.257975013844;4806.206975848981;5041.495850414965;5046.369203849519;5064.848054558369;5073.086844368012;5112.386513618352;5075.061113693979;5098.643094983353;5098.821541246076;5107.055194788976;5136.178211486144;4827.275908613701;4845.370101886732;4846.830360937351;4847.151748444078;4907.631927605408;5254.028004819121;5330.200469929541;5334;5338.54622357104;5398.568114550826;4887.29134275528;5022.547970682656;5047.798088076436;5091.261767043758;5100.387953445536;5173.793048278027;5179.792808287626;5180.119379705459;5186.948130518722;5215.843524694265;4961;5037.521435463698;5048.268001139814;5092.796288148433;5112.6421150519855;4965.255211718271;5043.823466178666;5046.394432668103;5100.1074811907765;5106.66806657566;4303.440552728125;4318.546552611993;4327.242732521796;4356.629686476622;4357.651387888961;3762.247550489913;3790.4124860646093;3807.149455199167;3809.6571308581806;3860.6911447084167;4353.934690979638;4476.597106260452;4484.753338566345;4493.505714371417;4519.728816271035;5126.282320475137;5141.871453213699;5146.125158723026;5152.278680984665;5159.7678104485385;4436.423264975532;4477.955220447819;4478.596926276651;4480.663950203748;4529.162105010583;4474.619657329098;4566.954330456653;4572.474165470947;4612.584867361954;4630.32860235264;4838.322634831126;4855.32025516428;4894.388201474816;4899.461059283405;4914.0908931847725;4994.175960966545;5186.325777649033;5213.270142180022;5213.661112027706;5268.025415298182;4826.638002149923;4827.493113223201;4837.782299796588;4849.684770489906;4877.609791216765;5052.090623687624;5105.081085404514;5122.641415101056;5134.794608215779;5143.61422893292;5170.870728231825;5176.50823171798;5193.42872284056;5205.219217117463;5211.973940130427;4878.170710979213;4942.233953737176;5015.3730783652045;5072.41667208261;5115.462876398074;5003.574696150868;5009.824656137018;5017.197248440378;5021.046001259749;5023.572996295356;4769.9046019080115;4785.760711964457;4903.485134061015;4938.234573641092;4957.702537847741;5011.198208286657;5043.470435604356;5049.798008079636;5095.541401273903;5110.48895110486;4915.754212289443;4957.182064959241;4975.477574854733;4983.227599722049;5015.097282489041 05:27:56 INFO - PROCESS | 7263 | |1;ext.html;521.5175962234935;573.8852229554088;583.591485959828;587.9706014699267;594.6551000419757;39404.21191576167;40833.79583102084;40939.385909211385;40962.38556421656;44163.77918110413;41605.791971040104;41842.372364414485;42124.78937605308;42330.153396932044;42368.78815605918;7805.063392392921;7925.603719814015;7934.45278170757;7945.801354966115;7986.362795626883;7925;7966.163552826956;7989.640466179007;8020.197980201991;8074.273315401612;7987.680492780281;8044.839103217962;8055.31529819966;8058.677652893906;8060.073091594454;7979.640916158787;8006.039275286974;8033.357331413473;8043.638036288381;8052.275295223458;7910.644021019068;7989.5605741684185;7991.880121798177;8000.679972801081;8018.558979256139;38530.80734596309;38920.22159556793;38969.41545876814;38981.22037559261;39030.633927812676;3204.5513628092085;3205.1506350816817;3270.280538281574;3500.652248884198;3519.788812671248;25410.237692869243;25416.618750718753;25626.65235454312;25778.484430311477;26301.47397052048;3006.3386055068067;3034.453798316324;3042.1481985044225;3048.9847550762324;3057.770667199969;258617.7069114661;259694;260619;261749;261971;52290.47709522932;52548.474515255126;52601;52652;53062.73468632632;33625;33892;34227.65772342295;36570.451443228376;54902.17646735302;15801.36794528206;15889.602759931095;15897.125658088917;15906.681866362607;15919.363225471083;12015.279083255033;12098.09264305163;12136;12163.574274900337;12174.878251217551;18269.908650456662;18319;18397.26410943574;18552.81447185511;18561.628767424576;6961.40828029613;7031.402330801837;7091.893836437756;7206.531575447579;7291.598962057138;870.7648934787572;930.4696323095906;931.9887921604999;970.6893793985998;1023.7356864272617;27956.44087118246;28644.570331445044;28675.56986645202;28768.71231287702;29054.564181537295;900;971.8289461199238;999.0509016434416;1039.3452125161252;1103.4813637590319;14373.6406589834;14478.927605361905;14753.40986360555;14909.329080191417;15055.924720376546;407246;408820;409556;410492;412193;49551.50448495469;49642;49862.50137498651;50033.24950125751;50102.248466273035;1185.7628474305002;1190.5297407523979;1216.7688139253337;1217.0932655171953;1224.4122821045949;25860.224193274233;27457.86271068632;27697.723022769515;27714.584281235395;27857.16428507148;41933.58066419297;41971.37042944419;42387.78806106073;42404.36393454162;42434.36348454714;329082;331071;331380;333965;334685;25582.488350233263;25677.229683109537;25938.35154121162;25958.533939275738;26111.73888261093;41357.1728565421;42284.788576056926;42452;42730.57269427266;43578.73159512986;36751.1049475712;36767.264654707295;36960;36991;37193.81403092967;36170.4574431389;36618.45072323864;36701.44947825838;36763;37107.6289237115;36025.63974360328;36050;36220.637793621725;36780.26439471249;36918.815405922796;32743.508847366833;32898.67101329052;33559.16102097467;33738;33925.151871203416;25087.623685644365;25172.874135629205;25535.87232063828;25640.743592563835;25923.481530369663 05:27:56 INFO - PROCESS | 7263 | |2;jquery.html;340.67295396419433;348.80815551446705;352.5593008739076;355.9818917894822;367.2178260305549;15793.605159870995;16600.750988735163;17568.385106521273;17692.026938518375;17727.46817595471;16068.437604683839;16155;16642.1678916054;16783;16802.579935501617;4850.2724591311235;5007.874803129933;5016.799328026875;5059.468755780646;5064.594832413398;3655.2506736119167;4983.900321993558;5517.475839795213;5874.295084589855;5875.559333050017;5838.357780644125;5882.588218824684;5895.911561326584;5925.5555833312455;5930.288365396159;5724.198612194296;5763.5101016413655;5890.145928840294;5891.381404952461;5930.703464826763;4533.977330113361;5039.118154323016;5114.33513643224;5119.078565858144;5138.640295179339;11759.823602645967;12261;12323.445444954908;12403.4418451169;12417.503299867994;1729.437932671874;1788.8926664400178;1792.4264235444664;1816.4369045595909;1929.5465565592074;8987.056359082333;9150;9369.906300936971;11140.610078647289;12075.516979320817;1668.4160543809692;1732.9220185091701;1737.2008875917093;1739.8956062636282;1797.973030404545;69674.65162674154;71099;71739.28260717378;72107.27892721059;73177.6341118291;9611.567479463301;9729;10052.497375131361;10177.18582513397;10817.891821081847;13702.794458083137;13748.793768093487;13807.585772426843;13831.51589694376;13945.372458239404;7130.92869071313;7271.490995630255;7344.706211751577;7507.436942229355;7544.585047822423;7082;7111.217766045731;7138.750143744944;7184.784456466315;7256.201817800038;4250.043740158501;4251.6386107180615;4255.8084886180195;4282.3941022116705;4311.935320970188;1678.169306193442;1682.7055265328763;1769.3718729850718;1789.5436663650685;1793.4440323499757;809.5628360685282;818.705266104202;824.6165533027171;868.1362044765499;899.7390756680489;15088.943773935938;15990.200489975454;16327.918360408123;16589.50231493057;16670.33318667264;814.2346194577078;839.6347588798892;863.0290922711949;878.7363790862715;904.6878826804742;8935.955320223356;9323.487208203478;9351.298652601083;9360.672376466791;9581.473018983883;391680;391997;394378;398276;401213;48446.27330590044;69251.30748692449;76115;77553.61223193961;79719.60140199262;868.0668281597308;881.5900606218139;885.8538341173763;886.8758373827669;888.9244414224734;14116.294185290899;14820.555383338085;15029.774553381489;15061.849381506483;15592.298346574658;34021.65978340185;34777.65222347744;36093;36111.819440902626;36459.635403645625;47555.28667070066;47717.284240735724;48487;48854;49238;7737.458377913492;7760.14638389788;7793.766187014398;7826.708593082078;7850.175731548334;11037.448127593749;12027.27836329823;12111.939440302742;12115.091368147248;12490.500379985062;9984.251181161297;10162.74593135148;10185.84721229197;10352.948235258775;10636.680899573024;7991;10388.37669739818;10491.895081049091;10532.89467105319;10601.41692206936;10404.271700981162;10462.843057353994;10472.947635261775;10532.157427405637;10651.786964260826;7723.459357844897;7840.294373506412;7880.527168369917;8001.8399632008195;8117.391195660231;9535.618575256913;10259.948700256451;10310.690679279634;10474.947625261824;10539 05:27:56 INFO - PROCESS | 7263 | |3;mootools.html;1346.70372518046;1401.9228942408167;1433.2976841347736;1607.3318291635887;1629.6659184867103;6599.934000659992;7149.285071492848;7294.817629559264;7663.118741344747;7698.076230852299;7294.1976382598;7480.289372509603;7536.660850261737;7579.886301705479;7599.848003039936;2142.8392870534694;2179.182806447582;2180.5529866377356;2182.6725991101302;2185.44271210841;2158.287765037534;2178.7276590426195;2199.1313431194667;2201.7137772089604;2206.437358473587;2114.2917122763893;2132.4775430019668;2146.452654573082;2148.4736239621316;2189.6058709432295;2128.404046866872;2132.3176583493287;2132.605467988427;2136.9465763355884;2137.850350475467;2105.463106907744;2127.7233959585155;2128.457243402938;2141.4111119442123;2156.9460763480884;7521.172671006185;7563.659635316424;7582;7598.164201937782;7601.923980760233;4389.495208051083;4472.731636101845;4483.798229079699;4489.753063581502;4508.053308805155;2691.0984820085296;2767.8892844286206;2775.791815613837;2809.592609071673;2812.774978001755;826.1944604011042;876.7457437343163;877.6708734224666;882.6734108379941;1643.9013659180368;9812.215022798158;10063.496825158712;10088;10126.848097278547;10312.484375781256;3832.5400951885954;3880.6701430378735;3901.005243662848;3922.2351641429645;4018.0356714388336;8088.676452941816;8120.903678003394;8122;8125.75622731319;8210.835783284301;4486.394336764561;4486.528914463999;4502.257127573979;4502.662300327489;4509.549045095464;3552.520409744703;4011.398290256485;4122.154958233555;4162.250794856955;4176.18564379943;3251.3822373748912;3287.9506807397906;3347.514610381481;3375.1224681582967;3385.6783605557926;990.3315262197988;1024.08856118055;1031.85038169465;1034.637876743149;1044.1959691037857;813.8636080289241;818.7502811642387;831.1714228696891;842.0695131879307;857.0486759696731;4961.355023846949;4993.151164302078;5013.724245166478;5036.874078148002;5076.213186956028;398.2691760619238;404.3651467196473;404.79557823299047;421.25648230872537;423.6335569732221;3423.606285277225;3456.0495863637702;3536.664016918389;3541.734369922266;3545.2377738786286;8867.201951824367;9206.447613143233;9225.077492250855;9240.21458176049;9321.207697345802;9063.864042039375;9103.271738260923;9185.311101667401;9294.209992150607;9304;7015.9298407016295;7050.0482434871665;7055.753048643272;7092.078029856189;7133.92866071343;4869;4993.550580447777;5083.364579427572;5193.169092945111;5272.9736351318;8348.916510834813;8457.661693532189;8461.830763384822;8507.319414446705;8655.091215422543;8451.577421129043;8527.53098579584;8571.442856214575;8762.737117886474;8811.105612293388;5928.258967629046;6475.967620161869;6587.341265873374;6659.766908158385;6715.160604924385;7150.213476517475;7216.5670059796585;7294.161171465349;7305.1599066105955;7331.890021649786;6385.074164246251;6569.178852643419;6610.867782644416;6643.534952553275;6709.832254193684;6430.549861509649;6457.418832305115;6535.3464653534265;6552.737890484327;6574;6016.969915150396;6062.333143354315;6108.5723999319625;6120.663363515049;6140.416660417253;4267.805277660502;4410.404595379583;4482.305242687388;4486.8878278042;4488.461384633865;4297.742135471882;4333.111712099075;4366.672499562482;4371.1913296039065;4391.8462853799965 05:27:56 INFO - PROCESS | 7263 | |4;prototype.html;273.54591378311994;283.74179496658047;284.13339315088984;289.60035151490945;290.24680952927145;4907.631927605435;4993.675411098276;5072.467390923951;5141.717205553698;5156.215643552482;5042.319286896268;5043.974780126095;5044.16771232747;5063.341765570471;5068.797248110071;3946.1121247719175;3954.675183813426;3958.782266975315;3978.925690063681;3983.1237127831832;3897.6686981606454;3930.3711406175016;3998.900027499307;4008.5790991945864;4015.698822588303;3821.808909554525;3830.923381532368;3873.9031524211837;3889.6467637079586;3901.7463864848837;3881.340172170738;3893.870777474515;3903.551091624471;3928.4303775952612;3931.253061918255;3437.4562823510673;3447.7241820654285;3448.896533104011;3452.4648679454726;3457.6715212054814;4637.675362724611;4909.7790599423115;4937.35814344133;4948.752562371903;4972.314949927035;4389.407429996973;4390.8024138913825;4403.603675669206;4406.22890994078;4410.62509686677;5162.819301324474;5194.220866869962;5196.740162991873;5223.11207094791;5309.150535914235;3479.878204262864;3658.487811706363;3659.2315613721153;3705.277470893177;3712.9814350928073;5407.783688652449;5458.590605704588;5476.698781567012;5484.808031718871;5527.474889885495;3707.1093742191674;3718.0704823794053;3729;3734.3382194923543;3737.271232109767;3771.73597848148;3771.8872932484983;3773.509443772292;3776.4524143999515;3785.6782173515007;4185.497740271187;4320.2655548556195;4320.589543993316;4341.587549182823;4350.73895566267;5227.3465816772905;5242.135047717084;5264.9736751315995;5297.231901374279;5343.519083282523;1220.1702842067302;1263.9873601263869;1286.2796833773118;1290.4322098276728;1297.3837427222184;798.397210106366;823.8311146215011;830.8795224692386;832.5587438657521;835.2190701693936;4188.308929026737;4202.978985105055;4204.26425375558;4233.682473814476;4249.426327445817;4773.427188737304;4790.904181916342;4815.253635686474;4830.758462076952;4833.806647734052;4162.313218318944;4171.958280417157;4215.747055176699;4252.55348188442;4258.212230737324;2520.4520964304857;2537.6827896512937;2611.6343711880354;2612.7648511634043;2628.5925681519393;4546.568076032838;4565.840195593139;4568.634509239253;4597.195490789099;4609.262517997105;4921.753912304442;4943.937053533436;4945.4807245238735;4951.3810773653295;5037.773300201499;4643.7245749583135;4753.928691069636;5173.6548497390195;5183.922241166386;5206.479352064915;5490.940897163564;5516.613837031369;5527.391986881359;5529.668219906657;5573.804916827891;5184.274201611702;5384.19237114436;5404.891902161856;5416.2688037114485;5432.723310022221;5108.463611320758;5127.2565478004735;5143.8456846294675;5161.7677204526635;5192.480751924777;3680.9815950920074;3704.1295295604973;3710.276496083238;3720.1815600567834;3762.586115527235;5021.84934451967;5454.427285135003;5458.808941687181;5469.15228139639;5485.424030476743;5273.235380869829;5314.883874386268;5319.601029922694;5326.573874089986;5355.491228333302;5297.311349524692;5305.957206475612;5350.3312085989255;5355.410904800391;5380.300560927054;5162.277281180713;5192.480751924777;5215.348081489814;5265.368155821173;5270.578353731616;5325.227841962971;5394.894046720491;5402.621816472809;5411.188321751769;5411.972940135274;5245.344331958505;5272.156454967187;5272.604554658493;5280.920786188133;5293.735313234246 05:27:56 INFO - PROCESS | 7263 | |5;yui.html;637.674785859212;640.759715106835;677.8305423644089;712.7540998355568;747.2490147401859;12284.631461056171;13095.34523273835;13101.737965240689;13112.344382780859;13177.209367437961;12146.96750776185;13176.538821141263;13232.941364690825;13261.668458288548;13324.333783310844;758.5524540521092;784.568487331968;793.849168657956;794.8211652378227;801.1707882341777;770.5877355614747;777.3314949143731;779.1857508903181;780.6916268074108;782.6712780632148;808.0263282744279;812.995935020324;813.4956327077191;814.2590242878981;816.8693009118542;805.5166899860095;808.3654331349921;809.1423091523004;809.9230573095547;813.2639960835453;591.3997292747864;593.3087952535291;595.2886300870462;596.0701305962712;598.5540772124751;11449.771004579861;11660.59187928427;11661.067114630894;11667.708307292301;11674.708132296675;10549.525271362807;10937.671869843918;11045.39250341231;11202.887971120266;11429.828552571718;9270.351075424724;9275.814483710355;9347.392419492711;9413.341066125375;9490.572924218426;3120.1107684309864;3166.1926208816603;3198.504231844068;3208.9197770055703;3236.951445728316;53946.19080713792;54339;54339.728301358635;54357.1846422304;56144.71927640377;7497;7711.730089446843;7740.187280335596;7740.535567865946;7753.689852405953;16987.575310617085;17022.659546809242;17034.914825425793;17047.31810727582;17052.403165889133;6170.7223174957235;6388.968055159695;6415.422611964946;6439.8068057958335;6621.172353455818;3503.8248087595516;3538.203904121552;3589.2642008388216;3589.587197472272;3608.0258330250686;2706.6616672915884;2832.7167283271506;2839.858007099637;2839.943201135966;3029.787914845984;569.1917477182411;569.900267453194;570.611983850977;578.9073748200268;582.5165112956236;558.7764894042416;569.814810186691;570.9543236541067;588.5615216663613;596.716559634179;8328.8334233315;8412.453190542717;8451.53516556583;8569.657213711507;8731.126887311219;498.39196180659536;513.9177731562932;585.8213244960243;590.3594599859115;617.1544983372718;3857.556381016163;3943.526776786804;3943.72393932422;3950.940735888964;4012.9398059029136;60327;60926.39073609207;61255.38744612586;61633.69183154056;101726;64016;71399.28600713926;71510;89823.55088224648;90728.54635726911;70300.29699702938;71985.28014719786;72338;72807.63596182091;74455.62772186213;8602.139786021598;8746.51894145828;8762.342824288076;8934.4192627479;8976.237019853124;42720.57279427166;42807.57192428036;42898;43090.78454607707;43268;59086.704566476896;61180;61193.38806611877;61721.691391544555;61986.38013619806;11096.278741881752;11190.664280071285;11219.570500816857;11225.101991840469;11421.543138274375;12145.271283723005;12590.496380144692;12859.610756618125;12909.870901291242;13543.86456135426;11656.417179140839;11827.526898923947;11933.641990740292;12150.57472988441;12196.268223906594;12137.150399471951;12222.938885305872;12406.503739850305;12686.429110689856;12966.01912791025;11465.828012579985;11746.412679366169;11782.234154779911;11795.705107372385;11812.409379530816;9085.682001129928;9168.862467063132;9389.342746007715;9516.286278529276;9771.462569558742;9428.764280892758;9451.716448506555;9728.805423891625;9748.415095094317;9762.609495620096 05:27:56 INFO - PROCESS | 7263 | __end_tp_report 05:27:56 INFO - PROCESS | 7263 | __start_cc_report 05:27:56 INFO - PROCESS | 7263 | _x_x_mozilla_cycle_collect,390 05:27:56 INFO - PROCESS | 7263 | __end_cc_report 05:27:56 INFO - PROCESS | 7263 | __startTimestamp1465475276201__endTimestamp 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | ------- Summary: start ------- 05:27:56 INFO - PROCESS | 7263 | Number of tests: 6 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#0] dojo.html Cycles:165 Average:4742.29 Median:4877.61 stddev:507.65 (10.4%) stddev-sans-first:480.00 05:27:56 INFO - PROCESS | 7263 | Values: 2579.1 2636.3 2639.2 2644.9 2653.2 4600.8 4714.0 4745.5 4800.5 4820.8 4676.9 4756.4 4762.8 4773.8 4795.3 4341.2 4370.3 4456.3 4481.1 4485.6 4164.6 4491.8 4520.4 4535.2 4536.2 4315.2 4381.5 4389.8 4407.6 4473.3 4333.3 4338.9 4345.3 4349.5 4379.0 4364.9 4374.1 4389.8 4395.9 4414.1 4687.6 4768.7 4778.6 4787.3 4806.2 5041.5 5046.4 5064.8 5073.1 5112.4 5075.1 5098.6 5098.8 5107.1 5136.2 4827.3 4845.4 4846.8 4847.2 4907.6 5254.0 5330.2 5334.0 5338.5 5398.6 4887.3 5022.5 5047.8 5091.3 5100.4 5173.8 5179.8 5180.1 5186.9 5215.8 4961.0 5037.5 5048.3 5092.8 5112.6 4965.3 5043.8 5046.4 5100.1 5106.7 4303.4 4318.5 4327.2 4356.6 4357.7 3762.2 3790.4 3807.1 3809.7 3860.7 4353.9 4476.6 4484.8 4493.5 4519.7 5126.3 5141.9 5146.1 5152.3 5159.8 4436.4 4478.0 4478.6 4480.7 4529.2 4474.6 4567.0 4572.5 4612.6 4630.3 4838.3 4855.3 4894.4 4899.5 4914.1 4994.2 5186.3 5213.3 5213.7 5268.0 4826.6 4827.5 4837.8 4849.7 4877.6 5052.1 5105.1 5122.6 5134.8 5143.6 5170.9 5176.5 5193.4 5205.2 5212.0 4878.2 4942.2 5015.4 5072.4 5115.5 5003.6 5009.8 5017.2 5021.0 5023.6 4769.9 4785.8 4903.5 4938.2 4957.7 5011.2 5043.5 5049.8 5095.5 5110.5 4915.8 4957.2 4975.5 4983.2 5015.1 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#1] ext.html Cycles:180 Average:48469.83 Median:36773.76 stddev:89506.63 (243.4%) stddev-sans-first:89685.32 05:27:56 INFO - PROCESS | 7263 | Values: 521.5 573.9 583.6 588.0 594.7 39404.2 40833.8 40939.4 40962.4 44163.8 41605.8 41842.4 42124.8 42330.2 42368.8 7805.1 7925.6 7934.5 7945.8 7986.4 7925.0 7966.2 7989.6 8020.2 8074.3 7987.7 8044.8 8055.3 8058.7 8060.1 7979.6 8006.0 8033.4 8043.6 8052.3 7910.6 7989.6 7991.9 8000.7 8018.6 38530.8 38920.2 38969.4 38981.2 39030.6 3204.6 3205.2 3270.3 3500.7 3519.8 25410.2 25416.6 25626.7 25778.5 26301.5 3006.3 3034.5 3042.1 3049.0 3057.8 258617.7 259694.0 260619.0 261749.0 261971.0 52290.5 52548.5 52601.0 52652.0 53062.7 33625.0 33892.0 34227.7 36570.5 54902.2 15801.4 15889.6 15897.1 15906.7 15919.4 12015.3 12098.1 12136.0 12163.6 12174.9 18269.9 18319.0 18397.3 18552.8 18561.6 6961.4 7031.4 7091.9 7206.5 7291.6 870.8 930.5 932.0 970.7 1023.7 27956.4 28644.6 28675.6 28768.7 29054.6 900.0 971.8 999.1 1039.3 1103.5 14373.6 14478.9 14753.4 14909.3 15055.9 407246.0 408820.0 409556.0 410492.0 412193.0 49551.5 49642.0 49862.5 50033.2 50102.2 1185.8 1190.5 1216.8 1217.1 1224.4 25860.2 27457.9 27697.7 27714.6 27857.2 41933.6 41971.4 42387.8 42404.4 42434.4 329082.0 331071.0 331380.0 333965.0 334685.0 25582.5 25677.2 25938.4 25958.5 26111.7 41357.2 42284.8 42452.0 42730.6 43578.7 36751.1 36767.3 36960.0 36991.0 37193.8 36170.5 36618.5 36701.4 36763.0 37107.6 36025.6 36050.0 36220.6 36780.3 36918.8 32743.5 32898.7 33559.2 33738.0 33925.2 25087.6 25172.9 25535.9 25640.7 25923.5 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#2] jquery.html Cycles:180 Average:23997.82 Median:4269.10 stddev:65190.62 (1527.0%) stddev-sans-first:65349.30 05:27:56 INFO - PROCESS | 7263 | Values: 340.7 348.8 352.6 356.0 367.2 15793.6 16600.8 17568.4 17692.0 17727.5 16068.4 16155.0 16642.2 16783.0 16802.6 4850.3 5007.9 5016.8 5059.5 5064.6 3655.3 4983.9 5517.5 5874.3 5875.6 5838.4 5882.6 5895.9 5925.6 5930.3 5724.2 5763.5 5890.1 5891.4 5930.7 4534.0 5039.1 5114.3 5119.1 5138.6 11759.8 12261.0 12323.4 12403.4 12417.5 1729.4 1788.9 1792.4 1816.4 1929.5 8987.1 9150.0 9369.9 11140.6 12075.5 1668.4 1732.9 1737.2 1739.9 1798.0 69674.7 71099.0 71739.3 72107.3 73177.6 9611.6 9729.0 10052.5 10177.2 10817.9 13702.8 13748.8 13807.6 13831.5 13945.4 7130.9 7271.5 7344.7 7507.4 7544.6 7082.0 7111.2 7138.8 7184.8 7256.2 4250.0 4251.6 4255.8 4282.4 4311.9 1678.2 1682.7 1769.4 1789.5 1793.4 809.6 818.7 824.6 868.1 899.7 15088.9 15990.2 16327.9 16589.5 16670.3 814.2 839.6 863.0 878.7 904.7 8936.0 9323.5 9351.3 9360.7 9581.5 391680.0 391997.0 394378.0 398276.0 401213.0 48446.3 69251.3 76115.0 77553.6 79719.6 868.1 881.6 885.9 886.9 888.9 14116.3 14820.6 15029.8 15061.8 15592.3 34021.7 34777.7 36093.0 36111.8 36459.6 47555.3 47717.3 48487.0 48854.0 49238.0 7737.5 7760.1 7793.8 7826.7 7850.2 11037.4 12027.3 12111.9 12115.1 12490.5 9984.3 10162.7 10185.8 10352.9 10636.7 7991.0 10388.4 10491.9 10532.9 10601.4 10404.3 10462.8 10472.9 10532.2 10651.8 7723.5 7840.3 7880.5 8001.8 8117.4 9535.6 10259.9 10310.7 10474.9 10539.0 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#3] mootools.html Cycles:180 Average:4914.88 Median:4977.25 stddev:2736.96 (55.0%) stddev-sans-first:2731.50 05:27:56 INFO - PROCESS | 7263 | Values: 1346.7 1401.9 1433.3 1607.3 1629.7 6599.9 7149.3 7294.8 7663.1 7698.1 7294.2 7480.3 7536.7 7579.9 7599.8 2142.8 2179.2 2180.6 2182.7 2185.4 2158.3 2178.7 2199.1 2201.7 2206.4 2114.3 2132.5 2146.5 2148.5 2189.6 2128.4 2132.3 2132.6 2136.9 2137.9 2105.5 2127.7 2128.5 2141.4 2156.9 7521.2 7563.7 7582.0 7598.2 7601.9 4389.5 4472.7 4483.8 4489.8 4508.1 2691.1 2767.9 2775.8 2809.6 2812.8 826.2 876.7 877.7 882.7 1643.9 9812.2 10063.5 10088.0 10126.8 10312.5 3832.5 3880.7 3901.0 3922.2 4018.0 8088.7 8120.9 8122.0 8125.8 8210.8 4486.4 4486.5 4502.3 4502.7 4509.5 3552.5 4011.4 4122.2 4162.3 4176.2 3251.4 3288.0 3347.5 3375.1 3385.7 990.3 1024.1 1031.9 1034.6 1044.2 813.9 818.8 831.2 842.1 857.0 4961.4 4993.2 5013.7 5036.9 5076.2 398.3 404.4 404.8 421.3 423.6 3423.6 3456.0 3536.7 3541.7 3545.2 8867.2 9206.4 9225.1 9240.2 9321.2 9063.9 9103.3 9185.3 9294.2 9304.0 7015.9 7050.0 7055.8 7092.1 7133.9 4869.0 4993.6 5083.4 5193.2 5273.0 8348.9 8457.7 8461.8 8507.3 8655.1 8451.6 8527.5 8571.4 8762.7 8811.1 5928.3 6476.0 6587.3 6659.8 6715.2 7150.2 7216.6 7294.2 7305.2 7331.9 6385.1 6569.2 6610.9 6643.5 6709.8 6430.5 6457.4 6535.3 6552.7 6574.0 6017.0 6062.3 6108.6 6120.7 6140.4 4267.8 4410.4 4482.3 4486.9 4488.5 4297.7 4333.1 4366.7 4371.2 4391.8 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#4] prototype.html Cycles:180 Average:4287.63 Median:4823.01 stddev:1280.24 (26.5%) stddev-sans-first:1247.88 05:27:56 INFO - PROCESS | 7263 | Values: 273.5 283.7 284.1 289.6 290.2 4907.6 4993.7 5072.5 5141.7 5156.2 5042.3 5044.0 5044.2 5063.3 5068.8 3946.1 3954.7 3958.8 3978.9 3983.1 3897.7 3930.4 3998.9 4008.6 4015.7 3821.8 3830.9 3873.9 3889.6 3901.7 3881.3 3893.9 3903.6 3928.4 3931.3 3437.5 3447.7 3448.9 3452.5 3457.7 4637.7 4909.8 4937.4 4948.8 4972.3 4389.4 4390.8 4403.6 4406.2 4410.6 5162.8 5194.2 5196.7 5223.1 5309.2 3479.9 3658.5 3659.2 3705.3 3713.0 5407.8 5458.6 5476.7 5484.8 5527.5 3707.1 3718.1 3729.0 3734.3 3737.3 3771.7 3771.9 3773.5 3776.5 3785.7 4185.5 4320.3 4320.6 4341.6 4350.7 5227.3 5242.1 5265.0 5297.2 5343.5 1220.2 1264.0 1286.3 1290.4 1297.4 798.4 823.8 830.9 832.6 835.2 4188.3 4203.0 4204.3 4233.7 4249.4 4773.4 4790.9 4815.3 4830.8 4833.8 4162.3 4172.0 4215.7 4252.6 4258.2 2520.5 2537.7 2611.6 2612.8 2628.6 4546.6 4565.8 4568.6 4597.2 4609.3 4921.8 4943.9 4945.5 4951.4 5037.8 4643.7 4753.9 5173.7 5183.9 5206.5 5490.9 5516.6 5527.4 5529.7 5573.8 5184.3 5384.2 5404.9 5416.3 5432.7 5108.5 5127.3 5143.8 5161.8 5192.5 3681.0 3704.1 3710.3 3720.2 3762.6 5021.8 5454.4 5458.8 5469.2 5485.4 5273.2 5314.9 5319.6 5326.6 5355.5 5297.3 5306.0 5350.3 5355.4 5380.3 5162.3 5192.5 5215.3 5265.4 5270.6 5325.2 5394.9 5402.6 5411.2 5412.0 5245.3 5272.2 5272.6 5280.9 5293.7 05:27:56 INFO - PROCESS | 7263 | 05:27:56 INFO - PROCESS | 7263 | [#5] yui.html Cycles:180 Average:16194.93 Median:584.17 stddev:22239.86 (3807.1%) stddev-sans-first:22271.57 05:27:56 INFO - PROCESS | 7263 | Values: 637.7 640.8 677.8 712.8 747.2 12284.6 13095.3 13101.7 13112.3 13177.2 12147.0 13176.5 13232.9 13261.7 13324.3 758.6 784.6 793.8 794.8 801.2 770.6 777.3 779.2 780.7 782.7 808.0 813.0 813.5 814.3 816.9 805.5 808.4 809.1 809.9 813.3 591.4 593.3 595.3 596.1 598.6 11449.8 11660.6 11661.1 11667.7 11674.7 10549.5 10937.7 11045.4 11202.9 11429.8 9270.4 9275.8 9347.4 9413.3 9490.6 3120.1 3166.2 3198.5 3208.9 3237.0 53946.2 54339.0 54339.7 54357.2 56144.7 7497.0 7711.7 7740.2 7740.5 7753.7 16987.6 17022.7 17034.9 17047.3 17052.4 6170.7 6389.0 6415.4 6439.8 6621.2 3503.8 3538.2 3589.3 3589.6 3608.0 2706.7 2832.7 2839.9 2839.9 3029.8 569.2 569.9 570.6 578.9 582.5 558.8 569.8 571.0 588.6 596.7 8328.8 8412.5 8451.5 8569.7 8731.1 498.4 513.9 585.8 590.4 617.2 3857.6 3943.5 3943.7 3950.9 4012.9 60327.0 60926.4 61255.4 61633.7 101726.0 64016.0 71399.3 71510.0 89823.6 90728.5 70300.3 71985.3 72338.0 72807.6 74455.6 8602.1 8746.5 8762.3 8934.4 8976.2 42720.6 42807.6 42898.0 43090.8 43268.0 59086.7 61180.0 61193.4 61721.7 61986.4 11096.3 11190.7 11219.6 11225.1 11421.5 12145.3 12590.5 12859.6 12909.9 13543.9 11656.4 11827.5 11933.6 12150.6 12196.3 12137.2 12222.9 12406.5 12686.4 12966.0 11465.8 11746.4 11782.2 11795.7 11812.4 9085.7 9168.9 9389.3 9516.3 9771.5 9428.8 9451.7 9728.8 9748.4 9762.6 05:27:56 INFO - PROCESS | 7263 | -------- Summary: end -------- 05:27:56 INFO - PROCESS | 7263 | 05:27:57 INFO - TEST-INFO | 7263: exit 0 05:27:57 INFO - TEST-OK | dromaeo_css | took 1115823ms 05:27:57 INFO - TEST-START | kraken 05:27:57 INFO - operating with platform_type : linux_ 05:27:57 INFO - Initialising browser for kraken test... 05:27:57 INFO - TEST-INFO | started process 7502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7DDnj/profile http://localhost:49129/getInfo.html) 05:28:02 INFO - PROCESS | 7502 | __metrics Screen width/height:1600/1200 05:28:02 INFO - PROCESS | 7502 | colorDepth:24 05:28:02 INFO - PROCESS | 7502 | Browser inner width/height: 1024/697 05:28:02 INFO - PROCESS | 7502 | __metrics 05:28:02 ERROR - PROCESS | 7502 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:28:03 INFO - TEST-INFO | 7502: exit 0 05:28:03 INFO - Browser initialized. 05:28:03 INFO - Running cycle 1/1 for kraken test... 05:28:03 INFO - TEST-INFO | started process 7619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7DDnj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:15 INFO - PROCESS | 7619 | RSS: Main: 185954304 05:28:15 INFO - PROCESS | 7619 | 05:28:18 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:19 INFO - PROCESS | 7619 | RSS: Main: 189980672 05:28:19 INFO - PROCESS | 7619 | 05:28:22 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-dft) 05:28:22 INFO - PROCESS | 7619 | RSS: Main: 190058496 05:28:22 INFO - PROCESS | 7619 | 05:28:25 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-fft) 05:28:26 INFO - PROCESS | 7619 | RSS: Main: 185241600 05:28:26 INFO - PROCESS | 7619 | 05:28:28 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator) 05:28:29 INFO - PROCESS | 7619 | RSS: Main: 185925632 05:28:29 INFO - PROCESS | 7619 | 05:28:31 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:32 INFO - PROCESS | 7619 | RSS: Main: 186142720 05:28:32 INFO - PROCESS | 7619 | 05:28:35 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:35 INFO - PROCESS | 7619 | RSS: Main: 186384384 05:28:35 INFO - PROCESS | 7619 | 05:28:39 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:40 INFO - PROCESS | 7619 | RSS: Main: 183918592 05:28:40 INFO - PROCESS | 7619 | 05:28:43 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial) 05:28:43 INFO - PROCESS | 7619 | RSS: Main: 184979456 05:28:43 INFO - PROCESS | 7619 | 05:28:45 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:46 INFO - PROCESS | 7619 | RSS: Main: 185069568 05:28:46 INFO - PROCESS | 7619 | 05:28:47 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:48 INFO - PROCESS | 7619 | RSS: Main: 184954880 05:28:48 INFO - PROCESS | 7619 | 05:28:50 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:51 INFO - PROCESS | 7619 | RSS: Main: 185577472 05:28:51 INFO - PROCESS | 7619 | 05:28:54 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:55 INFO - PROCESS | 7619 | RSS: Main: 186490880 05:28:55 INFO - PROCESS | 7619 | 05:28:57 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:58 INFO - PROCESS | 7619 | RSS: Main: 185991168 05:28:58 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49129/tests/kraken/driver.html?testName=ai-astar) 05:29:00 INFO - PROCESS | 7619 | RSS: Main: 186687488 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | __start_tp_report 05:29:00 INFO - PROCESS | 7619 | _x_x_mozilla_page_load 05:29:00 INFO - PROCESS | 7619 | _x_x_mozilla_page_load_details 05:29:00 INFO - PROCESS | 7619 | |i|pagename|runs| 05:29:00 INFO - PROCESS | 7619 | |0;ai-astar;115;108;116;114;114;119;115;115;115;114 05:29:00 INFO - PROCESS | 7619 | |1;audio-beat-detection;153;137;158;195;138;160;150;132;182;133 05:29:00 INFO - PROCESS | 7619 | |2;audio-dft;162;165;180;163;164;163;173;162;161;166 05:29:00 INFO - PROCESS | 7619 | |3;audio-fft;76;76;77;156;77;77;75;76;157;77 05:29:00 INFO - PROCESS | 7619 | |4;audio-oscillator;86;86;154;86;86;86;128;87;89;148 05:29:00 INFO - PROCESS | 7619 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;122;119;119 05:29:00 INFO - PROCESS | 7619 | |6;imaging-darkroom;149;148;147;150;149;149;147;148;149;149 05:29:00 INFO - PROCESS | 7619 | |7;imaging-desaturate;96;96;96;95;96;95;96;100;96;96 05:29:00 INFO - PROCESS | 7619 | |8;json-parse-financial;65;71;64;66;65;68;69;64;66;67 05:29:00 INFO - PROCESS | 7619 | |9;json-stringify-tinderbox;65;66;64;65;66;66;65;65;66;65 05:29:00 INFO - PROCESS | 7619 | |10;stanford-crypto-aes;84;89;88;90;89;85;85;86;124;86 05:29:00 INFO - PROCESS | 7619 | |11;stanford-crypto-ccm;134;132;137;143;155;136;133;140;145;135 05:29:00 INFO - PROCESS | 7619 | |12;stanford-crypto-pbkdf2;177;176;171;170;173;166;169;169;171;172 05:29:00 INFO - PROCESS | 7619 | |13;stanford-crypto-sha256-iterative;68;66;68;67;69;72;70;66;65;66 05:29:00 INFO - PROCESS | 7619 | __end_tp_report 05:29:00 INFO - PROCESS | 7619 | __start_cc_report 05:29:00 INFO - PROCESS | 7619 | _x_x_mozilla_cycle_collect,975 05:29:00 INFO - PROCESS | 7619 | __end_cc_report 05:29:00 INFO - PROCESS | 7619 | __startTimestamp1465475340544__endTimestamp 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | ------- Summary: start ------- 05:29:00 INFO - PROCESS | 7619 | Number of tests: 14 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.72 (2.4%) stddev-sans-first:2.88 05:29:00 INFO - PROCESS | 7619 | Values: 115.0 108.0 116.0 114.0 114.0 119.0 115.0 115.0 115.0 114.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:155.50 stddev:21.09 (13.6%) stddev-sans-first:22.37 05:29:00 INFO - PROCESS | 7619 | Values: 153.0 137.0 158.0 195.0 138.0 160.0 150.0 132.0 182.0 133.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.50 stddev:6.01 (3.7%) stddev-sans-first:6.20 05:29:00 INFO - PROCESS | 7619 | Values: 162.0 165.0 180.0 163.0 164.0 163.0 173.0 162.0 161.0 166.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.50 stddev:33.79 (44.2%) stddev-sans-first:35.32 05:29:00 INFO - PROCESS | 7619 | Values: 76.0 76.0 77.0 156.0 77.0 77.0 75.0 76.0 157.0 77.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:86.00 stddev:28.17 (32.8%) stddev-sans-first:29.16 05:29:00 INFO - PROCESS | 7619 | Values: 86.0 86.0 154.0 86.0 86.0 86.0 128.0 87.0 89.0 148.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.35 (1.1%) stddev-sans-first:1.42 05:29:00 INFO - PROCESS | 7619 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 122.0 119.0 119.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:29:00 INFO - PROCESS | 7619 | Values: 149.0 148.0 147.0 150.0 149.0 149.0 147.0 148.0 149.0 149.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 05:29:00 INFO - PROCESS | 7619 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 100.0 96.0 96.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.50 stddev:2.27 (3.4%) stddev-sans-first:2.35 05:29:00 INFO - PROCESS | 7619 | Values: 65.0 71.0 64.0 66.0 65.0 68.0 69.0 64.0 66.0 67.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:29:00 INFO - PROCESS | 7619 | Values: 65.0 66.0 64.0 65.0 66.0 66.0 65.0 65.0 66.0 65.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:87.00 stddev:11.91 (13.7%) stddev-sans-first:12.39 05:29:00 INFO - PROCESS | 7619 | Values: 84.0 89.0 88.0 90.0 89.0 85.0 85.0 86.0 124.0 86.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.50 stddev:7.06 (5.1%) stddev-sans-first:7.25 05:29:00 INFO - PROCESS | 7619 | Values: 134.0 132.0 137.0 143.0 155.0 136.0 133.0 140.0 145.0 135.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:3.31 (1.9%) stddev-sans-first:2.82 05:29:00 INFO - PROCESS | 7619 | Values: 177.0 176.0 171.0 170.0 173.0 166.0 169.0 169.0 171.0 172.0 05:29:00 INFO - PROCESS | 7619 | 05:29:00 INFO - PROCESS | 7619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:2.16 (3.2%) stddev-sans-first:2.29 05:29:00 INFO - PROCESS | 7619 | Values: 68.0 66.0 68.0 67.0 69.0 72.0 70.0 66.0 65.0 66.0 05:29:00 INFO - PROCESS | 7619 | -------- Summary: end -------- 05:29:00 INFO - PROCESS | 7619 | 05:29:01 INFO - TEST-INFO | 7619: exit 0 05:29:01 INFO - TEST-OK | kraken | took 64593ms 05:29:01 INFO - SUITE-END | took 1180s 05:29:01 INFO - Completed test suite (00:19:40) 05:29:01 INFO - javascript benchmark 05:29:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6322.655737347089, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.1230981466306, 2636.301380134264, 2639.1818536253763, 2644.8677566121687, 2653.164253260224, 4600.815967361302, 4713.98649290403, 4745.525447455253, 4800.543948324904, 4820.783064762085, 4676.883077923054, 4756.429228492577, 4762.7856746446405, 4773.785179666915, 4795.328653988436, 4341.218580655481, 4370.344448332744, 4456.3315502674695, 4481.1037792441475, 4485.573870482315, 4164.604362585549, 4491.842785502508, 4520.434945631796, 4535.183666939949, 4536.183486972343, 4315.201687687788, 4381.518033016366, 4389.758563279019, 4407.625351845097, 4473.2842745160615, 4333.263345231318, 4338.934915976263, 4345.348197770328, 4349.543297953701, 4378.9562104378865, 4364.869053928387, 4374.059577190919, 4389.780510974439, 4395.868123956255, 4414.139242847646, 4687.601553867926, 4768.713877167381, 4778.5699287064335, 4787.257975013844, 4806.206975848981, 5041.495850414965, 5046.369203849519, 5064.848054558369, 5073.086844368012, 5112.386513618352, 5075.061113693979, 5098.643094983353, 5098.821541246076, 5107.055194788976, 5136.178211486144, 4827.275908613701, 4845.370101886732, 4846.830360937351, 4847.151748444078, 4907.631927605408, 5254.028004819121, 5330.200469929541, 5334.0, 5338.54622357104, 5398.568114550826, 4887.29134275528, 5022.547970682656, 5047.798088076436, 5091.261767043758, 5100.387953445536, 5173.793048278027, 5179.792808287626, 5180.119379705459, 5186.948130518722, 5215.843524694265, 4961.0, 5037.521435463698, 5048.268001139814, 5092.796288148433, 5112.6421150519855, 4965.255211718271, 5043.823466178666, 5046.394432668103, 5100.1074811907765, 5106.66806657566, 4303.440552728125, 4318.546552611993, 4327.242732521796, 4356.629686476622, 4357.651387888961, 3762.247550489913, 3790.4124860646093, 3807.149455199167, 3809.6571308581806, 3860.6911447084167, 4353.934690979638, 4476.597106260452, 4484.753338566345, 4493.505714371417, 4519.728816271035, 5126.282320475137, 5141.871453213699, 5146.125158723026, 5152.278680984665, 5159.7678104485385, 4436.423264975532, 4477.955220447819, 4478.596926276651, 4480.663950203748, 4529.162105010583, 4474.619657329098, 4566.954330456653, 4572.474165470947, 4612.584867361954, 4630.32860235264, 4838.322634831126, 4855.32025516428, 4894.388201474816, 4899.461059283405, 4914.0908931847725, 4994.175960966545, 5186.325777649033, 5213.270142180022, 5213.661112027706, 5268.025415298182, 4826.638002149923, 4827.493113223201, 4837.782299796588, 4849.684770489906, 4877.609791216765, 5052.090623687624, 5105.081085404514, 5122.641415101056, 5134.794608215779, 5143.61422893292, 5170.870728231825, 5176.50823171798, 5193.42872284056, 5205.219217117463, 5211.973940130427, 4878.170710979213, 4942.233953737176, 5015.3730783652045, 5072.41667208261, 5115.462876398074, 5003.574696150868, 5009.824656137018, 5017.197248440378, 5021.046001259749, 5023.572996295356, 4769.9046019080115, 4785.760711964457, 4903.485134061015, 4938.234573641092, 4957.702537847741, 5011.198208286657, 5043.470435604356, 5049.798008079636, 5095.541401273903, 5110.48895110486, 4915.754212289443, 4957.182064959241, 4975.477574854733, 4983.227599722049, 5015.097282489041], "value": 4709.014521588775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.5175962234935, 573.8852229554088, 583.591485959828, 587.9706014699267, 594.6551000419757, 39404.21191576167, 40833.79583102084, 40939.385909211385, 40962.38556421656, 44163.77918110413, 41605.791971040104, 41842.372364414485, 42124.78937605308, 42330.153396932044, 42368.78815605918, 7805.063392392921, 7925.603719814015, 7934.45278170757, 7945.801354966115, 7986.362795626883, 7925.0, 7966.163552826956, 7989.640466179007, 8020.197980201991, 8074.273315401612, 7987.680492780281, 8044.839103217962, 8055.31529819966, 8058.677652893906, 8060.073091594454, 7979.640916158787, 8006.039275286974, 8033.357331413473, 8043.638036288381, 8052.275295223458, 7910.644021019068, 7989.5605741684185, 7991.880121798177, 8000.679972801081, 8018.558979256139, 38530.80734596309, 38920.22159556793, 38969.41545876814, 38981.22037559261, 39030.633927812676, 3204.5513628092085, 3205.1506350816817, 3270.280538281574, 3500.652248884198, 3519.788812671248, 25410.237692869243, 25416.618750718753, 25626.65235454312, 25778.484430311477, 26301.47397052048, 3006.3386055068067, 3034.453798316324, 3042.1481985044225, 3048.9847550762324, 3057.770667199969, 258617.7069114661, 259694.0, 260619.0, 261749.0, 261971.0, 52290.47709522932, 52548.474515255126, 52601.0, 52652.0, 53062.73468632632, 33625.0, 33892.0, 34227.65772342295, 36570.451443228376, 54902.17646735302, 15801.36794528206, 15889.602759931095, 15897.125658088917, 15906.681866362607, 15919.363225471083, 12015.279083255033, 12098.09264305163, 12136.0, 12163.574274900337, 12174.878251217551, 18269.908650456662, 18319.0, 18397.26410943574, 18552.81447185511, 18561.628767424576, 6961.40828029613, 7031.402330801837, 7091.893836437756, 7206.531575447579, 7291.598962057138, 870.7648934787572, 930.4696323095906, 931.9887921604999, 970.6893793985998, 1023.7356864272617, 27956.44087118246, 28644.570331445044, 28675.56986645202, 28768.71231287702, 29054.564181537295, 900.0, 971.8289461199238, 999.0509016434416, 1039.3452125161252, 1103.4813637590319, 14373.6406589834, 14478.927605361905, 14753.40986360555, 14909.329080191417, 15055.924720376546, 407246.0, 408820.0, 409556.0, 410492.0, 412193.0, 49551.50448495469, 49642.0, 49862.50137498651, 50033.24950125751, 50102.248466273035, 1185.7628474305002, 1190.5297407523979, 1216.7688139253337, 1217.0932655171953, 1224.4122821045949, 25860.224193274233, 27457.86271068632, 27697.723022769515, 27714.584281235395, 27857.16428507148, 41933.58066419297, 41971.37042944419, 42387.78806106073, 42404.36393454162, 42434.36348454714, 329082.0, 331071.0, 331380.0, 333965.0, 334685.0, 25582.488350233263, 25677.229683109537, 25938.35154121162, 25958.533939275738, 26111.73888261093, 41357.1728565421, 42284.788576056926, 42452.0, 42730.57269427266, 43578.73159512986, 36751.1049475712, 36767.264654707295, 36960.0, 36991.0, 37193.81403092967, 36170.4574431389, 36618.45072323864, 36701.44947825838, 36763.0, 37107.6289237115, 36025.63974360328, 36050.0, 36220.637793621725, 36780.26439471249, 36918.815405922796, 32743.508847366833, 32898.67101329052, 33559.16102097467, 33738.0, 33925.151871203416, 25087.623685644365, 25172.874135629205, 25535.87232063828, 25640.743592563835, 25923.481530369663], "value": 17651.090608958664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.67295396419433, 348.80815551446705, 352.5593008739076, 355.9818917894822, 367.2178260305549, 15793.605159870995, 16600.750988735163, 17568.385106521273, 17692.026938518375, 17727.46817595471, 16068.437604683839, 16155.0, 16642.1678916054, 16783.0, 16802.579935501617, 4850.2724591311235, 5007.874803129933, 5016.799328026875, 5059.468755780646, 5064.594832413398, 3655.2506736119167, 4983.900321993558, 5517.475839795213, 5874.295084589855, 5875.559333050017, 5838.357780644125, 5882.588218824684, 5895.911561326584, 5925.5555833312455, 5930.288365396159, 5724.198612194296, 5763.5101016413655, 5890.145928840294, 5891.381404952461, 5930.703464826763, 4533.977330113361, 5039.118154323016, 5114.33513643224, 5119.078565858144, 5138.640295179339, 11759.823602645967, 12261.0, 12323.445444954908, 12403.4418451169, 12417.503299867994, 1729.437932671874, 1788.8926664400178, 1792.4264235444664, 1816.4369045595909, 1929.5465565592074, 8987.056359082333, 9150.0, 9369.906300936971, 11140.610078647289, 12075.516979320817, 1668.4160543809692, 1732.9220185091701, 1737.2008875917093, 1739.8956062636282, 1797.973030404545, 69674.65162674154, 71099.0, 71739.28260717378, 72107.27892721059, 73177.6341118291, 9611.567479463301, 9729.0, 10052.497375131361, 10177.18582513397, 10817.891821081847, 13702.794458083137, 13748.793768093487, 13807.585772426843, 13831.51589694376, 13945.372458239404, 7130.92869071313, 7271.490995630255, 7344.706211751577, 7507.436942229355, 7544.585047822423, 7082.0, 7111.217766045731, 7138.750143744944, 7184.784456466315, 7256.201817800038, 4250.043740158501, 4251.6386107180615, 4255.8084886180195, 4282.3941022116705, 4311.935320970188, 1678.169306193442, 1682.7055265328763, 1769.3718729850718, 1789.5436663650685, 1793.4440323499757, 809.5628360685282, 818.705266104202, 824.6165533027171, 868.1362044765499, 899.7390756680489, 15088.943773935938, 15990.200489975454, 16327.918360408123, 16589.50231493057, 16670.33318667264, 814.2346194577078, 839.6347588798892, 863.0290922711949, 878.7363790862715, 904.6878826804742, 8935.955320223356, 9323.487208203478, 9351.298652601083, 9360.672376466791, 9581.473018983883, 391680.0, 391997.0, 394378.0, 398276.0, 401213.0, 48446.27330590044, 69251.30748692449, 76115.0, 77553.61223193961, 79719.60140199262, 868.0668281597308, 881.5900606218139, 885.8538341173763, 886.8758373827669, 888.9244414224734, 14116.294185290899, 14820.555383338085, 15029.774553381489, 15061.849381506483, 15592.298346574658, 34021.65978340185, 34777.65222347744, 36093.0, 36111.819440902626, 36459.635403645625, 47555.28667070066, 47717.284240735724, 48487.0, 48854.0, 49238.0, 7737.458377913492, 7760.14638389788, 7793.766187014398, 7826.708593082078, 7850.175731548334, 11037.448127593749, 12027.27836329823, 12111.939440302742, 12115.091368147248, 12490.500379985062, 9984.251181161297, 10162.74593135148, 10185.84721229197, 10352.948235258775, 10636.680899573024, 7991.0, 10388.37669739818, 10491.895081049091, 10532.89467105319, 10601.41692206936, 10404.271700981162, 10462.843057353994, 10472.947635261775, 10532.157427405637, 10651.786964260826, 7723.459357844897, 7840.294373506412, 7880.527168369917, 8001.8399632008195, 8117.391195660231, 9535.618575256913, 10259.948700256451, 10310.690679279634, 10474.947625261824, 10539.0], "value": 8033.447057973521, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.70372518046, 1401.9228942408167, 1433.2976841347736, 1607.3318291635887, 1629.6659184867103, 6599.934000659992, 7149.285071492848, 7294.817629559264, 7663.118741344747, 7698.076230852299, 7294.1976382598, 7480.289372509603, 7536.660850261737, 7579.886301705479, 7599.848003039936, 2142.8392870534694, 2179.182806447582, 2180.5529866377356, 2182.6725991101302, 2185.44271210841, 2158.287765037534, 2178.7276590426195, 2199.1313431194667, 2201.7137772089604, 2206.437358473587, 2114.2917122763893, 2132.4775430019668, 2146.452654573082, 2148.4736239621316, 2189.6058709432295, 2128.404046866872, 2132.3176583493287, 2132.605467988427, 2136.9465763355884, 2137.850350475467, 2105.463106907744, 2127.7233959585155, 2128.457243402938, 2141.4111119442123, 2156.9460763480884, 7521.172671006185, 7563.659635316424, 7582.0, 7598.164201937782, 7601.923980760233, 4389.495208051083, 4472.731636101845, 4483.798229079699, 4489.753063581502, 4508.053308805155, 2691.0984820085296, 2767.8892844286206, 2775.791815613837, 2809.592609071673, 2812.774978001755, 826.1944604011042, 876.7457437343163, 877.6708734224666, 882.6734108379941, 1643.9013659180368, 9812.215022798158, 10063.496825158712, 10088.0, 10126.848097278547, 10312.484375781256, 3832.5400951885954, 3880.6701430378735, 3901.005243662848, 3922.2351641429645, 4018.0356714388336, 8088.676452941816, 8120.903678003394, 8122.0, 8125.75622731319, 8210.835783284301, 4486.394336764561, 4486.528914463999, 4502.257127573979, 4502.662300327489, 4509.549045095464, 3552.520409744703, 4011.398290256485, 4122.154958233555, 4162.250794856955, 4176.18564379943, 3251.3822373748912, 3287.9506807397906, 3347.514610381481, 3375.1224681582967, 3385.6783605557926, 990.3315262197988, 1024.08856118055, 1031.85038169465, 1034.637876743149, 1044.1959691037857, 813.8636080289241, 818.7502811642387, 831.1714228696891, 842.0695131879307, 857.0486759696731, 4961.355023846949, 4993.151164302078, 5013.724245166478, 5036.874078148002, 5076.213186956028, 398.2691760619238, 404.3651467196473, 404.79557823299047, 421.25648230872537, 423.6335569732221, 3423.606285277225, 3456.0495863637702, 3536.664016918389, 3541.734369922266, 3545.2377738786286, 8867.201951824367, 9206.447613143233, 9225.077492250855, 9240.21458176049, 9321.207697345802, 9063.864042039375, 9103.271738260923, 9185.311101667401, 9294.209992150607, 9304.0, 7015.9298407016295, 7050.0482434871665, 7055.753048643272, 7092.078029856189, 7133.92866071343, 4869.0, 4993.550580447777, 5083.364579427572, 5193.169092945111, 5272.9736351318, 8348.916510834813, 8457.661693532189, 8461.830763384822, 8507.319414446705, 8655.091215422543, 8451.577421129043, 8527.53098579584, 8571.442856214575, 8762.737117886474, 8811.105612293388, 5928.258967629046, 6475.967620161869, 6587.341265873374, 6659.766908158385, 6715.160604924385, 7150.213476517475, 7216.5670059796585, 7294.161171465349, 7305.1599066105955, 7331.890021649786, 6385.074164246251, 6569.178852643419, 6610.867782644416, 6643.534952553275, 6709.832254193684, 6430.549861509649, 6457.418832305115, 6535.3464653534265, 6552.737890484327, 6574.0, 6016.969915150396, 6062.333143354315, 6108.5723999319625, 6120.663363515049, 6140.416660417253, 4267.805277660502, 4410.404595379583, 4482.305242687388, 4486.8878278042, 4488.461384633865, 4297.742135471882, 4333.111712099075, 4366.672499562482, 4371.1913296039065, 4391.8462853799965], "value": 3918.1667007942874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.54591378311994, 283.74179496658047, 284.13339315088984, 289.60035151490945, 290.24680952927145, 4907.631927605435, 4993.675411098276, 5072.467390923951, 5141.717205553698, 5156.215643552482, 5042.319286896268, 5043.974780126095, 5044.16771232747, 5063.341765570471, 5068.797248110071, 3946.1121247719175, 3954.675183813426, 3958.782266975315, 3978.925690063681, 3983.1237127831832, 3897.6686981606454, 3930.3711406175016, 3998.900027499307, 4008.5790991945864, 4015.698822588303, 3821.808909554525, 3830.923381532368, 3873.9031524211837, 3889.6467637079586, 3901.7463864848837, 3881.340172170738, 3893.870777474515, 3903.551091624471, 3928.4303775952612, 3931.253061918255, 3437.4562823510673, 3447.7241820654285, 3448.896533104011, 3452.4648679454726, 3457.6715212054814, 4637.675362724611, 4909.7790599423115, 4937.35814344133, 4948.752562371903, 4972.314949927035, 4389.407429996973, 4390.8024138913825, 4403.603675669206, 4406.22890994078, 4410.62509686677, 5162.819301324474, 5194.220866869962, 5196.740162991873, 5223.11207094791, 5309.150535914235, 3479.878204262864, 3658.487811706363, 3659.2315613721153, 3705.277470893177, 3712.9814350928073, 5407.783688652449, 5458.590605704588, 5476.698781567012, 5484.808031718871, 5527.474889885495, 3707.1093742191674, 3718.0704823794053, 3729.0, 3734.3382194923543, 3737.271232109767, 3771.73597848148, 3771.8872932484983, 3773.509443772292, 3776.4524143999515, 3785.6782173515007, 4185.497740271187, 4320.2655548556195, 4320.589543993316, 4341.587549182823, 4350.73895566267, 5227.3465816772905, 5242.135047717084, 5264.9736751315995, 5297.231901374279, 5343.519083282523, 1220.1702842067302, 1263.9873601263869, 1286.2796833773118, 1290.4322098276728, 1297.3837427222184, 798.397210106366, 823.8311146215011, 830.8795224692386, 832.5587438657521, 835.2190701693936, 4188.308929026737, 4202.978985105055, 4204.26425375558, 4233.682473814476, 4249.426327445817, 4773.427188737304, 4790.904181916342, 4815.253635686474, 4830.758462076952, 4833.806647734052, 4162.313218318944, 4171.958280417157, 4215.747055176699, 4252.55348188442, 4258.212230737324, 2520.4520964304857, 2537.6827896512937, 2611.6343711880354, 2612.7648511634043, 2628.5925681519393, 4546.568076032838, 4565.840195593139, 4568.634509239253, 4597.195490789099, 4609.262517997105, 4921.753912304442, 4943.937053533436, 4945.4807245238735, 4951.3810773653295, 5037.773300201499, 4643.7245749583135, 4753.928691069636, 5173.6548497390195, 5183.922241166386, 5206.479352064915, 5490.940897163564, 5516.613837031369, 5527.391986881359, 5529.668219906657, 5573.804916827891, 5184.274201611702, 5384.19237114436, 5404.891902161856, 5416.2688037114485, 5432.723310022221, 5108.463611320758, 5127.2565478004735, 5143.8456846294675, 5161.7677204526635, 5192.480751924777, 3680.9815950920074, 3704.1295295604973, 3710.276496083238, 3720.1815600567834, 3762.586115527235, 5021.84934451967, 5454.427285135003, 5458.808941687181, 5469.15228139639, 5485.424030476743, 5273.235380869829, 5314.883874386268, 5319.601029922694, 5326.573874089986, 5355.491228333302, 5297.311349524692, 5305.957206475612, 5350.3312085989255, 5355.410904800391, 5380.300560927054, 5162.277281180713, 5192.480751924777, 5215.348081489814, 5265.368155821173, 5270.578353731616, 5325.227841962971, 5394.894046720491, 5402.621816472809, 5411.188321751769, 5411.972940135274, 5245.344331958505, 5272.156454967187, 5272.604554658493, 5280.920786188133, 5293.735313234246], "value": 3869.64411023975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.674785859212, 640.759715106835, 677.8305423644089, 712.7540998355568, 747.2490147401859, 12284.631461056171, 13095.34523273835, 13101.737965240689, 13112.344382780859, 13177.209367437961, 12146.96750776185, 13176.538821141263, 13232.941364690825, 13261.668458288548, 13324.333783310844, 758.5524540521092, 784.568487331968, 793.849168657956, 794.8211652378227, 801.1707882341777, 770.5877355614747, 777.3314949143731, 779.1857508903181, 780.6916268074108, 782.6712780632148, 808.0263282744279, 812.995935020324, 813.4956327077191, 814.2590242878981, 816.8693009118542, 805.5166899860095, 808.3654331349921, 809.1423091523004, 809.9230573095547, 813.2639960835453, 591.3997292747864, 593.3087952535291, 595.2886300870462, 596.0701305962712, 598.5540772124751, 11449.771004579861, 11660.59187928427, 11661.067114630894, 11667.708307292301, 11674.708132296675, 10549.525271362807, 10937.671869843918, 11045.39250341231, 11202.887971120266, 11429.828552571718, 9270.351075424724, 9275.814483710355, 9347.392419492711, 9413.341066125375, 9490.572924218426, 3120.1107684309864, 3166.1926208816603, 3198.504231844068, 3208.9197770055703, 3236.951445728316, 53946.19080713792, 54339.0, 54339.728301358635, 54357.1846422304, 56144.71927640377, 7497.0, 7711.730089446843, 7740.187280335596, 7740.535567865946, 7753.689852405953, 16987.575310617085, 17022.659546809242, 17034.914825425793, 17047.31810727582, 17052.403165889133, 6170.7223174957235, 6388.968055159695, 6415.422611964946, 6439.8068057958335, 6621.172353455818, 3503.8248087595516, 3538.203904121552, 3589.2642008388216, 3589.587197472272, 3608.0258330250686, 2706.6616672915884, 2832.7167283271506, 2839.858007099637, 2839.943201135966, 3029.787914845984, 569.1917477182411, 569.900267453194, 570.611983850977, 578.9073748200268, 582.5165112956236, 558.7764894042416, 569.814810186691, 570.9543236541067, 588.5615216663613, 596.716559634179, 8328.8334233315, 8412.453190542717, 8451.53516556583, 8569.657213711507, 8731.126887311219, 498.39196180659536, 513.9177731562932, 585.8213244960243, 590.3594599859115, 617.1544983372718, 3857.556381016163, 3943.526776786804, 3943.72393932422, 3950.940735888964, 4012.9398059029136, 60327.0, 60926.39073609207, 61255.38744612586, 61633.69183154056, 101726.0, 64016.0, 71399.28600713926, 71510.0, 89823.55088224648, 90728.54635726911, 70300.29699702938, 71985.28014719786, 72338.0, 72807.63596182091, 74455.62772186213, 8602.139786021598, 8746.51894145828, 8762.342824288076, 8934.4192627479, 8976.237019853124, 42720.57279427166, 42807.57192428036, 42898.0, 43090.78454607707, 43268.0, 59086.704566476896, 61180.0, 61193.38806611877, 61721.691391544555, 61986.38013619806, 11096.278741881752, 11190.664280071285, 11219.570500816857, 11225.101991840469, 11421.543138274375, 12145.271283723005, 12590.496380144692, 12859.610756618125, 12909.870901291242, 13543.86456135426, 11656.417179140839, 11827.526898923947, 11933.641990740292, 12150.57472988441, 12196.268223906594, 12137.150399471951, 12222.938885305872, 12406.503739850305, 12686.429110689856, 12966.01912791025, 11465.828012579985, 11746.412679366169, 11782.234154779911, 11795.705107372385, 11812.409379530816, 9085.682001129928, 9168.862467063132, 9389.342746007715, 9516.286278529276, 9771.462569558742, 9428.764280892758, 9451.716448506555, 9728.805423891625, 9748.415095094317, 9762.609495620096], "value": 6309.415370295656, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 116.0, 114.0, 114.0, 119.0, 115.0, 115.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 137.0, 158.0, 195.0, 138.0, 160.0, 150.0, 132.0, 182.0, 133.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 180.0, 163.0, 164.0, 163.0, 173.0, 162.0, 161.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 156.0, 77.0, 77.0, 75.0, 76.0, 157.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 154.0, 86.0, 86.0, 86.0, 128.0, 87.0, 89.0, 148.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 122.0, 119.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 150.0, 149.0, 149.0, 147.0, 148.0, 149.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 100.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 64.0, 66.0, 65.0, 68.0, 69.0, 64.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 88.0, 90.0, 89.0, 85.0, 85.0, 86.0, 124.0, 86.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 137.0, 143.0, 155.0, 136.0, 133.0, 140.0, 145.0, 135.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 171.0, 170.0, 173.0, 166.0, 169.0, 169.0, 171.0, 172.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 67.0, 69.0, 72.0, 70.0, 66.0, 65.0, 66.0], "value": 67.7, "unit": "score"}]}]} 05:29:01 INFO - Return code: 0 05:29:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:01 ERROR - # TBPL SUCCESS # 05:29:01 INFO - Running post-action listener: _resource_record_post_action 05:29:01 INFO - ##### 05:29:01 INFO - ##### Finished run-tests step (success) 05:29:01 INFO - ##### 05:29:01 INFO - Running post-run listener: _resource_record_post_run 05:29:01 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 376832; Write bytes: 308076544; Read time: 136; Write time: 233532 05:29:01 INFO - TinderboxPrint: CPU usage
13.5% 05:29:01 INFO - TinderboxPrint: I/O read bytes / time
376,832 / 136 05:29:01 INFO - TinderboxPrint: I/O write bytes / time
308,076,544 / 233,532 05:29:01 INFO - TinderboxPrint: CPU idle
8,269.2 (86.5%) 05:29:01 INFO - TinderboxPrint: CPU user
1,232.8 (12.9%) 05:29:01 INFO - TinderboxPrint: Swap in / out
0 / 0 05:29:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15392768; Read time: 0; Write time: 8552 05:29:01 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 376832; Write bytes: 292683776; Read time: 136; Write time: 224980 05:29:02 INFO - Running post-run listener: _upload_blobber_files 05:29:02 INFO - Blob upload gear active. 05:29:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:02 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 05:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:03 INFO - (blobuploader) - INFO - Done attempting. 05:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:04 INFO - (blobuploader) - INFO - Done attempting. 05:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:08 INFO - (blobuploader) - INFO - Done attempting. 05:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:08 INFO - Return code: 0 05:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab867c86f104a754ce5208306ded2d4a300e50e15dabd5704dc307451c980d359c9f6fbdf297a58d06fafb57fdf422a0ac42e7ec4642d675f0505075c7cebc40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca781ce61fc72039889732af4c37180976c5898522eae55bee184f9ab28e5261b8e1883d701eea7de1adbaa39576124304a2df37225f88b0f6fc7a3463fceb88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d68424b1bf5fb0b50eaedbe0c3428d70259f758865c9ecaa8aa5c5593db9c930b87f362fe0620ff3e6fd48d3b64aca59221794ba5a4094152797097f8d577"} 05:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:08 INFO - Contents: 05:29:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab867c86f104a754ce5208306ded2d4a300e50e15dabd5704dc307451c980d359c9f6fbdf297a58d06fafb57fdf422a0ac42e7ec4642d675f0505075c7cebc40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca781ce61fc72039889732af4c37180976c5898522eae55bee184f9ab28e5261b8e1883d701eea7de1adbaa39576124304a2df37225f88b0f6fc7a3463fceb88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d68424b1bf5fb0b50eaedbe0c3428d70259f758865c9ecaa8aa5c5593db9c930b87f362fe0620ff3e6fd48d3b64aca59221794ba5a4094152797097f8d577"} 05:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:08 INFO - Copying logs to upload dir... 05:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.944336 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-09 05:29:08.895264) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:29:08.898783) ========= 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=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab867c86f104a754ce5208306ded2d4a300e50e15dabd5704dc307451c980d359c9f6fbdf297a58d06fafb57fdf422a0ac42e7ec4642d675f0505075c7cebc40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca781ce61fc72039889732af4c37180976c5898522eae55bee184f9ab28e5261b8e1883d701eea7de1adbaa39576124304a2df37225f88b0f6fc7a3463fceb88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d68424b1bf5fb0b50eaedbe0c3428d70259f758865c9ecaa8aa5c5593db9c930b87f362fe0620ff3e6fd48d3b64aca59221794ba5a4094152797097f8d577"} build_url:https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/VihdZ2z7RSyseir6WMAZEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab867c86f104a754ce5208306ded2d4a300e50e15dabd5704dc307451c980d359c9f6fbdf297a58d06fafb57fdf422a0ac42e7ec4642d675f0505075c7cebc40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca781ce61fc72039889732af4c37180976c5898522eae55bee184f9ab28e5261b8e1883d701eea7de1adbaa39576124304a2df37225f88b0f6fc7a3463fceb88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d68424b1bf5fb0b50eaedbe0c3428d70259f758865c9ecaa8aa5c5593db9c930b87f362fe0620ff3e6fd48d3b64aca59221794ba5a4094152797097f8d577"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:29:08.925492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:29:08.925885) ========= 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=41bf3e9aed84707956354da8000001c5-1465473835.316322-278439107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:29:08.977380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:29:08.977886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:29:08.978365) ========= ========= Total master_lag: 0.38 =========