builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1466037445.43 results: success (0) buildid: 20160615143006 builduid: c84279e32457496b9dc8dcf171e4ff13 revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.430887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.431296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.431577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.474656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.474936) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 17:37:25-- 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% 225M=0s 2016-06-15 17:37:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151574 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.677464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.677761) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.113893 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:25.803004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:37:25.803354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --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 c914e1312fd6cede0da6dcaa1c605eaf07849138 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 17:37:25,870 truncating revision to first 12 chars 2016-06-15 17:37:25,870 Setting DEBUG logging. 2016-06-15 17:37:25,870 attempt 1/10 2016-06-15 17:37:25,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c914e1312fd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 17:37:26,864 unpacking tar archive at: fx-team-c914e1312fd6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:37:27.186439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:27.186988) ========= script_repo_revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:27.187686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:27.188194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:37:27.196248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-06-15 17:37:27.196780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:37:27 INFO - MultiFileLogger online at 20160615 17:37:27 in /builds/slave/test 17:37:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:37:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:27 INFO - {'append_to_log': False, 17:37:27 INFO - 'base_work_dir': '/builds/slave/test', 17:37:27 INFO - 'blob_upload_branch': 'Fx-Team', 17:37:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:27 INFO - 'branch': 'Fx-Team', 17:37:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:27 INFO - 'config_files': ('talos/linux_config.py',), 17:37:27 INFO - 'default_actions': ('clobber', 17:37:27 INFO - 'read-buildbot-config', 17:37:27 INFO - 'download-and-extract', 17:37:27 INFO - 'populate-webroot', 17:37:27 INFO - 'create-virtualenv', 17:37:27 INFO - 'install', 17:37:27 INFO - 'run-tests'), 17:37:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:27 INFO - 'download_minidump_stackwalk': True, 17:37:27 INFO - 'download_symbols': 'ondemand', 17:37:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:27 INFO - 'installer_path': 'installer.exe', 17:37:27 INFO - 'log_level': 'info', 17:37:27 INFO - 'log_name': 'talos', 17:37:27 INFO - 'log_to_console': True, 17:37:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:37:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:37:27 INFO - 'opt_config_files': (), 17:37:27 INFO - 'pip_index': False, 17:37:27 INFO - 'sps_profile': False, 17:37:27 INFO - 'sps_profile_interval': 0, 17:37:27 INFO - 'suite': 'dromaeojs-e10s', 17:37:27 INFO - 'system_bits': '32', 17:37:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:27 INFO - 'title': 'talos-linux64-ix-038', 17:37:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:27 INFO - 'use_talos_json': True, 17:37:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:27 INFO - 'work_dir': 'build'} 17:37:27 INFO - ##### 17:37:27 INFO - ##### Running clobber step. 17:37:27 INFO - ##### 17:37:27 INFO - Running pre-action listener: _resource_record_pre_action 17:37:27 INFO - Running main action method: clobber 17:37:27 INFO - rmtree: /builds/slave/test/build 17:37:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:30 INFO - Running post-action listener: _resource_record_post_action 17:37:30 INFO - ##### 17:37:30 INFO - ##### Finished clobber step (success) 17:37:30 INFO - ##### 17:37:30 INFO - ##### 17:37:30 INFO - ##### Running read-buildbot-config step. 17:37:30 INFO - ##### 17:37:30 INFO - Running pre-action listener: _resource_record_pre_action 17:37:30 INFO - Running main action method: read_buildbot_config 17:37:30 INFO - Using buildbot properties: 17:37:30 INFO - { 17:37:30 INFO - "project": "", 17:37:30 INFO - "product": "firefox", 17:37:30 INFO - "script_repo_revision": "production", 17:37:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:37:30 INFO - "repository": "", 17:37:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:37:30 INFO - "buildid": "20160615143006", 17:37:30 INFO - "pgo_build": "True", 17:37:30 INFO - "basedir": "/builds/slave/test", 17:37:30 INFO - "buildnumber": 477, 17:37:30 INFO - "slavename": "talos-linux64-ix-038", 17:37:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:37:30 INFO - "platform": "ubuntu64_hw", 17:37:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:37:30 INFO - "branch": "fx-team", 17:37:30 INFO - "repo_path": "integration/fx-team", 17:37:30 INFO - "revision": "c914e1312fd6cede0da6dcaa1c605eaf07849138", 17:37:30 INFO - "stage_platform": "linux64-pgo", 17:37:30 INFO - "builduid": "c84279e32457496b9dc8dcf171e4ff13", 17:37:30 INFO - "slavebuilddir": "test" 17:37:30 INFO - } 17:37:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:37:30 INFO - Running post-action listener: _resource_record_post_action 17:37:30 INFO - ##### 17:37:30 INFO - ##### Finished read-buildbot-config step (success) 17:37:30 INFO - ##### 17:37:30 INFO - ##### 17:37:30 INFO - ##### Running download-and-extract step. 17:37:30 INFO - ##### 17:37:30 INFO - Running pre-action listener: _resource_record_pre_action 17:37:30 INFO - Running main action method: download_and_extract 17:37:30 INFO - mkdir: /builds/slave/test/build/tests 17:37: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')]} 17:37:30 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:37:30 INFO - Downloaded 1361 bytes. 17:37:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:37:30 INFO - Using the following test package requirements: 17:37:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:37:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:37:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:37:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'jsshell-linux-x86_64.zip'], 17:37:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:37:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:37:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:37:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:37:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:37:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:37:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:37: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')]} 17:37:30 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:41 INFO - Downloaded 24220662 bytes. 17:38:41 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'] 17:38:41 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 17:38:43 INFO - Return code: 0 17:38:43 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 17:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:43 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:44 INFO - Downloaded 24220662 bytes. 17:38:44 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'] 17:38:44 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 17:38:46 INFO - Return code: 0 17:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:46 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:50 INFO - Downloaded 14405384 bytes. 17:38:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:38:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:38:50 INFO - Return code: 0 17:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:50 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:39:11 INFO - Downloaded 59367946 bytes. 17:39:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:39:11 INFO - mkdir: /builds/slave/test/properties 17:39:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:39:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:39:11 INFO - Contents: 17:39:11 INFO - build_url:https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:39:12 INFO - Running post-action listener: _resource_record_post_action 17:39:12 INFO - Running post-action listener: set_extra_try_arguments 17:39:12 INFO - ##### 17:39:12 INFO - ##### Finished download-and-extract step (success) 17:39:12 INFO - ##### 17:39:12 INFO - ##### 17:39:12 INFO - ##### Running populate-webroot step. 17:39:12 INFO - ##### 17:39:12 INFO - Running pre-action listener: _resource_record_pre_action 17:39:12 INFO - Running main action method: populate_webroot 17:39:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:39:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:39:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:39:12 INFO - '--tppagecycles', 17:39:12 INFO - '7'], 17:39:12 INFO - 'tests': ['tsvgm']}}, 17:39:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:39:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:39:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:39:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:39:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['damp', 'tps']}, 17:39:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'tests': ['damp', 'tps']}, 17:39:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['dromaeo_dom']}, 17:39:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:39:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['basic_compositor_video']}, 17:39:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:39:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'other-e10s': {'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['a11yr', 17:39:12 INFO - 'ts_paint', 17:39:12 INFO - 'tpaint', 17:39:12 INFO - 'sessionrestore', 17:39:12 INFO - 'sessionrestore_no_auto_restore', 17:39:12 INFO - 'tabpaint']}, 17:39:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['tsvgx', 17:39:12 INFO - 'tsvgr_opacity', 17:39:12 INFO - 'tart', 17:39:12 INFO - 'tscrollx', 17:39:12 INFO - 'cart']}, 17:39:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:39:12 INFO - 'tsvgr_opacity', 17:39:12 INFO - 'tart', 17:39:12 INFO - 'tscrollx', 17:39:12 INFO - 'cart']}, 17:39:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'talos_options': ['--disable-e10s'], 17:39:12 INFO - 'tests': ['tp5o']}, 17:39:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'tests': ['tp5o']}, 17:39:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'talos_options': ['--disable-e10s', 17:39:12 INFO - '--xperf_path', 17:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:12 INFO - 'tests': ['tp5n']}, 17:39:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:12 INFO - 'talos_options': ['--xperf_path', 17:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:12 INFO - 'tests': ['tp5n']}}, 17:39:12 INFO - 'talos.zip': {'path': '', 17:39:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:39:12 INFO - Running post-action listener: _resource_record_post_action 17:39:12 INFO - ##### 17:39:12 INFO - ##### Finished populate-webroot step (success) 17:39:12 INFO - ##### 17:39:12 INFO - ##### 17:39:12 INFO - ##### Running create-virtualenv step. 17:39:12 INFO - ##### 17:39:12 INFO - Running pre-action listener: _resource_record_pre_action 17:39:12 INFO - Running main action method: create_virtualenv 17:39:12 INFO - Creating virtualenv /builds/slave/test/build/venv 17:39:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:39:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:39:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:39:12 INFO - Using real prefix '/usr' 17:39:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:39:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:39:14 INFO - Installing pip.................done. 17:39:14 INFO - Return code: 0 17:39:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:39:14 INFO - Using env: {'DISPLAY': ':0', 17:39:14 INFO - 'HOME': '/home/cltbld', 17:39:14 INFO - 'LANG': 'en_US.UTF-8', 17:39:14 INFO - 'LANGUAGE': 'en_US:en', 17:39:14 INFO - 'LOGNAME': 'cltbld', 17:39:14 INFO - 'MAIL': '/var/mail/cltbld', 17:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:14 INFO - 'MOZ_NO_REMOTE': '1', 17:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:14 INFO - 'NO_EM_RESTART': '1', 17:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:14 INFO - 'PWD': '/builds/slave/test', 17:39:14 INFO - 'SHELL': '/bin/bash', 17:39:14 INFO - 'SHLVL': '1', 17:39:14 INFO - 'TERM': 'linux', 17:39:14 INFO - 'TMOUT': '86400', 17:39:14 INFO - 'USER': 'cltbld', 17:39:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:14 INFO - '_': '/tools/buildbot/bin/python'} 17:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:39:15 INFO - Cleaning up... 17:39:15 INFO - Return code: 0 17:39:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:39:15 INFO - Using env: {'DISPLAY': ':0', 17:39:15 INFO - 'HOME': '/home/cltbld', 17:39:15 INFO - 'LANG': 'en_US.UTF-8', 17:39:15 INFO - 'LANGUAGE': 'en_US:en', 17:39:15 INFO - 'LOGNAME': 'cltbld', 17:39:15 INFO - 'MAIL': '/var/mail/cltbld', 17:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:15 INFO - 'MOZ_NO_REMOTE': '1', 17:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:15 INFO - 'NO_EM_RESTART': '1', 17:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:15 INFO - 'PWD': '/builds/slave/test', 17:39:15 INFO - 'SHELL': '/bin/bash', 17:39:15 INFO - 'SHLVL': '1', 17:39:15 INFO - 'TERM': 'linux', 17:39:15 INFO - 'TMOUT': '86400', 17:39:15 INFO - 'USER': 'cltbld', 17:39:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:15 INFO - '_': '/tools/buildbot/bin/python'} 17:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:15 INFO - Downloading/unpacking psutil>=3.1.1 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:39:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:17 INFO - Installing collected packages: psutil 17:39:17 INFO - Running setup.py install for psutil 17:39:17 INFO - building 'psutil._psutil_linux' extension 17:39:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:39:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:39:18 INFO - building 'psutil._psutil_posix' extension 17:39:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:39:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:39:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:19 INFO - Successfully installed psutil 17:39:19 INFO - Cleaning up... 17:39:19 INFO - Return code: 0 17:39:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:39:19 INFO - Using env: {'DISPLAY': ':0', 17:39:19 INFO - 'HOME': '/home/cltbld', 17:39:19 INFO - 'LANG': 'en_US.UTF-8', 17:39:19 INFO - 'LANGUAGE': 'en_US:en', 17:39:19 INFO - 'LOGNAME': 'cltbld', 17:39:19 INFO - 'MAIL': '/var/mail/cltbld', 17:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:19 INFO - 'MOZ_NO_REMOTE': '1', 17:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:19 INFO - 'NO_EM_RESTART': '1', 17:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:19 INFO - 'PWD': '/builds/slave/test', 17:39:19 INFO - 'SHELL': '/bin/bash', 17:39:19 INFO - 'SHLVL': '1', 17:39:19 INFO - 'TERM': 'linux', 17:39:19 INFO - 'TMOUT': '86400', 17:39:19 INFO - 'USER': 'cltbld', 17:39:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:19 INFO - '_': '/tools/buildbot/bin/python'} 17:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:39:21 INFO - Installing collected packages: mozsystemmonitor 17:39:21 INFO - Running setup.py install for mozsystemmonitor 17:39:21 INFO - Successfully installed mozsystemmonitor 17:39:21 INFO - Cleaning up... 17:39:21 INFO - Return code: 0 17:39:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:21 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:39:21 INFO - Using env: {'DISPLAY': ':0', 17:39:21 INFO - 'HOME': '/home/cltbld', 17:39:21 INFO - 'LANG': 'en_US.UTF-8', 17:39:21 INFO - 'LANGUAGE': 'en_US:en', 17:39:21 INFO - 'LOGNAME': 'cltbld', 17:39:21 INFO - 'MAIL': '/var/mail/cltbld', 17:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:21 INFO - 'MOZ_NO_REMOTE': '1', 17:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:21 INFO - 'NO_EM_RESTART': '1', 17:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:21 INFO - 'PWD': '/builds/slave/test', 17:39:21 INFO - 'SHELL': '/bin/bash', 17:39:21 INFO - 'SHLVL': '1', 17:39:21 INFO - 'TERM': 'linux', 17:39:21 INFO - 'TMOUT': '86400', 17:39:21 INFO - 'USER': 'cltbld', 17:39:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:21 INFO - '_': '/tools/buildbot/bin/python'} 17:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:21 INFO - Downloading/unpacking jsonschema==2.5.1 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:23 INFO - warning: no files found matching '*.txt' 17:39:23 INFO - no previously-included directories found matching 'build' 17:39:23 INFO - no previously-included directories found matching 'dist' 17:39:23 INFO - no previously-included directories found matching '.git*' 17:39:23 INFO - Installing collected packages: jsonschema, functools32 17:39:23 INFO - Running setup.py install for functools32 17:39:24 INFO - warning: no files found matching '*.txt' 17:39:24 INFO - no previously-included directories found matching 'build' 17:39:24 INFO - no previously-included directories found matching 'dist' 17:39:24 INFO - no previously-included directories found matching '.git*' 17:39:24 INFO - Successfully installed jsonschema functools32 17:39:24 INFO - Cleaning up... 17:39:24 INFO - Return code: 0 17:39:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:39:24 INFO - Using env: {'DISPLAY': ':0', 17:39:24 INFO - 'HOME': '/home/cltbld', 17:39:24 INFO - 'LANG': 'en_US.UTF-8', 17:39:24 INFO - 'LANGUAGE': 'en_US:en', 17:39:24 INFO - 'LOGNAME': 'cltbld', 17:39:24 INFO - 'MAIL': '/var/mail/cltbld', 17:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:24 INFO - 'MOZ_NO_REMOTE': '1', 17:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:24 INFO - 'NO_EM_RESTART': '1', 17:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:24 INFO - 'PWD': '/builds/slave/test', 17:39:24 INFO - 'SHELL': '/bin/bash', 17:39:24 INFO - 'SHLVL': '1', 17:39:24 INFO - 'TERM': 'linux', 17:39:24 INFO - 'TMOUT': '86400', 17:39:24 INFO - 'USER': 'cltbld', 17:39:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:24 INFO - '_': '/tools/buildbot/bin/python'} 17:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - Downloading docopt-0.6.1.tar.gz 17:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:26 INFO - Running setup.py install for blobuploader 17:39:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:27 INFO - Running setup.py install for requests 17:39:27 INFO - Running setup.py install for docopt 17:39:27 INFO - Successfully installed blobuploader requests docopt 17:39:27 INFO - Cleaning up... 17:39:27 INFO - Return code: 0 17:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:27 INFO - Using env: {'DISPLAY': ':0', 17:39:27 INFO - 'HOME': '/home/cltbld', 17:39:27 INFO - 'LANG': 'en_US.UTF-8', 17:39:27 INFO - 'LANGUAGE': 'en_US:en', 17:39:27 INFO - 'LOGNAME': 'cltbld', 17:39:27 INFO - 'MAIL': '/var/mail/cltbld', 17:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:27 INFO - 'MOZ_NO_REMOTE': '1', 17:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:27 INFO - 'NO_EM_RESTART': '1', 17:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:27 INFO - 'PWD': '/builds/slave/test', 17:39:27 INFO - 'SHELL': '/bin/bash', 17:39:27 INFO - 'SHLVL': '1', 17:39:27 INFO - 'TERM': 'linux', 17:39:27 INFO - 'TMOUT': '86400', 17:39:27 INFO - 'USER': 'cltbld', 17:39:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:27 INFO - '_': '/tools/buildbot/bin/python'} 17:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:27 INFO - Running setup.py (path:/tmp/pip-YnqK8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:27 INFO - Running setup.py (path:/tmp/pip-5BDS5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:27 INFO - Running setup.py (path:/tmp/pip-Il92Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:28 INFO - Running setup.py (path:/tmp/pip-aLi2Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:28 INFO - Running setup.py (path:/tmp/pip-vbIAYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:28 INFO - Running setup.py (path:/tmp/pip-fohwzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:28 INFO - Running setup.py (path:/tmp/pip-cg8GSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:28 INFO - Running setup.py (path:/tmp/pip-xRYDa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:28 INFO - Running setup.py (path:/tmp/pip-0nYSFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:28 INFO - Running setup.py (path:/tmp/pip-fV_UdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:28 INFO - Running setup.py (path:/tmp/pip-ib0gQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:28 INFO - Running setup.py (path:/tmp/pip-LY4Ix3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:28 INFO - Running setup.py (path:/tmp/pip-Gc1BvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:28 INFO - Running setup.py (path:/tmp/pip-8tOIrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:28 INFO - Running setup.py (path:/tmp/pip-_qyMHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:28 INFO - Running setup.py (path:/tmp/pip-PIjMs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:28 INFO - Running setup.py (path:/tmp/pip-4Xb6aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:29 INFO - Running setup.py install for manifestparser 17:39:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Running setup.py install for mozcrash 17:39:29 INFO - Running setup.py install for mozdebug 17:39:29 INFO - Running setup.py install for mozdevice 17:39:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Running setup.py install for mozfile 17:39:29 INFO - Running setup.py install for mozhttpd 17:39:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Running setup.py install for mozinfo 17:39:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Running setup.py install for mozInstall 17:39:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Running setup.py install for mozleak 17:39:29 INFO - Running setup.py install for mozlog 17:39:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Running setup.py install for moznetwork 17:39:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Running setup.py install for mozprocess 17:39:30 INFO - Running setup.py install for mozprofile 17:39:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Running setup.py install for mozrunner 17:39:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Running setup.py install for mozscreenshot 17:39:30 INFO - Running setup.py install for moztest 17:39:30 INFO - Running setup.py install for mozversion 17:39:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:30 INFO - Cleaning up... 17:39:30 INFO - Return code: 0 17:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:30 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:30 INFO - Using env: {'DISPLAY': ':0', 17:39:30 INFO - 'HOME': '/home/cltbld', 17:39:30 INFO - 'LANG': 'en_US.UTF-8', 17:39:30 INFO - 'LANGUAGE': 'en_US:en', 17:39:30 INFO - 'LOGNAME': 'cltbld', 17:39:30 INFO - 'MAIL': '/var/mail/cltbld', 17:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:30 INFO - 'MOZ_NO_REMOTE': '1', 17:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:30 INFO - 'NO_EM_RESTART': '1', 17:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:30 INFO - 'PWD': '/builds/slave/test', 17:39:30 INFO - 'SHELL': '/bin/bash', 17:39:30 INFO - 'SHLVL': '1', 17:39:30 INFO - 'TERM': 'linux', 17:39:30 INFO - 'TMOUT': '86400', 17:39:30 INFO - 'USER': 'cltbld', 17:39:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:30 INFO - '_': '/tools/buildbot/bin/python'} 17:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:31 INFO - Running setup.py (path:/tmp/pip-YMs53L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:31 INFO - Running setup.py (path:/tmp/pip-8gNuge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:31 INFO - Running setup.py (path:/tmp/pip-pYu643-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:31 INFO - Running setup.py (path:/tmp/pip-90GHYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:31 INFO - Running setup.py (path:/tmp/pip-UgRPFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:31 INFO - Running setup.py (path:/tmp/pip-XxNydF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:31 INFO - Running setup.py (path:/tmp/pip-goTakV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:31 INFO - Running setup.py (path:/tmp/pip-o2azMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:31 INFO - Running setup.py (path:/tmp/pip-yN70_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:31 INFO - Running setup.py (path:/tmp/pip-fR5T1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:31 INFO - Running setup.py (path:/tmp/pip-LDwK7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:31 INFO - Running setup.py (path:/tmp/pip-_6_6wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:31 INFO - Running setup.py (path:/tmp/pip-FOLOgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:31 INFO - Running setup.py (path:/tmp/pip-ERl0Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:32 INFO - Running setup.py (path:/tmp/pip-KmTXVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:32 INFO - Running setup.py (path:/tmp/pip-_ASMsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:32 INFO - Running setup.py (path:/tmp/pip-fKr9PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:34 INFO - Downloading blessings-1.6.tar.gz 17:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:34 INFO - Installing collected packages: blessings 17:39:34 INFO - Running setup.py install for blessings 17:39:34 INFO - Successfully installed blessings 17:39:34 INFO - Cleaning up... 17:39:34 INFO - Return code: 0 17:39:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:34 INFO - Reading from file tmpfile_stdout 17:39:34 INFO - Current package versions: 17:39:34 INFO - argparse == 1.2.1 17:39:34 INFO - blessings == 1.6 17:39:34 INFO - blobuploader == 1.2.4 17:39:34 INFO - docopt == 0.6.1 17:39:34 INFO - functools32 == 3.2.3-2 17:39:34 INFO - jsonschema == 2.5.1 17:39:34 INFO - manifestparser == 1.1 17:39:34 INFO - mozInstall == 1.12 17:39:34 INFO - mozcrash == 0.17 17:39:34 INFO - mozdebug == 0.1 17:39:34 INFO - mozdevice == 0.48 17:39:34 INFO - mozfile == 1.2 17:39:34 INFO - mozhttpd == 0.7 17:39:34 INFO - mozinfo == 0.9 17:39:34 INFO - mozleak == 0.1 17:39:34 INFO - mozlog == 3.2 17:39:34 INFO - moznetwork == 0.27 17:39:34 INFO - mozprocess == 0.22 17:39:34 INFO - mozprofile == 0.28 17:39:34 INFO - mozrunner == 6.11 17:39:34 INFO - mozscreenshot == 0.1 17:39:34 INFO - mozsystemmonitor == 0.3 17:39:34 INFO - moztest == 0.7 17:39:34 INFO - mozversion == 1.4 17:39:34 INFO - psutil == 3.1.1 17:39:34 INFO - requests == 1.2.3 17:39:34 INFO - wsgiref == 0.1.2 17:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:34 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:34 INFO - Using env: {'DISPLAY': ':0', 17:39:34 INFO - 'HOME': '/home/cltbld', 17:39:34 INFO - 'LANG': 'en_US.UTF-8', 17:39:34 INFO - 'LANGUAGE': 'en_US:en', 17:39:34 INFO - 'LOGNAME': 'cltbld', 17:39:34 INFO - 'MAIL': '/var/mail/cltbld', 17:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:34 INFO - 'MOZ_NO_REMOTE': '1', 17:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:34 INFO - 'NO_EM_RESTART': '1', 17:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:34 INFO - 'PWD': '/builds/slave/test', 17:39:34 INFO - 'SHELL': '/bin/bash', 17:39:34 INFO - 'SHLVL': '1', 17:39:34 INFO - 'TERM': 'linux', 17:39:34 INFO - 'TMOUT': '86400', 17:39:34 INFO - 'USER': 'cltbld', 17:39:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:34 INFO - '_': '/tools/buildbot/bin/python'} 17:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:34 INFO - Cleaning up... 17:39:34 INFO - Return code: 0 17:39:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:34 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:39:34 INFO - Using env: {'DISPLAY': ':0', 17:39:34 INFO - 'HOME': '/home/cltbld', 17:39:34 INFO - 'LANG': 'en_US.UTF-8', 17:39:34 INFO - 'LANGUAGE': 'en_US:en', 17:39:34 INFO - 'LOGNAME': 'cltbld', 17:39:34 INFO - 'MAIL': '/var/mail/cltbld', 17:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:34 INFO - 'MOZ_NO_REMOTE': '1', 17:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:34 INFO - 'NO_EM_RESTART': '1', 17:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:34 INFO - 'PWD': '/builds/slave/test', 17:39:34 INFO - 'SHELL': '/bin/bash', 17:39:34 INFO - 'SHLVL': '1', 17:39:34 INFO - 'TERM': 'linux', 17:39:34 INFO - 'TMOUT': '86400', 17:39:34 INFO - 'USER': 'cltbld', 17:39:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:34 INFO - '_': '/tools/buildbot/bin/python'} 17:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:39:35 INFO - Cleaning up... 17:39:35 INFO - Return code: 0 17:39:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:35 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 0x7f2772c75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:39:35 INFO - Using env: {'DISPLAY': ':0', 17:39:35 INFO - 'HOME': '/home/cltbld', 17:39:35 INFO - 'LANG': 'en_US.UTF-8', 17:39:35 INFO - 'LANGUAGE': 'en_US:en', 17:39:35 INFO - 'LOGNAME': 'cltbld', 17:39:35 INFO - 'MAIL': '/var/mail/cltbld', 17:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:35 INFO - 'MOZ_NO_REMOTE': '1', 17:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:35 INFO - 'NO_EM_RESTART': '1', 17:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:35 INFO - 'PWD': '/builds/slave/test', 17:39:35 INFO - 'SHELL': '/bin/bash', 17:39:35 INFO - 'SHLVL': '1', 17:39:35 INFO - 'TERM': 'linux', 17:39:35 INFO - 'TMOUT': '86400', 17:39:35 INFO - 'USER': 'cltbld', 17:39:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:35 INFO - '_': '/tools/buildbot/bin/python'} 17:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:35 INFO - Downloading/unpacking flake8 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:39:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:39:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:37 INFO - no previously-included directories found matching 'docs/_build' 17:39:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:39:37 INFO - Running setup.py install for pep8 17:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:38 INFO - no previously-included directories found matching 'docs/_build' 17:39:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:39:38 INFO - Cleaning up... 17:39:38 INFO - Return code: 0 17:39:38 INFO - Running post-action listener: _resource_record_post_action 17:39:38 INFO - Running post-action listener: _start_resource_monitoring 17:39:38 INFO - Starting resource monitoring. 17:39:38 INFO - ##### 17:39:38 INFO - ##### Finished create-virtualenv step (success) 17:39:38 INFO - ##### 17:39:38 INFO - ##### 17:39:38 INFO - ##### Running install step. 17:39:38 INFO - ##### 17:39:38 INFO - Running pre-action listener: _resource_record_pre_action 17:39:38 INFO - Running main action method: install 17:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:38 INFO - Reading from file tmpfile_stdout 17:39:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:38 INFO - Reading from file tmpfile_stdout 17:39:38 INFO - Output received: 17:39:38 INFO - Usage: mozinstall [options] installer 17:39:38 INFO - Options: 17:39:38 INFO - -h, --help show this help message and exit 17:39:38 INFO - -d DEST, --destination=DEST 17:39:38 INFO - Directory to install application into. [default: 17:39:38 INFO - "/builds/slave/test"] 17:39:38 INFO - --app=APP Application being installed. [default: firefox] 17:39:38 INFO - mkdir: /builds/slave/test/build/application 17:39:38 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'] 17:39:38 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 17:39:55 INFO - Reading from file tmpfile_stdout 17:39:55 INFO - Output received: 17:39:55 INFO - /builds/slave/test/build/application/firefox/firefox 17:39:55 INFO - Running post-action listener: _resource_record_post_action 17:39:55 INFO - ##### 17:39:55 INFO - ##### Finished install step (success) 17:39:55 INFO - ##### 17:39:55 INFO - ##### 17:39:55 INFO - ##### Running run-tests step. 17:39:55 INFO - ##### 17:39:55 INFO - Running pre-action listener: _resource_record_pre_action 17:39:55 INFO - Running main action method: run_tests 17:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:55 INFO - Python 2.7.3 17:39:55 INFO - Return code: 0 17:39:55 INFO - grabbing minidump binary from tooltool 17:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:55 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 0x27261c0>, '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 0x27270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2727550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:39:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:39:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:39:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:56 INFO - Return code: 0 17:39:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:39:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:39:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:39:57 INFO - Return code: 0 17:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:39:57 INFO - Using env: {'DISPLAY': ':0', 17:39:57 INFO - 'HOME': '/home/cltbld', 17:39:57 INFO - 'LANG': 'en_US.UTF-8', 17:39:57 INFO - 'LANGUAGE': 'en_US:en', 17:39:57 INFO - 'LOGNAME': 'cltbld', 17:39:57 INFO - 'MAIL': '/var/mail/cltbld', 17:39:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:57 INFO - 'MOZ_NO_REMOTE': '1', 17:39:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:57 INFO - 'NO_EM_RESTART': '1', 17:39:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:57 INFO - 'PWD': '/builds/slave/test', 17:39:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:57 INFO - 'SHELL': '/bin/bash', 17:39:57 INFO - 'SHLVL': '1', 17:39:57 INFO - 'TERM': 'linux', 17:39:57 INFO - 'TMOUT': '86400', 17:39:57 INFO - 'USER': 'cltbld', 17:39:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715', 17:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:57 INFO - '_': '/tools/buildbot/bin/python'} 17:39:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:39:58 INFO - mozversion application_buildid: 20160615143006 17:39:58 INFO - mozversion application_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 17:39:58 INFO - mozversion application_display_name: Nightly 17:39:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:58 INFO - mozversion application_name: Firefox 17:39:58 INFO - mozversion application_remotingname: firefox 17:39:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:39:58 INFO - mozversion application_vendor: Mozilla 17:39:58 INFO - mozversion application_version: 50.0a1 17:39:58 INFO - mozversion platform_buildid: 20160615143006 17:39:58 INFO - mozversion platform_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 17:39:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:39:58 INFO - mozversion platform_version: 50.0a1 17:39:58 INFO - using testdate: 1466037598 17:39:58 INFO - actual date: 1466037598 17:39:58 INFO - starting webserver on 'localhost:40106' 17:39:58 INFO - SUITE-START | Running 2 tests 17:39:58 INFO - TEST-START | dromaeo_css 17:39:58 INFO - operating with platform_type : linux_ 17:39:58 INFO - Initialising browser for dromaeo_css test... 17:39:58 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lLSHT/profile http://localhost:40106/getInfo.html) 17:40:09 INFO - PROCESS | 3326 | __metrics Screen width/height:1600/1200 17:40:09 INFO - PROCESS | 3326 | colorDepth:24 17:40:09 INFO - PROCESS | 3326 | Browser inner width/height: 1024/697 17:40:09 INFO - PROCESS | 3326 | __metrics 17:40:11 ERROR - PROCESS | 3326 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:40:11 INFO - TEST-INFO | 3326: exit 0 17:40:11 INFO - Browser initialized. 17:40:11 INFO - Running cycle 1/1 for dromaeo_css test... 17:40:11 INFO - TEST-INFO | started process 3448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lLSHT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:23 INFO - PROCESS | 3448 | RSS: Main: 185524224 17:40:23 INFO - PROCESS | 3448 | 17:41:13 INFO - PROCESS | 3448 | 1466037673551 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:43:21 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40106/tests/dromaeo/cssquery-ext.html) 17:43:22 INFO - PROCESS | 3448 | RSS: Main: 188657664 17:43:22 INFO - PROCESS | 3448 | 17:46:24 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-ext.html (next: http://localhost:40106/tests/dromaeo/cssquery-jquery.html) 17:46:25 INFO - PROCESS | 3448 | RSS: Main: 187711488 17:46:25 INFO - PROCESS | 3448 | 17:49:27 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40106/tests/dromaeo/cssquery-mootools.html) 17:49:27 INFO - PROCESS | 3448 | RSS: Main: 189411328 17:49:27 INFO - PROCESS | 3448 | 17:52:29 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40106/tests/dromaeo/cssquery-prototype.html) 17:52:30 INFO - PROCESS | 3448 | RSS: Main: 186912768 17:52:30 INFO - PROCESS | 3448 | 17:55:32 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40106/tests/dromaeo/cssquery-yui.html) 17:55:33 INFO - PROCESS | 3448 | RSS: Main: 188993536 17:55:33 INFO - PROCESS | 3448 | 17:58:35 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:40106/tests/dromaeo/cssquery-yui.html (next: http://localhost:40106/tests/dromaeo/cssquery-dojo.html) 17:58:36 INFO - PROCESS | 3448 | RSS: Main: 190087168 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | __start_tp_report 17:58:36 INFO - PROCESS | 3448 | _x_x_mozilla_page_load 17:58:36 INFO - PROCESS | 3448 | _x_x_mozilla_page_load_details 17:58:36 INFO - PROCESS | 3448 | |i|pagename|runs| 17:58:36 INFO - PROCESS | 3448 | |0;dojo.html;3092.288773582076;3110.346827166295;3128.6558478567354;3147.763917706173;3148.574942382779;5361.544268737157;5391.110466772982;5421.91867121993;5461.208124821898;5488.313960754906;5334.5999050071205;5445.074337362648;5453.3728621208575;5463.699496527699;5535.308086489189;4896.2410826321975;4919.704817710949;5018.272350509193;5067.189249720045;5115.7442127893455;706.6350054551413;4992.051510213048;5030.6981581105065;5056.974715126419;5069;4954.355933728611;4973.90052198954;4986.252062190664;4999.32509111269;5045.64680472367;4882.3408839806525;4995.475475075137;5014.348134742497;5032.647714659939;5052.216906379517;4911.336969509106;4911.680740751875;4926.704397736147;4929.334539837112;4941.925871111936;5435.211894275348;5512.200730894038;5514.6139770216105;5524.558035357162;5573.470520300565;5789.8263052108505;5843.912341314884;5910.320313163955;5923.17075609415;5935.970320148414;5884.058550631921;5915.408459154093;5922.289325280994;5922.526197904157;5964.850878728023;5461.617686761928;5493.890122197574;5531.751071201766;5535.972320138373;5542.0301447246575;5868.295804503487;5923.466887980103;5966.582339236299;5970;6019.428154325332;5744.684042377626;5758.165066065397;5777.335606405233;5781.161731548902;5781.219535362757;5852.941470585325;5860.70696465175;5868.706564671835;5869.060950248026;5875.50058245054;5625.971870140623;5771.567132465082;5818.5054270386645;5841.649501029951;5868.765249390062;5708.086706127;5764.567657425626;5796.0436527972415;5805.303363596396;5881.676507792027;4433.645308375322;4465.129299786576;4473.127740090651;4474.038081812361;4516.096780643818;3909.2963266611714;3974.4435778990965;4008.7995600220456;4039.7778122203563;4041.9797901010306;5662.518685911744;5680.857978550486;5686.943130568724;5688.516476099495;5713.971430142906;5724.656520608777;5941.940580594225;6008.098785182257;6008.789692360747;6010.429009244115;5628.296462942132;5644.238027866268;5670;5679.091345384802;5698.11679189718;5136.43499215086;5152.124138896396;5175.042617115846;5181.5595674368105;5219.765110570033;5934.258217722785;6038.547108966845;6145.600535965237;6168;6180.381961803873;5894.852628684232;5941.881162376815;5953.732082056405;5970.283565971938;6016.338202797776;5978.790742324171;5988.820335389945;5989;5997.220361352996;6017.338092809875;5543.334799823886;5662.150677398423;5711.171880077449;5798.594098413239;5806.883862322815;5881.088431293157;5889.057750759858;5891.469767720926;5892.322382926019;5933.169356290036;5654.604177707685;5684.687342196054;5735.71321433935;5738.196652468574;5745.454181852718;5594.4964953152785;5725.51333136688;5730.398308177748;5747.051736463437;5779.739911703899;5481.150421684645;5602.887942241214;5603.859903502445;5685.602007859576;5711.343195532567;5708.400617935057;5727.284089488814;5730.684812335361;5738.139279108167;5826.329972053268;5455.509004189642;5565.499105080562;5595.468430499096;5610.382857885547;5681.034224181816 17:58:36 INFO - PROCESS | 3448 | |1;ext.html;567.6055141676534;615.935326790687;620.8820324138411;623.9064140378946;637.9138816259804;41366.37950430742;43020.139597208035;43151.56848431515;46680;47112.76443617786;43841;44069;44264.77867610657;44459;44570.55429445705;8807.427517211378;8946.329025323126;8971.865422018675;9020.323475739313;9033.23217526511;8956.104389561024;8963.417377870417;9003.324750643695;9034.412763170405;9070.365074444759;9064.229540489066;9078.319126065539;9091.136342047495;9094.090590940887;9113.362064655477;9048.230900373475;9051.7284481466;9064.592093355783;9074.45553266806;9091.090890910922;8928.642854285887;8970;8996.505192214425;8998.325125615605;9031.412958157698;41015.38476922848;41463.7926810364;41479.37780933289;41517.37723934143;41632;3581.1405262737017;3748.8875333739757;3859.4210868369687;4124.979375103106;4172.520160181588;32110.678893211003;32212.838935805405;32590.674093259;32663.836680816683;33563.16092097693;4151.958480415187;4209.389638502431;4246.766427846467;4339.8047087880805;4391.742650234026;338585;341551;342513.9999999975;344541;345260.27369863243;33859;34582;56023;56227.43772562304;56429.71785141048;36118.458223126676;36610.8169459151;36629.63370366262;36646.450303245474;36748;14539.636509087146;14542.709145817025;14610.634734131732;14688.926555367154;14717.484888028868;12067.517299308105;12149.757004859854;12178.451969661386;12186.2078964867;12205.755884882252;8219.342452603778;8250;8372.41393102477;8382.203690649378;8439.535825529654;3241.3517296540786;3252.186858367495;3268.248302890301;3299.4226010448074;3311.7516186286125;1004.9598016079275;1039.210200247802;1104.4201794058183;1109.7503061811028;1148.1159507179425;31436.685633143832;31466;31605.20986975344;31735;31902.680973190436;1082.3992684060422;1104.282216559243;1126.594426006637;1132.1395739238073;1171.7363593191465;16033.198340082949;16422;16433.83566164347;16462.341506339853;16828.326866925432;565367;929687;956583;957568;957764;56793.14810277849;57396;57479;57578.4242157573;57645.135322970185;1351.2433037499031;1371.9588412347646;1393.428694235379;1403.7894315852704;1404.810350602676;30164.229471316085;32126.678733212368;32264.193395165308;32369.49272508826;32456.35087298288;50166.74916625393;50717.23924141067;50794.49205508045;50808.49191508185;50827.49172508375;482535;486073;486537;490842;491168;28027.299317517227;28147.296317592223;28448.57327140053;28691.71308286974;28708;46650.300245495666;46759;47574.52425475701;47650.52349476461;47965.5203447961;38842.805785970886;39918.2016359677;40154.1969160621;40459.1908161841;40697.98255043648;38484.42273365846;39857.40213896736;39974;40063;40532;38873.02817429474;39344.40983385309;40108.1978360437;40231.396529051504;40252.39621405623;33092.503612445355;35244.823775880956;35595.822020890766;41831.16337673169;43276.78361608172;31418.21454463657;34349.31301374009;34356;34598.30803383868;34858.825705871306 17:58:36 INFO - PROCESS | 3448 | |2;jquery.html;394.1565050791306;396.7104014069727;399.94000899865034;404.1553153908332;419.1470357821833;13624.318784060782;17919.82080179198;18941.242350306005;19522.609547809054;19546.218151273948;16802.747958780597;16810.411635592758;17186.828131718677;19071.332503362384;19099.33152339665;5374.086405311096;5500.862478438051;5510.476504732064;5529.723513824313;5886.058230683092;5693.914591281114;5751.856203594902;5803.709814509279;5836.533077353823;5846.444587764156;5660.773569057233;5747.655140691572;5805;5816.505597024258;5835.649861008353;5713.5714821388565;5776.018076926933;5780.826575202751;5800.47795698387;5820.679862607555;5120.564751996085;5159.871003224912;5210.739463026872;5238.869028274324;5242.79028838846;20551.79448205514;21732;21835.563288734138;22666.77333226663;23248.883755581282;2311.295055008222;2331.49872777352;2369.2536850891915;2543.847369157838;2777.4861650594703;10187.54156062979;10245.538950747234;10456.058954694037;10593.629222977159;10814.297070690458;1857.3406440713622;1911.1781933768475;1912.3211260002638;1965.9606807863906;1982.3656429942423;79003;81700;82493.76259356174;84367;84425;9400.858987115198;9538.570764315622;10769.515371808287;10870.891291087146;11235.606753763579;15323;15546.844531554765;15553.533393998197;15600.84399155994;15606.609834754221;7546.2831031051965;8127.390445716476;8154.429189956646;8283.461574997606;8332.16678332162;7777.883331750028;7794.961025194951;8001.239882211181;8049.879251811228;8099.230573095547;4588.311753237042;4691.601213896857;4744.288356746516;4772.7136371817805;4857.571214392804;1967.5277933295906;2024.2813801100692;2025.8885761282977;2044.8364130869495;2050.7744148143693;926.7173512078881;940.47333493244;977.1889331854544;1023.9504507879483;1025.733309339562;19039.238430462625;19288;19332.516687082654;19436;19490.707639385422;940.7648087978006;971.6696323249987;978.105033893979;1008.8839783424853;1033.4006276359694;10198.592056317813;10916.235863489479;10930.453477326102;11039.337639741641;11060.115190784718;421165;424113.55318680976;468668;470828;471037;72966;78893;84485.57757211174;97674.51162744283;100688.49655751821;1001.1090129784498;1035.9067683908484;1059.7615536504225;1068.4871261794383;1068.7541865370852;17612.82387176163;17633.559161021076;18061.458156255332;18079.728804068214;18110.81889181091;42149.1570168601;42158.36762448627;42858.78570607127;44283;44357.778211108736;61144.69427652833;61668.38331616806;61851.38148618456;61865;63549.68225158845;8915.554222288989;8940.73177804667;8985.371024028254;9005.189532942066;9213.262938964732;10272.743181420525;12798.61604151877;13311.80032299497;13925.164490130624;13972.650683732989;10898.50956706966;11378.829317560409;11586.36275004849;11916.52333906634;12160.878391216329;10697.251192416767;11123.72190695239;11595.710107247387;11682.24065435744;12325.75348493043;11944.64166075019;11962.342071186169;11985.400729963292;12184.268943863397;12377.009839212662;8996.955015224881;9197.172254497127;9327.207187389147;9331.766705832408;9363.953180234328;11229.66311010671;11886.108541859569;11899.643010709693;12003.63989080329;12156.756864862477 17:58:36 INFO - PROCESS | 3448 | |3;mootools.html;1435.504750860953;1474.5797447727396;1572.4182052640517;1702.6594681063775;1713.811480737118;6923;7601.695932162714;7992.120866704672;8117.756467305975;8124.837503249939;8250.83498330033;8279.503229806201;8307.83384332313;8309.459885107464;8313.41806073575;2209.491816882118;2221.8777967211795;2234.273860995175;2234.553089382122;2234.7876951689564;2194.967075493869;2228.1310288987306;2239.944001399962;2250.1449449209276;2251.7297924249115;2212.8782916939563;2218.589560931233;2223.6886835842915;2227.9554408911813;2256.6953461282683;2175.184305885293;2179.814715749163;2201.350601572532;2204.47092697753;2215.2357436684397;2156.54712510373;2167.9891600541896;2168.4362065862833;2170.1319472211085;2174.597699425611;8388;8449.281811046068;8481.363897707697;8501.14988501145;8551.273141782956;4989.426215985171;5110.156824124015;5121.308623335839;5137.434882162959;5145.125328694131;3021.818690878554;3129.9217519561967;3172.0642410488963;3210.6949839765184;3214.8874789382257;1025.3489034463096;1058.3596923861107;1090.2041509697885;1098.2696506822954;1104.9944750276277;11521.769564608661;11673;11688.181827272094;11696.883031169664;11733.53065877364;4386.539413361615;4544.772761361919;4548.11311794197;4550.6587005974025;4552.726836389827;9822.557984890696;9899.60401583943;9913.553890074963;9930.553125109387;9951.054649808257;4992.375953005874;4992.700437973734;5003.74981250936;5058.671186372948;5089.262057001788;4163.770992595376;4660.044690838437;4673.626109911199;4682.906341873144;4718.363020992122;3713.8700145494777;3780.1494663700446;3833.0800607853917;3839.6544311012144;3888.4361767543546;1177.9764404711857;1203.7773011992808;1217.945192466341;1218.5065048655308;1224.6693392784077;925.6575067225169;944.7260294514651;964.6479035152119;967.583938906277;984.6061575369766;5625.943740562624;5725.3988331225455;5875.236219291465;5881.264841894763;6008.7706273078065;422.09039519834806;433.9262325404689;440.65848967050795;440.7663938112805;440.79503031090695;3994.3609022556834;4048.0689441428635;4091.7135800494275;4133.731307465006;4144.896377590584;9781.315307928518;10263.435511046964;10265.435401052864;10272.640457583948;10315.896841031643;10094.293399462114;10095.141912937335;10172.593096276067;10181.847272290921;10194.337368071052;7750.961245193738;7828.099768526578;7850.607469626496;7881.5665138417935;7898.249666281694;5645.858853528694;5647.0964645656495;5686.715664216856;5755.71221438918;5798.188253644409;9469.857952130586;9502.572384242587;9570.808583828424;9600;9607.663731769355;9335.113164249386;9470.857937131086;9717.319787614799;9742.95128524353;9792.265580081379;6617.172853393326;7223.2776722329445;7490.550566966;7493.925060749323;7520.924790752022;8172.387070969582;8241.752747417588;8278.958605206935;8294.958525207336;8325.708600198965;7246.96376518114;7352.558846469229;7413.592252426169;7433.628318584158;7570.05374328209;7261.564306141649;7263.0921134858145;7311.561306321638;7336.486445948733;7367.742129025459;6759.864802704017;6795.932040679728;6830.112085428863;6844.897326540006;6891.517593768388;4814.422269327703;4991.276264941635;4993.975030124826;5070.569001634903;5188.247704082812;4912.828051018198;4995.775190116381;5013.39839219296;5021.698698078127;5060.696358218519 17:58:36 INFO - PROCESS | 3448 | |4;prototype.html;326.96566860479646;326.9754768392371;331.33071196183704;331.3505529162841;332.4497955883013;5614.494695477406;5624.9718751406235;5646.774129034844;5648.4633959773755;5701.600887937846;5579.13523403873;5602.439756024395;5624.887502249952;5642.351129620095;5646.830595082144;4204.297259609855;4301.870943871689;4404.7357158570585;4426.889327766816;4435.955640443586;4294.162638285536;4330.935035974463;4349;4353.955050787804;4363.0619416825375;4319.287317592593;4350.260455722519;4355.71687840291;4359.128174365123;4384.97807510962;4232.841250962001;4341.826326946918;4343.500497442803;4364.54172311909;4391.516933137353;3817.751846129993;3830.559485659157;3863.497745293122;3883.456316115746;3883.475730776337;5415.727304083537;5447.155690867922;5514;5522.723863806794;5528.419515950807;4782.473927867932;4979.3526841510375;5011.123053465665;5016.874578135539;5076.796928122871;5862.706864656793;5881.500217444567;5927.851803704899;5928.9624315745;5929.64422134669;4280.336547835091;4298;4302.709187243814;4315.331123675835;4316.395704601358;5972.64164150148;5982.700864956735;6027.186329845458;6043.730816528534;6075.359652893694;4261.637760790368;4314.482262128502;4321.58944900234;4378.387025816388;4391.560843915583;4434.627474301234;4437.556244375537;4448.243798554254;4449.243628583149;4458.996725736748;4943.8516844494725;4991.226359914219;5003.974980125149;5010.498950105033;5027.824026159067;5886.293644762656;5941.940580594225;5947.1376650385455;5956.315023772235;5991.453632206295;1513.3341329814846;1521.5511424129909;1541.961450963735;1544.8995815272197;1550.2558771789604;977.1742877268697;981.9410835349759;991.7718924647371;1042.9791404172026;1048;5617.9438205618235;5634.295713035871;5700.800471983461;5732.742026608813;5750.453706897838;6011.248593925759;6069.36271691466;6117.908231376533;6124.295705993779;6126.499007743042;5474.39781624021;5606.495415412551;5615.634983726045;5640.138754211101;5677.205191273225;3202.814958465383;3212.4860022396306;3214.437473442138;3214.5660335854827;3214.8071115733133;5874.765009399576;6087.1173679816175;6142.57002009855;6169.2288463942;6212.099245609361;6149.754009839557;6159.753609855556;6169.907451388232;6172.382761723792;6181.536384771161;5939.109133630076;6082.908756368658;6130.111133885562;6170.994426811304;6182.319944806068;5924.30444147903;5980.996366217366;5981.863445945257;6034;6042.788502402394;5932.79235226765;5934.465898069195;5950.285965683973;5955.255593050869;5986.610870293417;5927.644341339534;6158.353372895782;6164.969175154096;6171.7531298749345;6193.473554747897;4373.081652852809;4401.823927042882;4403.4495688039;4405.2511073117;4408.096340250177;5812.796552120655;6043.54673399488;6059.182010428536;6070.575059745775;6083.756649734138;5804.593678442468;5823.708814559171;5837.5038121758425;5850.561207909509;5852.122181672783;5747.597668163188;5770.826875193751;5803.071508558611;5811.27359080115;5830.912536312044;5193.948060519347;5666.2350582670815;5727.596738799021;5741.885162296814;5747.281589801275;5866.67733274674;5911.758530708427;5928.110783382354;5928.970355148197;5947.464728174485;5553.500184983371;5755.971220143872;5761.798337058183;5768.567357448124;5817.156512305607 17:58:36 INFO - PROCESS | 3448 | |5;yui.html;730.7807657702688;732.6959311885568;740.6259838781415;788.9487183333084;802.4382931947634;15562.844371556295;16330.673386532262;16350.10074445905;16361;16376.672466550663;12213.450394732236;14785.408583656668;14949.551513454586;14952.327145278461;14971.176585287805;788.964496597653;807.8828569857367;813.0203105258179;813.5484805932705;813.9145389734082;796.1282395776616;798.3014861995754;799.9560024198666;800.651716503323;800.6997375984006;827.9213474719892;835.448603921412;837.3008537870885;837.6188834080479;837.7444879311807;824.2705205892828;824.389951435936;826.9503829770202;829.3116713128089;832.3299743706314;593.4303069053714;603.1194456094108;603.6076550242334;604.7701873288166;605.279717136606;14528.782068268985;14577.70844583113;14585.854141458556;14623.561293161221;14661.706765864623;14239.644008899757;14298.28508574567;14519.70960580793;14743.77884331736;14886.776698349533;11890.464929078213;12006.879931200663;12117.69705757363;12339.691507712289;12747.553835615801;3900.6294402031763;3911.198204368098;3919.9216015679526;3952.505936757905;4047.797610119482;76008;77102;77219;77514;77864;11470.197086204053;11610.88389116115;11691;11708.88291117078;11856.170068095324;20778.792212077988;20844.1662333508;20850.06174722141;21019.369418917457;21055.578888422147;8183.71357002502;8524.914750852537;8535.530545819915;8818.691345802994;8991.370604057653;4645.117427688729;4844.15227335222;4853.95146048542;4922.360093187863;4954.529319714621;3660.9816950915606;3675.632436756303;3731.794751288651;3739.0652336915773;3780.8487660493824;624.9843753906098;628.8836565235355;642.3351830855042;657.7138944559132;664.557750267764;582.2779753106117;600.1849004553321;617.1298469158465;663.3333499832734;677.6408503493157;9290.024547422423;9439.339246252697;9455.243580513543;9458.763530911783;9596.520173991412;636.8503401700597;649.9545031847725;676.1683129750336;689.9103116594911;702.950793444454;4510.729356238636;4643.674942754043;4664.230401983635;4692.1084993851055;4696.084263568571;114618.4269078666;116313;116732;117076.41461792636;117411;59477.10784338152;102428;103592;104692.95307046984;105406.47296763468;56817.71591142018;57110;61376.69311653413;82741.10406135877;89661.55169224112;8719.171678690514;8730.519821409629;8837.734867953715;8874.866876996979;9071;48013;52475.73762131165;52846.20730688966;53703.19445208403;54842;44332.11335773331;45357.77321113373;45597;62046.689766552685;63875.36124638694;11621.360825154698;11703.23928944616;12024;12217.389130543615;12411.875881241072;12669.176503527242;12856.614301570968;13104.73790524165;13703.931480342535;13713.862861371657;12532.561360352343;12557.246565206116;12875.549355772502;13563.796543051665;13731;13166.275854828076;13487.460501579826;13493.797593035915;13493.932530337286;13838.65403364924;13060.346982651019;13072.411741471466;13362.398692059076;13407.798883016958;13484.595462136152;10379.584816607252;10413.479326033517;10497.688874721107;10561.894381056398;10818.350898946088;11239.55041798319;11365.943170284096;11649.184557080924;11653.825192622287;11781.705457363634 17:58:36 INFO - PROCESS | 3448 | __end_tp_report 17:58:36 INFO - PROCESS | 3448 | __start_cc_report 17:58:36 INFO - PROCESS | 3448 | _x_x_mozilla_cycle_collect,360 17:58:36 INFO - PROCESS | 3448 | __end_cc_report 17:58:36 INFO - PROCESS | 3448 | __startTimestamp1466038716136__endTimestamp 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | ------- Summary: start ------- 17:58:36 INFO - PROCESS | 3448 | Number of tests: 6 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#0] dojo.html Cycles:165 Average:5424.74 Median:5681.03 stddev:723.47 (12.7%) stddev-sans-first:702.17 17:58:36 INFO - PROCESS | 3448 | Values: 3092.3 3110.3 3128.7 3147.8 3148.6 5361.5 5391.1 5421.9 5461.2 5488.3 5334.6 5445.1 5453.4 5463.7 5535.3 4896.2 4919.7 5018.3 5067.2 5115.7 706.6 4992.1 5030.7 5057.0 5069.0 4954.4 4973.9 4986.3 4999.3 5045.6 4882.3 4995.5 5014.3 5032.6 5052.2 4911.3 4911.7 4926.7 4929.3 4941.9 5435.2 5512.2 5514.6 5524.6 5573.5 5789.8 5843.9 5910.3 5923.2 5936.0 5884.1 5915.4 5922.3 5922.5 5964.9 5461.6 5493.9 5531.8 5536.0 5542.0 5868.3 5923.5 5966.6 5970.0 6019.4 5744.7 5758.2 5777.3 5781.2 5781.2 5852.9 5860.7 5868.7 5869.1 5875.5 5626.0 5771.6 5818.5 5841.6 5868.8 5708.1 5764.6 5796.0 5805.3 5881.7 4433.6 4465.1 4473.1 4474.0 4516.1 3909.3 3974.4 4008.8 4039.8 4042.0 5662.5 5680.9 5686.9 5688.5 5714.0 5724.7 5941.9 6008.1 6008.8 6010.4 5628.3 5644.2 5670.0 5679.1 5698.1 5136.4 5152.1 5175.0 5181.6 5219.8 5934.3 6038.5 6145.6 6168.0 6180.4 5894.9 5941.9 5953.7 5970.3 6016.3 5978.8 5988.8 5989.0 5997.2 6017.3 5543.3 5662.2 5711.2 5798.6 5806.9 5881.1 5889.1 5891.5 5892.3 5933.2 5654.6 5684.7 5735.7 5738.2 5745.5 5594.5 5725.5 5730.4 5747.1 5779.7 5481.2 5602.9 5603.9 5685.6 5711.3 5708.4 5727.3 5730.7 5738.1 5826.3 5455.5 5565.5 5595.5 5610.4 5681.0 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#1] ext.html Cycles:180 Average:69463.62 Median:40495.60 stddev:166938.91 (412.2%) stddev-sans-first:167327.08 17:58:36 INFO - PROCESS | 3448 | Values: 567.6 615.9 620.9 623.9 637.9 41366.4 43020.1 43151.6 46680.0 47112.8 43841.0 44069.0 44264.8 44459.0 44570.6 8807.4 8946.3 8971.9 9020.3 9033.2 8956.1 8963.4 9003.3 9034.4 9070.4 9064.2 9078.3 9091.1 9094.1 9113.4 9048.2 9051.7 9064.6 9074.5 9091.1 8928.6 8970.0 8996.5 8998.3 9031.4 41015.4 41463.8 41479.4 41517.4 41632.0 3581.1 3748.9 3859.4 4125.0 4172.5 32110.7 32212.8 32590.7 32663.8 33563.2 4152.0 4209.4 4246.8 4339.8 4391.7 338585.0 341551.0 342514.0 344541.0 345260.3 33859.0 34582.0 56023.0 56227.4 56429.7 36118.5 36610.8 36629.6 36646.5 36748.0 14539.6 14542.7 14610.6 14688.9 14717.5 12067.5 12149.8 12178.5 12186.2 12205.8 8219.3 8250.0 8372.4 8382.2 8439.5 3241.4 3252.2 3268.2 3299.4 3311.8 1005.0 1039.2 1104.4 1109.8 1148.1 31436.7 31466.0 31605.2 31735.0 31902.7 1082.4 1104.3 1126.6 1132.1 1171.7 16033.2 16422.0 16433.8 16462.3 16828.3 565367.0 929687.0 956583.0 957568.0 957764.0 56793.1 57396.0 57479.0 57578.4 57645.1 1351.2 1372.0 1393.4 1403.8 1404.8 30164.2 32126.7 32264.2 32369.5 32456.4 50166.7 50717.2 50794.5 50808.5 50827.5 482535.0 486073.0 486537.0 490842.0 491168.0 28027.3 28147.3 28448.6 28691.7 28708.0 46650.3 46759.0 47574.5 47650.5 47965.5 38842.8 39918.2 40154.2 40459.2 40698.0 38484.4 39857.4 39974.0 40063.0 40532.0 38873.0 39344.4 40108.2 40231.4 40252.4 33092.5 35244.8 35595.8 41831.2 43276.8 31418.2 34349.3 34356.0 34598.3 34858.8 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#2] jquery.html Cycles:180 Average:27905.09 Median:2456.55 stddev:74714.81 (3041.5%) stddev-sans-first:74895.85 17:58:36 INFO - PROCESS | 3448 | Values: 394.2 396.7 399.9 404.2 419.1 13624.3 17919.8 18941.2 19522.6 19546.2 16802.7 16810.4 17186.8 19071.3 19099.3 5374.1 5500.9 5510.5 5529.7 5886.1 5693.9 5751.9 5803.7 5836.5 5846.4 5660.8 5747.7 5805.0 5816.5 5835.6 5713.6 5776.0 5780.8 5800.5 5820.7 5120.6 5159.9 5210.7 5238.9 5242.8 20551.8 21732.0 21835.6 22666.8 23248.9 2311.3 2331.5 2369.3 2543.8 2777.5 10187.5 10245.5 10456.1 10593.6 10814.3 1857.3 1911.2 1912.3 1966.0 1982.4 79003.0 81700.0 82493.8 84367.0 84425.0 9400.9 9538.6 10769.5 10870.9 11235.6 15323.0 15546.8 15553.5 15600.8 15606.6 7546.3 8127.4 8154.4 8283.5 8332.2 7777.9 7795.0 8001.2 8049.9 8099.2 4588.3 4691.6 4744.3 4772.7 4857.6 1967.5 2024.3 2025.9 2044.8 2050.8 926.7 940.5 977.2 1024.0 1025.7 19039.2 19288.0 19332.5 19436.0 19490.7 940.8 971.7 978.1 1008.9 1033.4 10198.6 10916.2 10930.5 11039.3 11060.1 421165.0 424113.6 468668.0 470828.0 471037.0 72966.0 78893.0 84485.6 97674.5 100688.5 1001.1 1035.9 1059.8 1068.5 1068.8 17612.8 17633.6 18061.5 18079.7 18110.8 42149.2 42158.4 42858.8 44283.0 44357.8 61144.7 61668.4 61851.4 61865.0 63549.7 8915.6 8940.7 8985.4 9005.2 9213.3 10272.7 12798.6 13311.8 13925.2 13972.7 10898.5 11378.8 11586.4 11916.5 12160.9 10697.3 11123.7 11595.7 11682.2 12325.8 11944.6 11962.3 11985.4 12184.3 12377.0 8997.0 9197.2 9327.2 9331.8 9364.0 11229.7 11886.1 11899.6 12003.6 12156.8 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#3] mootools.html Cycles:180 Average:5516.71 Median:4994.88 stddev:3119.18 (62.4%) stddev-sans-first:3112.85 17:58:36 INFO - PROCESS | 3448 | Values: 1435.5 1474.6 1572.4 1702.7 1713.8 6923.0 7601.7 7992.1 8117.8 8124.8 8250.8 8279.5 8307.8 8309.5 8313.4 2209.5 2221.9 2234.3 2234.6 2234.8 2195.0 2228.1 2239.9 2250.1 2251.7 2212.9 2218.6 2223.7 2228.0 2256.7 2175.2 2179.8 2201.4 2204.5 2215.2 2156.5 2168.0 2168.4 2170.1 2174.6 8388.0 8449.3 8481.4 8501.1 8551.3 4989.4 5110.2 5121.3 5137.4 5145.1 3021.8 3129.9 3172.1 3210.7 3214.9 1025.3 1058.4 1090.2 1098.3 1105.0 11521.8 11673.0 11688.2 11696.9 11733.5 4386.5 4544.8 4548.1 4550.7 4552.7 9822.6 9899.6 9913.6 9930.6 9951.1 4992.4 4992.7 5003.7 5058.7 5089.3 4163.8 4660.0 4673.6 4682.9 4718.4 3713.9 3780.1 3833.1 3839.7 3888.4 1178.0 1203.8 1217.9 1218.5 1224.7 925.7 944.7 964.6 967.6 984.6 5625.9 5725.4 5875.2 5881.3 6008.8 422.1 433.9 440.7 440.8 440.8 3994.4 4048.1 4091.7 4133.7 4144.9 9781.3 10263.4 10265.4 10272.6 10315.9 10094.3 10095.1 10172.6 10181.8 10194.3 7751.0 7828.1 7850.6 7881.6 7898.2 5645.9 5647.1 5686.7 5755.7 5798.2 9469.9 9502.6 9570.8 9600.0 9607.7 9335.1 9470.9 9717.3 9743.0 9792.3 6617.2 7223.3 7490.6 7493.9 7520.9 8172.4 8241.8 8279.0 8295.0 8325.7 7247.0 7352.6 7413.6 7433.6 7570.1 7261.6 7263.1 7311.6 7336.5 7367.7 6759.9 6795.9 6830.1 6844.9 6891.5 4814.4 4991.3 4994.0 5070.6 5188.2 4912.8 4995.8 5013.4 5021.7 5060.7 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#4] prototype.html Cycles:180 Average:4947.51 Median:5644.56 stddev:1442.30 (25.6%) stddev-sans-first:1404.03 17:58:36 INFO - PROCESS | 3448 | Values: 327.0 327.0 331.3 331.4 332.4 5614.5 5625.0 5646.8 5648.5 5701.6 5579.1 5602.4 5624.9 5642.4 5646.8 4204.3 4301.9 4404.7 4426.9 4436.0 4294.2 4330.9 4349.0 4354.0 4363.1 4319.3 4350.3 4355.7 4359.1 4385.0 4232.8 4341.8 4343.5 4364.5 4391.5 3817.8 3830.6 3863.5 3883.5 3883.5 5415.7 5447.2 5514.0 5522.7 5528.4 4782.5 4979.4 5011.1 5016.9 5076.8 5862.7 5881.5 5927.9 5929.0 5929.6 4280.3 4298.0 4302.7 4315.3 4316.4 5972.6 5982.7 6027.2 6043.7 6075.4 4261.6 4314.5 4321.6 4378.4 4391.6 4434.6 4437.6 4448.2 4449.2 4459.0 4943.9 4991.2 5004.0 5010.5 5027.8 5886.3 5941.9 5947.1 5956.3 5991.5 1513.3 1521.6 1542.0 1544.9 1550.3 977.2 981.9 991.8 1043.0 1048.0 5617.9 5634.3 5700.8 5732.7 5750.5 6011.2 6069.4 6117.9 6124.3 6126.5 5474.4 5606.5 5615.6 5640.1 5677.2 3202.8 3212.5 3214.4 3214.6 3214.8 5874.8 6087.1 6142.6 6169.2 6212.1 6149.8 6159.8 6169.9 6172.4 6181.5 5939.1 6082.9 6130.1 6171.0 6182.3 5924.3 5981.0 5981.9 6034.0 6042.8 5932.8 5934.5 5950.3 5955.3 5986.6 5927.6 6158.4 6165.0 6171.8 6193.5 4373.1 4401.8 4403.4 4405.3 4408.1 5812.8 6043.5 6059.2 6070.6 6083.8 5804.6 5823.7 5837.5 5850.6 5852.1 5747.6 5770.8 5803.1 5811.3 5830.9 5193.9 5666.2 5727.6 5741.9 5747.3 5866.7 5911.8 5928.1 5929.0 5947.5 5553.5 5756.0 5761.8 5768.6 5817.2 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - PROCESS | 3448 | [#5] yui.html Cycles:180 Average:19585.63 Median:24934.25 stddev:28303.43 (113.5%) stddev-sans-first:28347.42 17:58:36 INFO - PROCESS | 3448 | Values: 730.8 732.7 740.6 788.9 802.4 15562.8 16330.7 16350.1 16361.0 16376.7 12213.5 14785.4 14949.6 14952.3 14971.2 789.0 807.9 813.0 813.5 813.9 796.1 798.3 800.0 800.7 800.7 827.9 835.4 837.3 837.6 837.7 824.3 824.4 827.0 829.3 832.3 593.4 603.1 603.6 604.8 605.3 14528.8 14577.7 14585.9 14623.6 14661.7 14239.6 14298.3 14519.7 14743.8 14886.8 11890.5 12006.9 12117.7 12339.7 12747.6 3900.6 3911.2 3919.9 3952.5 4047.8 76008.0 77102.0 77219.0 77514.0 77864.0 11470.2 11610.9 11691.0 11708.9 11856.2 20778.8 20844.2 20850.1 21019.4 21055.6 8183.7 8524.9 8535.5 8818.7 8991.4 4645.1 4844.2 4854.0 4922.4 4954.5 3661.0 3675.6 3731.8 3739.1 3780.8 625.0 628.9 642.3 657.7 664.6 582.3 600.2 617.1 663.3 677.6 9290.0 9439.3 9455.2 9458.8 9596.5 636.9 650.0 676.2 689.9 703.0 4510.7 4643.7 4664.2 4692.1 4696.1 114618.4 116313.0 116732.0 117076.4 117411.0 59477.1 102428.0 103592.0 104693.0 105406.5 56817.7 57110.0 61376.7 82741.1 89661.6 8719.2 8730.5 8837.7 8874.9 9071.0 48013.0 52475.7 52846.2 53703.2 54842.0 44332.1 45357.8 45597.0 62046.7 63875.4 11621.4 11703.2 12024.0 12217.4 12411.9 12669.2 12856.6 13104.7 13703.9 13713.9 12532.6 12557.2 12875.5 13563.8 13731.0 13166.3 13487.5 13493.8 13493.9 13838.7 13060.3 13072.4 13362.4 13407.8 13484.6 10379.6 10413.5 10497.7 10561.9 10818.4 11239.6 11365.9 11649.2 11653.8 11781.7 17:58:36 INFO - PROCESS | 3448 | -------- Summary: end -------- 17:58:36 INFO - PROCESS | 3448 | 17:58:36 INFO - TEST-INFO | 3448: exit 0 17:58:36 INFO - TEST-OK | dromaeo_css | took 1118834ms 17:58:36 INFO - TEST-START | kraken 17:58:36 INFO - operating with platform_type : linux_ 17:58:36 INFO - Initialising browser for kraken test... 17:58:36 INFO - TEST-INFO | started process 3686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDC3Lh/profile http://localhost:40106/getInfo.html) 17:58:42 INFO - PROCESS | 3686 | __metrics Screen width/height:1600/1200 17:58:42 INFO - PROCESS | 3686 | colorDepth:24 17:58:42 INFO - PROCESS | 3686 | Browser inner width/height: 1024/697 17:58:42 INFO - PROCESS | 3686 | __metrics 17:58:44 ERROR - PROCESS | 3686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:58:45 INFO - TEST-INFO | 3686: exit 0 17:58:45 INFO - Browser initialized. 17:58:45 INFO - Running cycle 1/1 for kraken test... 17:58:45 INFO - TEST-INFO | started process 3807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDC3Lh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:57 INFO - PROCESS | 3807 | RSS: Main: 184942592 17:58:57 INFO - PROCESS | 3807 | 17:58:59 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40106/tests/kraken/driver.html?testName=audio-beat-detection) 17:59:00 INFO - PROCESS | 3807 | RSS: Main: 190300160 17:59:00 INFO - PROCESS | 3807 | 17:59:03 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40106/tests/kraken/driver.html?testName=audio-dft) 17:59:03 INFO - PROCESS | 3807 | RSS: Main: 189210624 17:59:03 INFO - PROCESS | 3807 | 17:59:06 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40106/tests/kraken/driver.html?testName=audio-fft) 17:59:07 INFO - PROCESS | 3807 | RSS: Main: 184958976 17:59:07 INFO - PROCESS | 3807 | 17:59:09 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40106/tests/kraken/driver.html?testName=audio-oscillator) 17:59:10 INFO - PROCESS | 3807 | RSS: Main: 185892864 17:59:10 INFO - PROCESS | 3807 | 17:59:12 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:59:12 INFO - PROCESS | 3807 | RSS: Main: 186294272 17:59:12 INFO - PROCESS | 3807 | 17:59:16 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40106/tests/kraken/driver.html?testName=imaging-darkroom) 17:59:16 INFO - PROCESS | 3807 | RSS: Main: 186658816 17:59:16 INFO - PROCESS | 3807 | 17:59:20 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40106/tests/kraken/driver.html?testName=imaging-desaturate) 17:59:20 INFO - PROCESS | 3807 | RSS: Main: 183357440 17:59:20 INFO - PROCESS | 3807 | 17:59:23 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40106/tests/kraken/driver.html?testName=json-parse-financial) 17:59:24 INFO - PROCESS | 3807 | RSS: Main: 184942592 17:59:24 INFO - PROCESS | 3807 | 17:59:25 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:59:26 INFO - PROCESS | 3807 | RSS: Main: 185974784 17:59:27 INFO - PROCESS | 3807 | 17:59:28 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:28 INFO - PROCESS | 3807 | RSS: Main: 186232832 17:59:28 INFO - PROCESS | 3807 | 17:59:30 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:31 INFO - PROCESS | 3807 | RSS: Main: 186613760 17:59:31 INFO - PROCESS | 3807 | 17:59:35 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:36 INFO - PROCESS | 3807 | RSS: Main: 185171968 17:59:36 INFO - PROCESS | 3807 | 17:59:39 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:39 INFO - PROCESS | 3807 | RSS: Main: 186130432 17:59:39 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:40106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40106/tests/kraken/driver.html?testName=ai-astar) 17:59:41 INFO - PROCESS | 3807 | RSS: Main: 186961920 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | __start_tp_report 17:59:41 INFO - PROCESS | 3807 | _x_x_mozilla_page_load 17:59:41 INFO - PROCESS | 3807 | _x_x_mozilla_page_load_details 17:59:41 INFO - PROCESS | 3807 | |i|pagename|runs| 17:59:41 INFO - PROCESS | 3807 | |0;ai-astar;111;106;111;112;111;111;112;111;113;111 17:59:41 INFO - PROCESS | 3807 | |1;audio-beat-detection;153;127;156;178;134;151;159;130;187;133 17:59:41 INFO - PROCESS | 3807 | |2;audio-dft;161;161;163;163;174;162;162;163;170;161 17:59:41 INFO - PROCESS | 3807 | |3;audio-fft;74;84;75;157;74;75;74;75;169;75 17:59:41 INFO - PROCESS | 3807 | |4;audio-oscillator;86;85;155;85;85;84;156;85;85;145 17:59:41 INFO - PROCESS | 3807 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;117;118 17:59:41 INFO - PROCESS | 3807 | |6;imaging-darkroom;146;146;147;148;146;147;148;147;148;147 17:59:41 INFO - PROCESS | 3807 | |7;imaging-desaturate;97;97;97;95;96;96;95;96;95;96 17:59:41 INFO - PROCESS | 3807 | |8;json-parse-financial;55;54;59;54;56;58;55;55;56;56 17:59:41 INFO - PROCESS | 3807 | |9;json-stringify-tinderbox;61;62;62;61;62;62;61;61;62;62 17:59:41 INFO - PROCESS | 3807 | |10;stanford-crypto-aes;81;80;79;80;81;80;81;82;110;86 17:59:41 INFO - PROCESS | 3807 | |11;stanford-crypto-ccm;130;131;122;129;127;123;132;138;128;122 17:59:41 INFO - PROCESS | 3807 | |12;stanford-crypto-pbkdf2;164;163;164;162;163;159;161;162;163;161 17:59:41 INFO - PROCESS | 3807 | |13;stanford-crypto-sha256-iterative;62;65;67;69;63;62;63;63;64;63 17:59:41 INFO - PROCESS | 3807 | __end_tp_report 17:59:41 INFO - PROCESS | 3807 | __start_cc_report 17:59:41 INFO - PROCESS | 3807 | _x_x_mozilla_cycle_collect,890 17:59:41 INFO - PROCESS | 3807 | __end_cc_report 17:59:41 INFO - PROCESS | 3807 | __startTimestamp1466038781594__endTimestamp 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | ------- Summary: start ------- 17:59:41 INFO - PROCESS | 3807 | Number of tests: 14 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.85 (1.7%) stddev-sans-first:1.96 17:59:41 INFO - PROCESS | 3807 | Values: 111.0 106.0 111.0 112.0 111.0 111.0 112.0 111.0 113.0 111.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.50 stddev:20.41 (13.2%) stddev-sans-first:21.63 17:59:41 INFO - PROCESS | 3807 | Values: 153.0 127.0 156.0 178.0 134.0 151.0 159.0 130.0 187.0 133.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.40 (2.7%) stddev-sans-first:4.53 17:59:41 INFO - PROCESS | 3807 | Values: 161.0 161.0 163.0 163.0 174.0 162.0 162.0 163.0 170.0 161.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.02 (49.4%) stddev-sans-first:38.60 17:59:41 INFO - PROCESS | 3807 | Values: 74.0 84.0 75.0 157.0 74.0 75.0 74.0 75.0 169.0 75.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:85.00 stddev:32.49 (38.2%) stddev-sans-first:33.72 17:59:41 INFO - PROCESS | 3807 | Values: 86.0 85.0 155.0 85.0 85.0 84.0 156.0 85.0 85.0 145.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:59:41 INFO - PROCESS | 3807 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 17:59:41 INFO - PROCESS | 3807 | Values: 146.0 146.0 147.0 148.0 146.0 147.0 148.0 147.0 148.0 147.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 17:59:41 INFO - PROCESS | 3807 | Values: 97.0 97.0 97.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.62 (2.9%) stddev-sans-first:1.69 17:59:41 INFO - PROCESS | 3807 | Values: 55.0 54.0 59.0 54.0 56.0 58.0 55.0 55.0 56.0 56.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 17:59:41 INFO - PROCESS | 3807 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:9.33 (11.5%) stddev-sans-first:9.84 17:59:41 INFO - PROCESS | 3807 | Values: 81.0 80.0 79.0 80.0 81.0 80.0 81.0 82.0 110.0 86.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.50 stddev:5.03 (3.9%) stddev-sans-first:5.29 17:59:41 INFO - PROCESS | 3807 | Values: 130.0 131.0 122.0 129.0 127.0 123.0 132.0 138.0 128.0 122.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:1.55 (1.0%) stddev-sans-first:1.50 17:59:41 INFO - PROCESS | 3807 | Values: 164.0 163.0 164.0 162.0 163.0 159.0 161.0 162.0 163.0 161.0 17:59:41 INFO - PROCESS | 3807 | 17:59:41 INFO - PROCESS | 3807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.50 stddev:2.28 (3.6%) stddev-sans-first:2.29 17:59:41 INFO - PROCESS | 3807 | Values: 62.0 65.0 67.0 69.0 63.0 62.0 63.0 63.0 64.0 63.0 17:59:41 INFO - PROCESS | 3807 | -------- Summary: end -------- 17:59:41 INFO - PROCESS | 3807 | 17:59:42 INFO - TEST-INFO | 3807: exit 0 17:59:42 INFO - TEST-OK | kraken | took 65634ms 17:59:42 INFO - SUITE-END | took 1184s 17:59:42 INFO - Completed test suite (00:19:44) 17:59:42 INFO - javascript benchmark 17:59:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7176.5761718548, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.288773582076, 3110.346827166295, 3128.6558478567354, 3147.763917706173, 3148.574942382779, 5361.544268737157, 5391.110466772982, 5421.91867121993, 5461.208124821898, 5488.313960754906, 5334.5999050071205, 5445.074337362648, 5453.3728621208575, 5463.699496527699, 5535.308086489189, 4896.2410826321975, 4919.704817710949, 5018.272350509193, 5067.189249720045, 5115.7442127893455, 706.6350054551413, 4992.051510213048, 5030.6981581105065, 5056.974715126419, 5069.0, 4954.355933728611, 4973.90052198954, 4986.252062190664, 4999.32509111269, 5045.64680472367, 4882.3408839806525, 4995.475475075137, 5014.348134742497, 5032.647714659939, 5052.216906379517, 4911.336969509106, 4911.680740751875, 4926.704397736147, 4929.334539837112, 4941.925871111936, 5435.211894275348, 5512.200730894038, 5514.6139770216105, 5524.558035357162, 5573.470520300565, 5789.8263052108505, 5843.912341314884, 5910.320313163955, 5923.17075609415, 5935.970320148414, 5884.058550631921, 5915.408459154093, 5922.289325280994, 5922.526197904157, 5964.850878728023, 5461.617686761928, 5493.890122197574, 5531.751071201766, 5535.972320138373, 5542.0301447246575, 5868.295804503487, 5923.466887980103, 5966.582339236299, 5970.0, 6019.428154325332, 5744.684042377626, 5758.165066065397, 5777.335606405233, 5781.161731548902, 5781.219535362757, 5852.941470585325, 5860.70696465175, 5868.706564671835, 5869.060950248026, 5875.50058245054, 5625.971870140623, 5771.567132465082, 5818.5054270386645, 5841.649501029951, 5868.765249390062, 5708.086706127, 5764.567657425626, 5796.0436527972415, 5805.303363596396, 5881.676507792027, 4433.645308375322, 4465.129299786576, 4473.127740090651, 4474.038081812361, 4516.096780643818, 3909.2963266611714, 3974.4435778990965, 4008.7995600220456, 4039.7778122203563, 4041.9797901010306, 5662.518685911744, 5680.857978550486, 5686.943130568724, 5688.516476099495, 5713.971430142906, 5724.656520608777, 5941.940580594225, 6008.098785182257, 6008.789692360747, 6010.429009244115, 5628.296462942132, 5644.238027866268, 5670.0, 5679.091345384802, 5698.11679189718, 5136.43499215086, 5152.124138896396, 5175.042617115846, 5181.5595674368105, 5219.765110570033, 5934.258217722785, 6038.547108966845, 6145.600535965237, 6168.0, 6180.381961803873, 5894.852628684232, 5941.881162376815, 5953.732082056405, 5970.283565971938, 6016.338202797776, 5978.790742324171, 5988.820335389945, 5989.0, 5997.220361352996, 6017.338092809875, 5543.334799823886, 5662.150677398423, 5711.171880077449, 5798.594098413239, 5806.883862322815, 5881.088431293157, 5889.057750759858, 5891.469767720926, 5892.322382926019, 5933.169356290036, 5654.604177707685, 5684.687342196054, 5735.71321433935, 5738.196652468574, 5745.454181852718, 5594.4964953152785, 5725.51333136688, 5730.398308177748, 5747.051736463437, 5779.739911703899, 5481.150421684645, 5602.887942241214, 5603.859903502445, 5685.602007859576, 5711.343195532567, 5708.400617935057, 5727.284089488814, 5730.684812335361, 5738.139279108167, 5826.329972053268, 5455.509004189642, 5565.499105080562, 5595.468430499096, 5610.382857885547, 5681.034224181816], "value": 5377.417235306746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6055141676534, 615.935326790687, 620.8820324138411, 623.9064140378946, 637.9138816259804, 41366.37950430742, 43020.139597208035, 43151.56848431515, 46680.0, 47112.76443617786, 43841.0, 44069.0, 44264.77867610657, 44459.0, 44570.55429445705, 8807.427517211378, 8946.329025323126, 8971.865422018675, 9020.323475739313, 9033.23217526511, 8956.104389561024, 8963.417377870417, 9003.324750643695, 9034.412763170405, 9070.365074444759, 9064.229540489066, 9078.319126065539, 9091.136342047495, 9094.090590940887, 9113.362064655477, 9048.230900373475, 9051.7284481466, 9064.592093355783, 9074.45553266806, 9091.090890910922, 8928.642854285887, 8970.0, 8996.505192214425, 8998.325125615605, 9031.412958157698, 41015.38476922848, 41463.7926810364, 41479.37780933289, 41517.37723934143, 41632.0, 3581.1405262737017, 3748.8875333739757, 3859.4210868369687, 4124.979375103106, 4172.520160181588, 32110.678893211003, 32212.838935805405, 32590.674093259, 32663.836680816683, 33563.16092097693, 4151.958480415187, 4209.389638502431, 4246.766427846467, 4339.8047087880805, 4391.742650234026, 338585.0, 341551.0, 342513.9999999975, 344541.0, 345260.27369863243, 33859.0, 34582.0, 56023.0, 56227.43772562304, 56429.71785141048, 36118.458223126676, 36610.8169459151, 36629.63370366262, 36646.450303245474, 36748.0, 14539.636509087146, 14542.709145817025, 14610.634734131732, 14688.926555367154, 14717.484888028868, 12067.517299308105, 12149.757004859854, 12178.451969661386, 12186.2078964867, 12205.755884882252, 8219.342452603778, 8250.0, 8372.41393102477, 8382.203690649378, 8439.535825529654, 3241.3517296540786, 3252.186858367495, 3268.248302890301, 3299.4226010448074, 3311.7516186286125, 1004.9598016079275, 1039.210200247802, 1104.4201794058183, 1109.7503061811028, 1148.1159507179425, 31436.685633143832, 31466.0, 31605.20986975344, 31735.0, 31902.680973190436, 1082.3992684060422, 1104.282216559243, 1126.594426006637, 1132.1395739238073, 1171.7363593191465, 16033.198340082949, 16422.0, 16433.83566164347, 16462.341506339853, 16828.326866925432, 565367.0, 929687.0, 956583.0, 957568.0, 957764.0, 56793.14810277849, 57396.0, 57479.0, 57578.4242157573, 57645.135322970185, 1351.2433037499031, 1371.9588412347646, 1393.428694235379, 1403.7894315852704, 1404.810350602676, 30164.229471316085, 32126.678733212368, 32264.193395165308, 32369.49272508826, 32456.35087298288, 50166.74916625393, 50717.23924141067, 50794.49205508045, 50808.49191508185, 50827.49172508375, 482535.0, 486073.0, 486537.0, 490842.0, 491168.0, 28027.299317517227, 28147.296317592223, 28448.57327140053, 28691.71308286974, 28708.0, 46650.300245495666, 46759.0, 47574.52425475701, 47650.52349476461, 47965.5203447961, 38842.805785970886, 39918.2016359677, 40154.1969160621, 40459.1908161841, 40697.98255043648, 38484.42273365846, 39857.40213896736, 39974.0, 40063.0, 40532.0, 38873.02817429474, 39344.40983385309, 40108.1978360437, 40231.396529051504, 40252.39621405623, 33092.503612445355, 35244.823775880956, 35595.822020890766, 41831.16337673169, 43276.78361608172, 31418.21454463657, 34349.31301374009, 34356.0, 34598.30803383868, 34858.825705871306], "value": 19255.8140177968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1565050791306, 396.7104014069727, 399.94000899865034, 404.1553153908332, 419.1470357821833, 13624.318784060782, 17919.82080179198, 18941.242350306005, 19522.609547809054, 19546.218151273948, 16802.747958780597, 16810.411635592758, 17186.828131718677, 19071.332503362384, 19099.33152339665, 5374.086405311096, 5500.862478438051, 5510.476504732064, 5529.723513824313, 5886.058230683092, 5693.914591281114, 5751.856203594902, 5803.709814509279, 5836.533077353823, 5846.444587764156, 5660.773569057233, 5747.655140691572, 5805.0, 5816.505597024258, 5835.649861008353, 5713.5714821388565, 5776.018076926933, 5780.826575202751, 5800.47795698387, 5820.679862607555, 5120.564751996085, 5159.871003224912, 5210.739463026872, 5238.869028274324, 5242.79028838846, 20551.79448205514, 21732.0, 21835.563288734138, 22666.77333226663, 23248.883755581282, 2311.295055008222, 2331.49872777352, 2369.2536850891915, 2543.847369157838, 2777.4861650594703, 10187.54156062979, 10245.538950747234, 10456.058954694037, 10593.629222977159, 10814.297070690458, 1857.3406440713622, 1911.1781933768475, 1912.3211260002638, 1965.9606807863906, 1982.3656429942423, 79003.0, 81700.0, 82493.76259356174, 84367.0, 84425.0, 9400.858987115198, 9538.570764315622, 10769.515371808287, 10870.891291087146, 11235.606753763579, 15323.0, 15546.844531554765, 15553.533393998197, 15600.84399155994, 15606.609834754221, 7546.2831031051965, 8127.390445716476, 8154.429189956646, 8283.461574997606, 8332.16678332162, 7777.883331750028, 7794.961025194951, 8001.239882211181, 8049.879251811228, 8099.230573095547, 4588.311753237042, 4691.601213896857, 4744.288356746516, 4772.7136371817805, 4857.571214392804, 1967.5277933295906, 2024.2813801100692, 2025.8885761282977, 2044.8364130869495, 2050.7744148143693, 926.7173512078881, 940.47333493244, 977.1889331854544, 1023.9504507879483, 1025.733309339562, 19039.238430462625, 19288.0, 19332.516687082654, 19436.0, 19490.707639385422, 940.7648087978006, 971.6696323249987, 978.105033893979, 1008.8839783424853, 1033.4006276359694, 10198.592056317813, 10916.235863489479, 10930.453477326102, 11039.337639741641, 11060.115190784718, 421165.0, 424113.55318680976, 468668.0, 470828.0, 471037.0, 72966.0, 78893.0, 84485.57757211174, 97674.51162744283, 100688.49655751821, 1001.1090129784498, 1035.9067683908484, 1059.7615536504225, 1068.4871261794383, 1068.7541865370852, 17612.82387176163, 17633.559161021076, 18061.458156255332, 18079.728804068214, 18110.81889181091, 42149.1570168601, 42158.36762448627, 42858.78570607127, 44283.0, 44357.778211108736, 61144.69427652833, 61668.38331616806, 61851.38148618456, 61865.0, 63549.68225158845, 8915.554222288989, 8940.73177804667, 8985.371024028254, 9005.189532942066, 9213.262938964732, 10272.743181420525, 12798.61604151877, 13311.80032299497, 13925.164490130624, 13972.650683732989, 10898.50956706966, 11378.829317560409, 11586.36275004849, 11916.52333906634, 12160.878391216329, 10697.251192416767, 11123.72190695239, 11595.710107247387, 11682.24065435744, 12325.75348493043, 11944.64166075019, 11962.342071186169, 11985.400729963292, 12184.268943863397, 12377.009839212662, 8996.955015224881, 9197.172254497127, 9327.207187389147, 9331.766705832408, 9363.953180234328, 11229.66311010671, 11886.108541859569, 11899.643010709693, 12003.63989080329, 12156.756864862477], "value": 9211.612698156592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.504750860953, 1474.5797447727396, 1572.4182052640517, 1702.6594681063775, 1713.811480737118, 6923.0, 7601.695932162714, 7992.120866704672, 8117.756467305975, 8124.837503249939, 8250.83498330033, 8279.503229806201, 8307.83384332313, 8309.459885107464, 8313.41806073575, 2209.491816882118, 2221.8777967211795, 2234.273860995175, 2234.553089382122, 2234.7876951689564, 2194.967075493869, 2228.1310288987306, 2239.944001399962, 2250.1449449209276, 2251.7297924249115, 2212.8782916939563, 2218.589560931233, 2223.6886835842915, 2227.9554408911813, 2256.6953461282683, 2175.184305885293, 2179.814715749163, 2201.350601572532, 2204.47092697753, 2215.2357436684397, 2156.54712510373, 2167.9891600541896, 2168.4362065862833, 2170.1319472211085, 2174.597699425611, 8388.0, 8449.281811046068, 8481.363897707697, 8501.14988501145, 8551.273141782956, 4989.426215985171, 5110.156824124015, 5121.308623335839, 5137.434882162959, 5145.125328694131, 3021.818690878554, 3129.9217519561967, 3172.0642410488963, 3210.6949839765184, 3214.8874789382257, 1025.3489034463096, 1058.3596923861107, 1090.2041509697885, 1098.2696506822954, 1104.9944750276277, 11521.769564608661, 11673.0, 11688.181827272094, 11696.883031169664, 11733.53065877364, 4386.539413361615, 4544.772761361919, 4548.11311794197, 4550.6587005974025, 4552.726836389827, 9822.557984890696, 9899.60401583943, 9913.553890074963, 9930.553125109387, 9951.054649808257, 4992.375953005874, 4992.700437973734, 5003.74981250936, 5058.671186372948, 5089.262057001788, 4163.770992595376, 4660.044690838437, 4673.626109911199, 4682.906341873144, 4718.363020992122, 3713.8700145494777, 3780.1494663700446, 3833.0800607853917, 3839.6544311012144, 3888.4361767543546, 1177.9764404711857, 1203.7773011992808, 1217.945192466341, 1218.5065048655308, 1224.6693392784077, 925.6575067225169, 944.7260294514651, 964.6479035152119, 967.583938906277, 984.6061575369766, 5625.943740562624, 5725.3988331225455, 5875.236219291465, 5881.264841894763, 6008.7706273078065, 422.09039519834806, 433.9262325404689, 440.65848967050795, 440.7663938112805, 440.79503031090695, 3994.3609022556834, 4048.0689441428635, 4091.7135800494275, 4133.731307465006, 4144.896377590584, 9781.315307928518, 10263.435511046964, 10265.435401052864, 10272.640457583948, 10315.896841031643, 10094.293399462114, 10095.141912937335, 10172.593096276067, 10181.847272290921, 10194.337368071052, 7750.961245193738, 7828.099768526578, 7850.607469626496, 7881.5665138417935, 7898.249666281694, 5645.858853528694, 5647.0964645656495, 5686.715664216856, 5755.71221438918, 5798.188253644409, 9469.857952130586, 9502.572384242587, 9570.808583828424, 9600.0, 9607.663731769355, 9335.113164249386, 9470.857937131086, 9717.319787614799, 9742.95128524353, 9792.265580081379, 6617.172853393326, 7223.2776722329445, 7490.550566966, 7493.925060749323, 7520.924790752022, 8172.387070969582, 8241.752747417588, 8278.958605206935, 8294.958525207336, 8325.708600198965, 7246.96376518114, 7352.558846469229, 7413.592252426169, 7433.628318584158, 7570.05374328209, 7261.564306141649, 7263.0921134858145, 7311.561306321638, 7336.486445948733, 7367.742129025459, 6759.864802704017, 6795.932040679728, 6830.112085428863, 6844.897326540006, 6891.517593768388, 4814.422269327703, 4991.276264941635, 4993.975030124826, 5070.569001634903, 5188.247704082812, 4912.828051018198, 4995.775190116381, 5013.39839219296, 5021.698698078127, 5060.696358218519], "value": 4356.187818720399, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.96566860479646, 326.9754768392371, 331.33071196183704, 331.3505529162841, 332.4497955883013, 5614.494695477406, 5624.9718751406235, 5646.774129034844, 5648.4633959773755, 5701.600887937846, 5579.13523403873, 5602.439756024395, 5624.887502249952, 5642.351129620095, 5646.830595082144, 4204.297259609855, 4301.870943871689, 4404.7357158570585, 4426.889327766816, 4435.955640443586, 4294.162638285536, 4330.935035974463, 4349.0, 4353.955050787804, 4363.0619416825375, 4319.287317592593, 4350.260455722519, 4355.71687840291, 4359.128174365123, 4384.97807510962, 4232.841250962001, 4341.826326946918, 4343.500497442803, 4364.54172311909, 4391.516933137353, 3817.751846129993, 3830.559485659157, 3863.497745293122, 3883.456316115746, 3883.475730776337, 5415.727304083537, 5447.155690867922, 5514.0, 5522.723863806794, 5528.419515950807, 4782.473927867932, 4979.3526841510375, 5011.123053465665, 5016.874578135539, 5076.796928122871, 5862.706864656793, 5881.500217444567, 5927.851803704899, 5928.9624315745, 5929.64422134669, 4280.336547835091, 4298.0, 4302.709187243814, 4315.331123675835, 4316.395704601358, 5972.64164150148, 5982.700864956735, 6027.186329845458, 6043.730816528534, 6075.359652893694, 4261.637760790368, 4314.482262128502, 4321.58944900234, 4378.387025816388, 4391.560843915583, 4434.627474301234, 4437.556244375537, 4448.243798554254, 4449.243628583149, 4458.996725736748, 4943.8516844494725, 4991.226359914219, 5003.974980125149, 5010.498950105033, 5027.824026159067, 5886.293644762656, 5941.940580594225, 5947.1376650385455, 5956.315023772235, 5991.453632206295, 1513.3341329814846, 1521.5511424129909, 1541.961450963735, 1544.8995815272197, 1550.2558771789604, 977.1742877268697, 981.9410835349759, 991.7718924647371, 1042.9791404172026, 1048.0, 5617.9438205618235, 5634.295713035871, 5700.800471983461, 5732.742026608813, 5750.453706897838, 6011.248593925759, 6069.36271691466, 6117.908231376533, 6124.295705993779, 6126.499007743042, 5474.39781624021, 5606.495415412551, 5615.634983726045, 5640.138754211101, 5677.205191273225, 3202.814958465383, 3212.4860022396306, 3214.437473442138, 3214.5660335854827, 3214.8071115733133, 5874.765009399576, 6087.1173679816175, 6142.57002009855, 6169.2288463942, 6212.099245609361, 6149.754009839557, 6159.753609855556, 6169.907451388232, 6172.382761723792, 6181.536384771161, 5939.109133630076, 6082.908756368658, 6130.111133885562, 6170.994426811304, 6182.319944806068, 5924.30444147903, 5980.996366217366, 5981.863445945257, 6034.0, 6042.788502402394, 5932.79235226765, 5934.465898069195, 5950.285965683973, 5955.255593050869, 5986.610870293417, 5927.644341339534, 6158.353372895782, 6164.969175154096, 6171.7531298749345, 6193.473554747897, 4373.081652852809, 4401.823927042882, 4403.4495688039, 4405.2511073117, 4408.096340250177, 5812.796552120655, 6043.54673399488, 6059.182010428536, 6070.575059745775, 6083.756649734138, 5804.593678442468, 5823.708814559171, 5837.5038121758425, 5850.561207909509, 5852.122181672783, 5747.597668163188, 5770.826875193751, 5803.071508558611, 5811.27359080115, 5830.912536312044, 5193.948060519347, 5666.2350582670815, 5727.596738799021, 5741.885162296814, 5747.281589801275, 5866.67733274674, 5911.758530708427, 5928.110783382354, 5928.970355148197, 5947.464728174485, 5553.500184983371, 5755.971220143872, 5761.798337058183, 5768.567357448124, 5817.156512305607], "value": 4481.830618816774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7807657702688, 732.6959311885568, 740.6259838781415, 788.9487183333084, 802.4382931947634, 15562.844371556295, 16330.673386532262, 16350.10074445905, 16361.0, 16376.672466550663, 12213.450394732236, 14785.408583656668, 14949.551513454586, 14952.327145278461, 14971.176585287805, 788.964496597653, 807.8828569857367, 813.0203105258179, 813.5484805932705, 813.9145389734082, 796.1282395776616, 798.3014861995754, 799.9560024198666, 800.651716503323, 800.6997375984006, 827.9213474719892, 835.448603921412, 837.3008537870885, 837.6188834080479, 837.7444879311807, 824.2705205892828, 824.389951435936, 826.9503829770202, 829.3116713128089, 832.3299743706314, 593.4303069053714, 603.1194456094108, 603.6076550242334, 604.7701873288166, 605.279717136606, 14528.782068268985, 14577.70844583113, 14585.854141458556, 14623.561293161221, 14661.706765864623, 14239.644008899757, 14298.28508574567, 14519.70960580793, 14743.77884331736, 14886.776698349533, 11890.464929078213, 12006.879931200663, 12117.69705757363, 12339.691507712289, 12747.553835615801, 3900.6294402031763, 3911.198204368098, 3919.9216015679526, 3952.505936757905, 4047.797610119482, 76008.0, 77102.0, 77219.0, 77514.0, 77864.0, 11470.197086204053, 11610.88389116115, 11691.0, 11708.88291117078, 11856.170068095324, 20778.792212077988, 20844.1662333508, 20850.06174722141, 21019.369418917457, 21055.578888422147, 8183.71357002502, 8524.914750852537, 8535.530545819915, 8818.691345802994, 8991.370604057653, 4645.117427688729, 4844.15227335222, 4853.95146048542, 4922.360093187863, 4954.529319714621, 3660.9816950915606, 3675.632436756303, 3731.794751288651, 3739.0652336915773, 3780.8487660493824, 624.9843753906098, 628.8836565235355, 642.3351830855042, 657.7138944559132, 664.557750267764, 582.2779753106117, 600.1849004553321, 617.1298469158465, 663.3333499832734, 677.6408503493157, 9290.024547422423, 9439.339246252697, 9455.243580513543, 9458.763530911783, 9596.520173991412, 636.8503401700597, 649.9545031847725, 676.1683129750336, 689.9103116594911, 702.950793444454, 4510.729356238636, 4643.674942754043, 4664.230401983635, 4692.1084993851055, 4696.084263568571, 114618.4269078666, 116313.0, 116732.0, 117076.41461792636, 117411.0, 59477.10784338152, 102428.0, 103592.0, 104692.95307046984, 105406.47296763468, 56817.71591142018, 57110.0, 61376.69311653413, 82741.10406135877, 89661.55169224112, 8719.171678690514, 8730.519821409629, 8837.734867953715, 8874.866876996979, 9071.0, 48013.0, 52475.73762131165, 52846.20730688966, 53703.19445208403, 54842.0, 44332.11335773331, 45357.77321113373, 45597.0, 62046.689766552685, 63875.36124638694, 11621.360825154698, 11703.23928944616, 12024.0, 12217.389130543615, 12411.875881241072, 12669.176503527242, 12856.614301570968, 13104.73790524165, 13703.931480342535, 13713.862861371657, 12532.561360352343, 12557.246565206116, 12875.549355772502, 13563.796543051665, 13731.0, 13166.275854828076, 13487.460501579826, 13493.797593035915, 13493.932530337286, 13838.65403364924, 13060.346982651019, 13072.411741471466, 13362.398692059076, 13407.798883016958, 13484.595462136152, 10379.584816607252, 10413.479326033517, 10497.688874721107, 10561.894381056398, 10818.350898946088, 11239.55041798319, 11365.943170284096, 11649.184557080924, 11653.825192622287, 11781.705457363634], "value": 7335.459269424309, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 111.0, 111.0, 112.0, 111.0, 113.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 156.0, 178.0, 134.0, 151.0, 159.0, 130.0, 187.0, 133.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 163.0, 174.0, 162.0, 162.0, 163.0, 170.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 84.0, 75.0, 157.0, 74.0, 75.0, 74.0, 75.0, 169.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 155.0, 85.0, 85.0, 84.0, 156.0, 85.0, 85.0, 145.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 59.0, 54.0, 56.0, 58.0, 55.0, 55.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 81.0, 80.0, 81.0, 82.0, 110.0, 86.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 122.0, 129.0, 127.0, 123.0, 132.0, 138.0, 128.0, 122.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 163.0, 159.0, 161.0, 162.0, 163.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 67.0, 69.0, 63.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 64.1, "unit": "score"}]}]} 17:59:42 INFO - Return code: 0 17:59:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:59:42 ERROR - # TBPL SUCCESS # 17:59:42 INFO - Running post-action listener: _resource_record_post_action 17:59:42 INFO - ##### 17:59:42 INFO - ##### Finished run-tests step (success) 17:59:42 INFO - ##### 17:59:42 INFO - Running post-run listener: _resource_record_post_run 17:59:42 INFO - Total resource usage - Wall time: 1204s; CPU: 14.0%; Read bytes: 7659520; Write bytes: 436465664; Read time: 2444; Write time: 1404136 17:59:42 INFO - TinderboxPrint: CPU usage
13.5% 17:59:42 INFO - TinderboxPrint: I/O read bytes / time
7,659,520 / 2,444 17:59:42 INFO - TinderboxPrint: I/O write bytes / time
436,465,664 / 1,404,136 17:59:42 INFO - TinderboxPrint: CPU idle
8,301.5 (86.4%) 17:59:42 INFO - TinderboxPrint: CPU user
1,223.3 (12.7%) 17:59:42 INFO - TinderboxPrint: Swap in / out
0 / 0 17:59:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 65835008; Read time: 0; Write time: 179520 17:59:43 INFO - run-tests - Wall time: 1187s; CPU: 14.0%; Read bytes: 7659520; Write bytes: 355663872; Read time: 2444; Write time: 1137916 17:59:43 INFO - Running post-run listener: _upload_blobber_files 17:59:43 INFO - Blob upload gear active. 17:59:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:59:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:59:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:44 INFO - (blobuploader) - INFO - Done attempting. 17:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:48 INFO - (blobuploader) - INFO - Done attempting. 17:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:49 INFO - (blobuploader) - INFO - Done attempting. 17:59:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:49 INFO - Return code: 0 17:59:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d5aa28e48a852b1a5ecc3e16c8099c838a223a5308850e9b8d8c27c5e18a4ab22affc3453bb9d1d821ee77b2d2544ab3637c7a511a688379e2d449acb521e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888a57194015a04d476e230198604904c6a200da6b13ee64b454306e31f410d554f812e7b3c82a3364b91a905a535de3cf526690c96d8e3df4766a9000842e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b7fa5a04d301d04202fb4add469914a97568f7686a2b7bc13bbbe9655c66866b3a6c39d60d81ec7e27d13c47321d7875c01ceb2bf679c64ef6d110d813954f"} 17:59:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:49 INFO - Contents: 17:59:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d5aa28e48a852b1a5ecc3e16c8099c838a223a5308850e9b8d8c27c5e18a4ab22affc3453bb9d1d821ee77b2d2544ab3637c7a511a688379e2d449acb521e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888a57194015a04d476e230198604904c6a200da6b13ee64b454306e31f410d554f812e7b3c82a3364b91a905a535de3cf526690c96d8e3df4766a9000842e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b7fa5a04d301d04202fb4add469914a97568f7686a2b7bc13bbbe9655c66866b3a6c39d60d81ec7e27d13c47321d7875c01ceb2bf679c64ef6d110d813954f"} 17:59:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:49 INFO - Copying logs to upload dir... 17:59:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1341.826250 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-06-15 17:59:49.057922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:59:49.062241) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d5aa28e48a852b1a5ecc3e16c8099c838a223a5308850e9b8d8c27c5e18a4ab22affc3453bb9d1d821ee77b2d2544ab3637c7a511a688379e2d449acb521e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888a57194015a04d476e230198604904c6a200da6b13ee64b454306e31f410d554f812e7b3c82a3364b91a905a535de3cf526690c96d8e3df4766a9000842e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b7fa5a04d301d04202fb4add469914a97568f7686a2b7bc13bbbe9655c66866b3a6c39d60d81ec7e27d13c47321d7875c01ceb2bf679c64ef6d110d813954f"} build_url:https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d5aa28e48a852b1a5ecc3e16c8099c838a223a5308850e9b8d8c27c5e18a4ab22affc3453bb9d1d821ee77b2d2544ab3637c7a511a688379e2d449acb521e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/888a57194015a04d476e230198604904c6a200da6b13ee64b454306e31f410d554f812e7b3c82a3364b91a905a535de3cf526690c96d8e3df4766a9000842e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71b7fa5a04d301d04202fb4add469914a97568f7686a2b7bc13bbbe9655c66866b3a6c39d60d81ec7e27d13c47321d7875c01ceb2bf679c64ef6d110d813954f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:59:49.090208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:59:49.090707) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466032782.705984-706367715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:59:49.141914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:59:49.142426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:59:49.142941) ========= ========= Total master_lag: 0.18 =========