builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1465489789.72 results: success (0) buildid: 20160609090330 builduid: c0bc181ffaa245c6a93226187cd7c2bd revision: f4c18cbc1201927d52b23a97dad073a5617237bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.724876) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.725362) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.725663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.740435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.740847) ========= 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=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 09:29:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-09 09:29:49 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.846995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.847307) ========= 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=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:49.896489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 09:29:49.896836) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4c18cbc1201927d52b23a97dad073a5617237bd --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 f4c18cbc1201927d52b23a97dad073a5617237bd --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=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 09:29:49,909 truncating revision to first 12 chars 2016-06-09 09:29:49,909 Setting DEBUG logging. 2016-06-09 09:29:49,909 attempt 1/10 2016-06-09 09:29:49,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4c18cbc1201?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 09:29:50,963 unpacking tar archive at: fx-team-f4c18cbc1201/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 09:29:51.281479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:51.281846) ========= script_repo_revision: f4c18cbc1201927d52b23a97dad073a5617237bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:51.282282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:51.282603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:29:51.290935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 09:29:51.291201) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:51 INFO - MultiFileLogger online at 20160609 09:29:51 in /builds/slave/test 09:29:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:29:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:51 INFO - {'append_to_log': False, 09:29:51 INFO - 'base_work_dir': '/builds/slave/test', 09:29:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:29:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:51 INFO - 'branch': 'Fx-Team-Non-PGO', 09:29:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:51 INFO - 'config_files': ('talos/linux_config.py',), 09:29:51 INFO - 'default_actions': ('clobber', 09:29:51 INFO - 'read-buildbot-config', 09:29:51 INFO - 'download-and-extract', 09:29:51 INFO - 'populate-webroot', 09:29:51 INFO - 'create-virtualenv', 09:29:51 INFO - 'install', 09:29:51 INFO - 'run-tests'), 09:29:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:51 INFO - 'download_minidump_stackwalk': True, 09:29:51 INFO - 'download_symbols': 'ondemand', 09:29:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:51 INFO - 'installer_path': 'installer.exe', 09:29:51 INFO - 'log_level': 'info', 09:29:51 INFO - 'log_name': 'talos', 09:29:51 INFO - 'log_to_console': True, 09:29:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:51 INFO - 'opt_config_files': (), 09:29:51 INFO - 'pip_index': False, 09:29:51 INFO - 'sps_profile': False, 09:29:51 INFO - 'sps_profile_interval': 0, 09:29:51 INFO - 'suite': 'dromaeojs', 09:29:51 INFO - 'system_bits': '32', 09:29:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:51 INFO - 'title': 'talos-linux64-ix-058', 09:29:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:51 INFO - 'use_talos_json': True, 09:29:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:51 INFO - 'work_dir': 'build'} 09:29:51 INFO - ##### 09:29:51 INFO - ##### Running clobber step. 09:29:51 INFO - ##### 09:29:51 INFO - Running pre-action listener: _resource_record_pre_action 09:29:51 INFO - Running main action method: clobber 09:29:51 INFO - rmtree: /builds/slave/test/build 09:29:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:52 INFO - Running post-action listener: _resource_record_post_action 09:29:52 INFO - ##### 09:29:52 INFO - ##### Finished clobber step (success) 09:29:52 INFO - ##### 09:29:52 INFO - ##### 09:29:52 INFO - ##### Running read-buildbot-config step. 09:29:52 INFO - ##### 09:29:52 INFO - Running pre-action listener: _resource_record_pre_action 09:29:52 INFO - Running main action method: read_buildbot_config 09:29:52 INFO - Using buildbot properties: 09:29:52 INFO - { 09:29:52 INFO - "project": "", 09:29:52 INFO - "product": "firefox", 09:29:52 INFO - "script_repo_revision": "production", 09:29:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:29:52 INFO - "repository": "", 09:29:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:29:52 INFO - "buildid": "20160609090330", 09:29:52 INFO - "pgo_build": "False", 09:29:52 INFO - "basedir": "/builds/slave/test", 09:29:52 INFO - "buildnumber": 3075, 09:29:52 INFO - "slavename": "talos-linux64-ix-058", 09:29:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:29:52 INFO - "platform": "ubuntu64_hw", 09:29:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:29:52 INFO - "branch": "fx-team", 09:29:52 INFO - "repo_path": "integration/fx-team", 09:29:52 INFO - "revision": "f4c18cbc1201927d52b23a97dad073a5617237bd", 09:29:52 INFO - "stage_platform": "linux64", 09:29:52 INFO - "builduid": "c0bc181ffaa245c6a93226187cd7c2bd", 09:29:52 INFO - "slavebuilddir": "test" 09:29:52 INFO - } 09:29:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:29:52 INFO - Running post-action listener: _resource_record_post_action 09:29:52 INFO - ##### 09:29:52 INFO - ##### Finished read-buildbot-config step (success) 09:29:52 INFO - ##### 09:29:52 INFO - ##### 09:29:52 INFO - ##### Running download-and-extract step. 09:29:52 INFO - ##### 09:29:52 INFO - Running pre-action listener: _resource_record_pre_action 09:29:52 INFO - Running main action method: download_and_extract 09:29:52 INFO - mkdir: /builds/slave/test/build/tests 09:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:52 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:29:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:29:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:29:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:53 INFO - Downloaded 1361 bytes. 09:29:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:29:53 INFO - Using the following test package requirements: 09:29:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:29:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:29:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:29:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'jsshell-linux-x86_64.zip'], 09:29:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:29:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:29:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:29:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:29:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:29:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:29:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:29:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:53 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:54 INFO - Downloaded 22879604 bytes. 09:29:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:29:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:29:55 INFO - Return code: 0 09:29:55 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 09:29: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')]} 09:29:55 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:29:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:29:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:29:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:57 INFO - Downloaded 22879604 bytes. 09:29:57 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'] 09:29:57 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 09:29:58 INFO - Return code: 0 09:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:58 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:59 INFO - Downloaded 10833377 bytes. 09:29:59 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'] 09:29:59 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 09:29:59 INFO - Return code: 0 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:59 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:29:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:29:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:29:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/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 09:30:00 INFO - Downloaded 55364925 bytes. 09:30:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:30:00 INFO - mkdir: /builds/slave/test/properties 09:30:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:00 INFO - Contents: 09:30:00 INFO - build_url:https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:30:01 INFO - Running post-action listener: _resource_record_post_action 09:30:01 INFO - Running post-action listener: set_extra_try_arguments 09:30:01 INFO - ##### 09:30:01 INFO - ##### Finished download-and-extract step (success) 09:30:01 INFO - ##### 09:30:01 INFO - ##### 09:30:01 INFO - ##### Running populate-webroot step. 09:30:01 INFO - ##### 09:30:01 INFO - Running pre-action listener: _resource_record_pre_action 09:30:01 INFO - Running main action method: populate_webroot 09:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:01 INFO - '--tppagecycles', 09:30:01 INFO - '7'], 09:30:01 INFO - 'tests': ['tsvgm']}}, 09:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['damp', 'tps']}, 09:30:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'tests': ['damp', 'tps']}, 09:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['dromaeo_dom']}, 09:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['a11yr', 09:30:01 INFO - 'ts_paint', 09:30:01 INFO - 'tpaint', 09:30:01 INFO - 'sessionrestore', 09:30:01 INFO - 'sessionrestore_no_auto_restore', 09:30:01 INFO - 'tabpaint']}, 09:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['tsvgx', 09:30:01 INFO - 'tsvgr_opacity', 09:30:01 INFO - 'tart', 09:30:01 INFO - 'tscrollx', 09:30:01 INFO - 'cart']}, 09:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:01 INFO - 'tsvgr_opacity', 09:30:01 INFO - 'tart', 09:30:01 INFO - 'tscrollx', 09:30:01 INFO - 'cart']}, 09:30:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'talos_options': ['--disable-e10s'], 09:30:01 INFO - 'tests': ['tp5o']}, 09:30:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'tests': ['tp5o']}, 09:30:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'talos_options': ['--disable-e10s', 09:30:01 INFO - '--xperf_path', 09:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:01 INFO - 'tests': ['tp5n']}, 09:30:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:01 INFO - 'talos_options': ['--xperf_path', 09:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:01 INFO - 'tests': ['tp5n']}}, 09:30:01 INFO - 'talos.zip': {'path': '', 09:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:01 INFO - Running post-action listener: _resource_record_post_action 09:30:01 INFO - ##### 09:30:01 INFO - ##### Finished populate-webroot step (success) 09:30:01 INFO - ##### 09:30:01 INFO - ##### 09:30:01 INFO - ##### Running create-virtualenv step. 09:30:01 INFO - ##### 09:30:01 INFO - Running pre-action listener: _resource_record_pre_action 09:30:01 INFO - Running main action method: create_virtualenv 09:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:01 INFO - Using real prefix '/usr' 09:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:04 INFO - Installing pip.................done. 09:30:04 INFO - Return code: 0 09:30:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:30:04 INFO - Using env: {'DISPLAY': ':0', 09:30:04 INFO - 'HOME': '/home/cltbld', 09:30:04 INFO - 'LANG': 'en_US.UTF-8', 09:30:04 INFO - 'LANGUAGE': 'en_US:en', 09:30:04 INFO - 'LOGNAME': 'cltbld', 09:30:04 INFO - 'MAIL': '/var/mail/cltbld', 09:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:04 INFO - 'MOZ_NO_REMOTE': '1', 09:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:04 INFO - 'NO_EM_RESTART': '1', 09:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:04 INFO - 'PWD': '/builds/slave/test', 09:30:04 INFO - 'SHELL': '/bin/bash', 09:30:04 INFO - 'SHLVL': '1', 09:30:04 INFO - 'TERM': 'linux', 09:30:04 INFO - 'TMOUT': '86400', 09:30:04 INFO - 'USER': 'cltbld', 09:30:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:04 INFO - '_': '/tools/buildbot/bin/python'} 09:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:30:04 INFO - Cleaning up... 09:30:04 INFO - Return code: 0 09:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:30:04 INFO - Using env: {'DISPLAY': ':0', 09:30:04 INFO - 'HOME': '/home/cltbld', 09:30:04 INFO - 'LANG': 'en_US.UTF-8', 09:30:04 INFO - 'LANGUAGE': 'en_US:en', 09:30:04 INFO - 'LOGNAME': 'cltbld', 09:30:04 INFO - 'MAIL': '/var/mail/cltbld', 09:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:04 INFO - 'MOZ_NO_REMOTE': '1', 09:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:04 INFO - 'NO_EM_RESTART': '1', 09:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:04 INFO - 'PWD': '/builds/slave/test', 09:30:04 INFO - 'SHELL': '/bin/bash', 09:30:04 INFO - 'SHLVL': '1', 09:30:04 INFO - 'TERM': 'linux', 09:30:04 INFO - 'TMOUT': '86400', 09:30:04 INFO - 'USER': 'cltbld', 09:30:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:04 INFO - '_': '/tools/buildbot/bin/python'} 09:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:04 INFO - Downloading/unpacking psutil>=3.1.1 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:06 INFO - Installing collected packages: psutil 09:30:06 INFO - Running setup.py install for psutil 09:30:06 INFO - building 'psutil._psutil_linux' extension 09:30:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:30:07 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 09:30:07 INFO - building 'psutil._psutil_posix' extension 09:30:07 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 09:30:07 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 09:30:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:07 INFO - Successfully installed psutil 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:07 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')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:07 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 09:30:07 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 09:30:07 INFO - Using env: {'DISPLAY': ':0', 09:30:07 INFO - 'HOME': '/home/cltbld', 09:30:07 INFO - 'LANG': 'en_US.UTF-8', 09:30:07 INFO - 'LANGUAGE': 'en_US:en', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MAIL': '/var/mail/cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SHLVL': '1', 09:30:07 INFO - 'TERM': 'linux', 09:30:07 INFO - 'TMOUT': '86400', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - '_': '/tools/buildbot/bin/python'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:09 INFO - Installing collected packages: mozsystemmonitor 09:30:09 INFO - Running setup.py install for mozsystemmonitor 09:30:10 INFO - Successfully installed mozsystemmonitor 09:30:10 INFO - Cleaning up... 09:30:10 INFO - Return code: 0 09:30:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:30:10 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')]} 09:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:10 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')]} 09:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:10 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:10 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 09:30:10 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 09:30:10 INFO - Using env: {'DISPLAY': ':0', 09:30:10 INFO - 'HOME': '/home/cltbld', 09:30:10 INFO - 'LANG': 'en_US.UTF-8', 09:30:10 INFO - 'LANGUAGE': 'en_US:en', 09:30:10 INFO - 'LOGNAME': 'cltbld', 09:30:10 INFO - 'MAIL': '/var/mail/cltbld', 09:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:10 INFO - 'MOZ_NO_REMOTE': '1', 09:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:10 INFO - 'NO_EM_RESTART': '1', 09:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:10 INFO - 'PWD': '/builds/slave/test', 09:30:10 INFO - 'SHELL': '/bin/bash', 09:30:10 INFO - 'SHLVL': '1', 09:30:10 INFO - 'TERM': 'linux', 09:30:10 INFO - 'TMOUT': '86400', 09:30:10 INFO - 'USER': 'cltbld', 09:30:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:10 INFO - '_': '/tools/buildbot/bin/python'} 09:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:11 INFO - Downloading/unpacking jsonschema==2.5.1 09:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:13 INFO - warning: no files found matching '*.txt' 09:30:13 INFO - no previously-included directories found matching 'build' 09:30:13 INFO - no previously-included directories found matching 'dist' 09:30:13 INFO - no previously-included directories found matching '.git*' 09:30:13 INFO - Installing collected packages: jsonschema, functools32 09:30:13 INFO - Running setup.py install for functools32 09:30:13 INFO - warning: no files found matching '*.txt' 09:30:13 INFO - no previously-included directories found matching 'build' 09:30:13 INFO - no previously-included directories found matching 'dist' 09:30:13 INFO - no previously-included directories found matching '.git*' 09:30:13 INFO - Successfully installed jsonschema functools32 09:30:13 INFO - Cleaning up... 09:30:13 INFO - Return code: 0 09:30:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30:13 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')]} 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:13 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')]} 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:13 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:13 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 09:30:13 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 09:30:13 INFO - Using env: {'DISPLAY': ':0', 09:30:13 INFO - 'HOME': '/home/cltbld', 09:30:13 INFO - 'LANG': 'en_US.UTF-8', 09:30:13 INFO - 'LANGUAGE': 'en_US:en', 09:30:13 INFO - 'LOGNAME': 'cltbld', 09:30:13 INFO - 'MAIL': '/var/mail/cltbld', 09:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:13 INFO - 'MOZ_NO_REMOTE': '1', 09:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:13 INFO - 'NO_EM_RESTART': '1', 09:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:13 INFO - 'PWD': '/builds/slave/test', 09:30:13 INFO - 'SHELL': '/bin/bash', 09:30:13 INFO - 'SHLVL': '1', 09:30:13 INFO - 'TERM': 'linux', 09:30:13 INFO - 'TMOUT': '86400', 09:30:13 INFO - 'USER': 'cltbld', 09:30:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:13 INFO - '_': '/tools/buildbot/bin/python'} 09:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:16 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 09:30:16 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 09:30:16 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 09:30:16 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 09:30:16 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 09:30:16 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 09:30:16 INFO - Downloading docopt-0.6.1.tar.gz 09:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:16 INFO - Running setup.py install for blobuploader 09:30:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:16 INFO - Running setup.py install for requests 09:30:16 INFO - Running setup.py install for docopt 09:30:16 INFO - Successfully installed blobuploader requests docopt 09:30:16 INFO - Cleaning up... 09:30:16 INFO - Return code: 0 09:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:16 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')]} 09:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:16 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')]} 09:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:16 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:16 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 09:30:16 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 09:30:16 INFO - Using env: {'DISPLAY': ':0', 09:30:16 INFO - 'HOME': '/home/cltbld', 09:30:16 INFO - 'LANG': 'en_US.UTF-8', 09:30:16 INFO - 'LANGUAGE': 'en_US:en', 09:30:16 INFO - 'LOGNAME': 'cltbld', 09:30:16 INFO - 'MAIL': '/var/mail/cltbld', 09:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:16 INFO - 'MOZ_NO_REMOTE': '1', 09:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:16 INFO - 'NO_EM_RESTART': '1', 09:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:16 INFO - 'PWD': '/builds/slave/test', 09:30:16 INFO - 'SHELL': '/bin/bash', 09:30:16 INFO - 'SHLVL': '1', 09:30:16 INFO - 'TERM': 'linux', 09:30:16 INFO - 'TMOUT': '86400', 09:30:16 INFO - 'USER': 'cltbld', 09:30:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:16 INFO - '_': '/tools/buildbot/bin/python'} 09:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:17 INFO - Running setup.py (path:/tmp/pip-Z5H_cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:17 INFO - Running setup.py (path:/tmp/pip-NPHeYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:17 INFO - Running setup.py (path:/tmp/pip-fIh8IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:17 INFO - Running setup.py (path:/tmp/pip-bZt94k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:17 INFO - Running setup.py (path:/tmp/pip-tMDCwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:17 INFO - Running setup.py (path:/tmp/pip-UJK4fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:17 INFO - Running setup.py (path:/tmp/pip-7NbEl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:17 INFO - Running setup.py (path:/tmp/pip-NDkKpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:17 INFO - Running setup.py (path:/tmp/pip-P01eX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:17 INFO - Running setup.py (path:/tmp/pip-26L9Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:17 INFO - Running setup.py (path:/tmp/pip-pDHstW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:17 INFO - Running setup.py (path:/tmp/pip-SMcOMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:18 INFO - Running setup.py (path:/tmp/pip-HvxLdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:18 INFO - Running setup.py (path:/tmp/pip-oNf1Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:18 INFO - Running setup.py (path:/tmp/pip-vAoh1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:18 INFO - Running setup.py (path:/tmp/pip-DhgASp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:18 INFO - Running setup.py (path:/tmp/pip-4HnsTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:18 INFO - Running setup.py install for manifestparser 09:30:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Running setup.py install for mozcrash 09:30:18 INFO - Running setup.py install for mozdebug 09:30:18 INFO - Running setup.py install for mozdevice 09:30:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:18 INFO - Running setup.py install for mozfile 09:30:18 INFO - Running setup.py install for mozhttpd 09:30:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozinfo 09:30:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozInstall 09:30:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozleak 09:30:19 INFO - Running setup.py install for mozlog 09:30:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for moznetwork 09:30:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozprocess 09:30:19 INFO - Running setup.py install for mozprofile 09:30:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozrunner 09:30:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:19 INFO - Running setup.py install for mozscreenshot 09:30:19 INFO - Running setup.py install for moztest 09:30:20 INFO - Running setup.py install for mozversion 09:30:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:20 INFO - Cleaning up... 09:30:20 INFO - Return code: 0 09:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:20 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:20 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 09:30:20 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 09:30:20 INFO - Using env: {'DISPLAY': ':0', 09:30:20 INFO - 'HOME': '/home/cltbld', 09:30:20 INFO - 'LANG': 'en_US.UTF-8', 09:30:20 INFO - 'LANGUAGE': 'en_US:en', 09:30:20 INFO - 'LOGNAME': 'cltbld', 09:30:20 INFO - 'MAIL': '/var/mail/cltbld', 09:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:20 INFO - 'MOZ_NO_REMOTE': '1', 09:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:20 INFO - 'NO_EM_RESTART': '1', 09:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:20 INFO - 'PWD': '/builds/slave/test', 09:30:20 INFO - 'SHELL': '/bin/bash', 09:30:20 INFO - 'SHLVL': '1', 09:30:20 INFO - 'TERM': 'linux', 09:30:20 INFO - 'TMOUT': '86400', 09:30:20 INFO - 'USER': 'cltbld', 09:30:20 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:20 INFO - '_': '/tools/buildbot/bin/python'} 09:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:20 INFO - Running setup.py (path:/tmp/pip-BilIkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:20 INFO - Running setup.py (path:/tmp/pip-WJiNy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:20 INFO - Running setup.py (path:/tmp/pip-gZWmPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:20 INFO - Running setup.py (path:/tmp/pip-S5t6Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:20 INFO - Running setup.py (path:/tmp/pip-ORhFmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:20 INFO - Running setup.py (path:/tmp/pip-DrWiUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:20 INFO - Running setup.py (path:/tmp/pip-zxBIC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:20 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)) 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:20 INFO - Running setup.py (path:/tmp/pip-XBmEgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:21 INFO - Running setup.py (path:/tmp/pip-ERKNfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:21 INFO - Running setup.py (path:/tmp/pip-ho7e0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:21 INFO - Running setup.py (path:/tmp/pip-Mo1JhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:21 INFO - Running setup.py (path:/tmp/pip-Lgi80d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:21 INFO - Running setup.py (path:/tmp/pip-ZyEQ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:21 INFO - Running setup.py (path:/tmp/pip-KyI1Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:21 INFO - Running setup.py (path:/tmp/pip-ydDLxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:21 INFO - Running setup.py (path:/tmp/pip-7j8Vg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:21 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)) 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:21 INFO - Running setup.py (path:/tmp/pip-wa8hAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 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)) 09:30:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:23 INFO - Downloading blessings-1.6.tar.gz 09:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:23 INFO - Installing collected packages: blessings 09:30:23 INFO - Running setup.py install for blessings 09:30:23 INFO - Successfully installed blessings 09:30:23 INFO - Cleaning up... 09:30:23 INFO - Return code: 0 09:30:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:24 INFO - Reading from file tmpfile_stdout 09:30:24 INFO - Current package versions: 09:30:24 INFO - argparse == 1.2.1 09:30:24 INFO - blessings == 1.6 09:30:24 INFO - blobuploader == 1.2.4 09:30:24 INFO - docopt == 0.6.1 09:30:24 INFO - functools32 == 3.2.3-2 09:30:24 INFO - jsonschema == 2.5.1 09:30:24 INFO - manifestparser == 1.1 09:30:24 INFO - mozInstall == 1.12 09:30:24 INFO - mozcrash == 0.17 09:30:24 INFO - mozdebug == 0.1 09:30:24 INFO - mozdevice == 0.48 09:30:24 INFO - mozfile == 1.2 09:30:24 INFO - mozhttpd == 0.7 09:30:24 INFO - mozinfo == 0.9 09:30:24 INFO - mozleak == 0.1 09:30:24 INFO - mozlog == 3.2 09:30:24 INFO - moznetwork == 0.27 09:30:24 INFO - mozprocess == 0.22 09:30:24 INFO - mozprofile == 0.28 09:30:24 INFO - mozrunner == 6.11 09:30:24 INFO - mozscreenshot == 0.1 09:30:24 INFO - mozsystemmonitor == 0.3 09:30:24 INFO - moztest == 0.7 09:30:24 INFO - mozversion == 1.4 09:30:24 INFO - psutil == 3.1.1 09:30:24 INFO - requests == 1.2.3 09:30:24 INFO - wsgiref == 0.1.2 09:30:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:24 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 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30:24 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 09:30:24 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 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 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)) 09:30:24 INFO - Cleaning up... 09:30:24 INFO - Return code: 0 09:30:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30: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', 'jsonschema'] in /builds/slave/test/build 09:30: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 jsonschema 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:24 INFO - Cleaning up... 09:30:24 INFO - Return code: 0 09:30:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9566e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, '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': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', '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 09:30: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', 'flake8'] in /builds/slave/test/build 09:30: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 flake8 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 INFO - Downloading/unpacking flake8 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:30:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:30:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:30:27 INFO - no previously-included directories found matching 'docs/_build' 09:30:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:30:27 INFO - Running setup.py install for pep8 09:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:30:27 INFO - no previously-included directories found matching 'docs/_build' 09:30:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:30:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:30:27 INFO - Cleaning up... 09:30:27 INFO - Return code: 0 09:30:27 INFO - Running post-action listener: _resource_record_post_action 09:30:27 INFO - Running post-action listener: _start_resource_monitoring 09:30:27 INFO - Starting resource monitoring. 09:30:27 INFO - ##### 09:30:27 INFO - ##### Finished create-virtualenv step (success) 09:30:27 INFO - ##### 09:30:27 INFO - ##### 09:30:27 INFO - ##### Running install step. 09:30:27 INFO - ##### 09:30:27 INFO - Running pre-action listener: _resource_record_pre_action 09:30:27 INFO - Running main action method: install 09:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:27 INFO - Reading from file tmpfile_stdout 09:30:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:27 INFO - Reading from file tmpfile_stdout 09:30:27 INFO - Output received: 09:30:27 INFO - Usage: mozinstall [options] installer 09:30:27 INFO - Options: 09:30:27 INFO - -h, --help show this help message and exit 09:30:27 INFO - -d DEST, --destination=DEST 09:30:27 INFO - Directory to install application into. [default: 09:30:27 INFO - "/builds/slave/test"] 09:30:27 INFO - --app=APP Application being installed. [default: firefox] 09:30:27 INFO - mkdir: /builds/slave/test/build/application 09:30:27 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'] 09:30:27 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 09:30:43 INFO - Reading from file tmpfile_stdout 09:30:43 INFO - Output received: 09:30:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:43 INFO - Running post-action listener: _resource_record_post_action 09:30:43 INFO - ##### 09:30:43 INFO - ##### Finished install step (success) 09:30:43 INFO - ##### 09:30:43 INFO - ##### 09:30:43 INFO - ##### Running run-tests step. 09:30:43 INFO - ##### 09:30:43 INFO - Running pre-action listener: _resource_record_pre_action 09:30:43 INFO - Running main action method: run_tests 09:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:43 INFO - Python 2.7.3 09:30:43 INFO - Return code: 0 09:30:43 INFO - grabbing minidump binary from tooltool 09:30: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')]} 09:30:43 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 0x176d1c0>, '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 0x176e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:43 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 09:30:43 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 09:30:43 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 09:30:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:43 INFO - Return code: 0 09:30:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:30:44 INFO - Return code: 0 09:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:30:44 INFO - Using env: {'DISPLAY': ':0', 09:30:44 INFO - 'HOME': '/home/cltbld', 09:30:44 INFO - 'LANG': 'en_US.UTF-8', 09:30:44 INFO - 'LANGUAGE': 'en_US:en', 09:30:44 INFO - 'LOGNAME': 'cltbld', 09:30:44 INFO - 'MAIL': '/var/mail/cltbld', 09:30:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:44 INFO - 'MOZ_NO_REMOTE': '1', 09:30:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:44 INFO - 'NO_EM_RESTART': '1', 09:30:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:44 INFO - 'PWD': '/builds/slave/test', 09:30:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:44 INFO - 'SHELL': '/bin/bash', 09:30:44 INFO - 'SHLVL': '1', 09:30:44 INFO - 'TERM': 'linux', 09:30:44 INFO - 'TMOUT': '86400', 09:30:44 INFO - 'USER': 'cltbld', 09:30:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597', 09:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:44 INFO - '_': '/tools/buildbot/bin/python'} 09:30:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:30:45 INFO - mozversion application_buildid: 20160609090330 09:30:45 INFO - mozversion application_changeset: f4c18cbc1201927d52b23a97dad073a5617237bd 09:30:45 INFO - mozversion application_display_name: Nightly 09:30:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:45 INFO - mozversion application_name: Firefox 09:30:45 INFO - mozversion application_remotingname: firefox 09:30:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:30:45 INFO - mozversion application_vendor: Mozilla 09:30:45 INFO - mozversion application_version: 50.0a1 09:30:45 INFO - mozversion platform_buildid: 20160609090330 09:30:45 INFO - mozversion platform_changeset: f4c18cbc1201927d52b23a97dad073a5617237bd 09:30:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:30:45 INFO - mozversion platform_version: 50.0a1 09:30:45 INFO - using testdate: 1465489845 09:30:45 INFO - actual date: 1465489845 09:30:45 INFO - starting webserver on 'localhost:40380' 09:30:45 INFO - SUITE-START | Running 2 tests 09:30:45 INFO - TEST-START | dromaeo_css 09:30:45 INFO - operating with platform_type : linux_ 09:30:45 INFO - Initialising browser for dromaeo_css test... 09:30:45 INFO - TEST-INFO | started process 10892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMI08b/profile http://localhost:40380/getInfo.html) 09:30:49 INFO - PROCESS | 10892 | __metrics Screen width/height:1600/1200 09:30:49 INFO - PROCESS | 10892 | colorDepth:24 09:30:49 INFO - PROCESS | 10892 | Browser inner width/height: 1024/697 09:30:49 INFO - PROCESS | 10892 | __metrics 09:30:50 ERROR - PROCESS | 10892 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:30:50 INFO - PROCESS | 10892 | console.error: PushService: 09:30:50 INFO - PROCESS | 10892 | stateChangeProcessEnqueue: Error transitioning state 09:30:50 INFO - PROCESS | 10892 | UnknownError 09:30:51 INFO - TEST-INFO | 10892: exit 0 09:30:51 INFO - Browser initialized. 09:30:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:51 INFO - TEST-INFO | started process 10975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMI08b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:03 INFO - PROCESS | 10975 | RSS: Main: 174608384 09:31:03 INFO - PROCESS | 10975 | 09:31:54 INFO - PROCESS | 10975 | 1465489914647 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] 09:34:07 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40380/tests/dromaeo/cssquery-ext.html) 09:34:08 INFO - PROCESS | 10975 | RSS: Main: 249122816 09:34:08 INFO - PROCESS | 10975 | 09:37:10 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-ext.html (next: http://localhost:40380/tests/dromaeo/cssquery-jquery.html) 09:37:11 INFO - PROCESS | 10975 | RSS: Main: 258215936 09:37:11 INFO - PROCESS | 10975 | 09:40:13 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40380/tests/dromaeo/cssquery-mootools.html) 09:40:14 INFO - PROCESS | 10975 | RSS: Main: 253169664 09:40:14 INFO - PROCESS | 10975 | 09:43:16 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40380/tests/dromaeo/cssquery-prototype.html) 09:43:16 INFO - PROCESS | 10975 | RSS: Main: 254763008 09:43:16 INFO - PROCESS | 10975 | 09:46:19 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40380/tests/dromaeo/cssquery-yui.html) 09:46:20 INFO - PROCESS | 10975 | RSS: Main: 231211008 09:46:20 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | Cycle 1(1): loaded http://localhost:40380/tests/dromaeo/cssquery-yui.html (next: http://localhost:40380/tests/dromaeo/cssquery-dojo.html) 09:49:23 INFO - PROCESS | 10975 | RSS: Main: 290619392 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | __start_tp_report 09:49:23 INFO - PROCESS | 10975 | _x_x_mozilla_page_load 09:49:23 INFO - PROCESS | 10975 | _x_x_mozilla_page_load_details 09:49:23 INFO - PROCESS | 10975 | |i|pagename|runs| 09:49:23 INFO - PROCESS | 10975 | |0;dojo.html;2609.960850587241;2617.7120516743144;2648.1128821844686;2653.601959706044;2659.640948471957;4550.567696068876;4633.212353899837;4692.296155576665;4723.220668589687;4769.046190761844;4714.717116972984;4720.221163508026;4733.5739783419485;4781.497942716017;4790.832320868771;4287.528371879091;4292.957070429303;4367.432233809616;4393.340998850182;4465.330200469923;4358.869233922987;4395.296752519597;4412.911741765162;4417.624501917341;4444.644428445717;4175.102352994106;4226.3026600610865;4299.462567179103;4339.978300108479;4402.603765661074;4316.115196384733;4331.198728235287;4337.804798784062;4368.49762277339;4388.517263101056;4311.094670119279;4331.177076355482;4331.45856767904;4338.978305108486;4394.582514661102;4588.0365123324145;4612.86161415158;4656.534346565317;4657.347971284023;4707.223308154151;4941.715154059934;4981.327520784684;4998.050370429607;5000.249962505617;5004.8999020019755;4997.62517811162;5000.74996250186;5011.624128190364;5021.648484606079;5022.146235140035;4553.180427523078;4705.364775755229;4726.1020406122725;4734.857954261378;4768.783960090155;5215.87858610393;5223.9290945356115;5235.110031294689;5238.449962753933;5241.030409374202;4761.40482439695;5011.448740638527;5016.799328026911;5017.096922553902;5017.122003649347;4988.775505102279;5025.346704928409;5027;5040.924386134211;5055.7219352935945;4994.076095922266;5002.199648056367;5002.774875130628;5011.649184557046;5050.545450909436;4808.422989241313;4957.03337849116;4960.50394960501;4965.652404331662;5014.222795466709;4206.978965105155;4207.389928460356;4227.175700738388;4268.551802060739;4270.615644592001;3678.3562876496508;3700.3524383232825;3702.407614781622;3711.740178187555;3731.850725970931;4305.870823875289;4346.521882592912;4460.955390446119;4492.685512014193;4505.279155335131;5007.499250075036;5050.419201791841;5056;5058.494150584912;5060.822871199491;4386.210482113186;4395.208862404797;4416.53626369233;4417.955820441819;4455.22033644111;4366.847160349373;4492.281235002384;4498.347739577743;4515.503294637587;4527.660425468037;4793.760311984387;4820.4456487504385;4840.273958906192;4885.218365061573;4889.339939108175;5052.823151189691;5053.140966035856;5057;5062.417821950376;5107.974460127824;4454.732716037048;4759.857204283877;4767.785449654704;4769.451513076041;4819.542143496362;4955.6531042826655;4998.225275082368;5012.548870601663;5013.548780609763;5057.266696329085;5084.898302033865;5093.796248150033;5101.438841727481;5109.3613298337705;5147.974260128675;4710.670253082251;4877.097736918681;4909.852704418873;4943.456219815889;4945.23348880924;4910.410750709938;4934.5312195341385;4935;4935.383077115361;4970;4850.5149485052625;4859.708417494961;4880.6583539153335;4908.950910490849;4911.238757992517;4697.13103075932;4865.148598995091;4880.6095512358215;4909.459959404391;4996.575291100297;4807.7836497357;4807.903841923212;4815.903681926412;4816.133096042746;4868.634852386014 09:49:23 INFO - PROCESS | 10975 | |1;ext.html;553.3094166998841;576.0581449330347;576.2451188942483;583.5477504933676;588.7262422973316;28057.43885122299;28610.713892861066;30596.235094122658;40346.7982660087;41464.79267603658;42176.78911605437;42618.57381426185;42637;42667.57332426675;42733.35899961503;7782.961085194566;7911.8417631647335;7911.9604401978195;7915.96042019792;7916.564588947605;7812.3359514441345;7899.9210007899765;7911.129775724666;7921.287084162424;7922.168172341908;7903.525788452711;7927.40544459165;7943.20567943204;7947.96026019872;7948.046234451874;7834.412419068564;7879.172686867853;7890.0926393464915;7899.091604465502;7904.249096335839;7846.568438735867;7897.5656338901335;7901.446898717092;7906.6837326506875;7915.604219789045;39340.60659393398;39654.20691586152;39691.80154099211;39692.801535992425;39729;2710.715374885648;2725.7683096936785;2786.582012698091;2798.188525327673;2845.089571337173;29806.85096574525;29827.552586711216;30543.69456305431;30841.074767757003;31227.37545249105;3509.3507701075127;3532.1522834519787;3538.6992105671047;3546.3261980223674;3717.4609681596016;190129.04935475372;190753.04623476794;190755;191008;191249;50663;50835.237471437955;50935.23597145972;50983;50987.7450612752;32901.34197316088;33705.662943370255;33709.83145084259;35537;35572.82213588915;14987.700245995236;15220.923895380674;15224.543263702106;15273.236338183046;15279.541613751606;10786.298890572089;10822.458877056115;10864.239503234856;10866.891331086588;10873;18106.3662771805;18110.90944545295;18186.909065454587;18216.63566728658;18301.450956471326;6848.280930502226;7125.35871771543;7210.170830354471;7225.169105552929;7275.308845659654;797.6370751308141;856.6059612578284;867.280157469299;897.528797381367;925.9722208333761;27787;28056;28196.71803281982;28278.293042673686;28480.715192847805;946.5787724462685;956.9473678947586;963.7301555564453;1053.0943388685723;1078.1267173589417;14366.640833979234;14540.709185816224;14861.628459288388;15127.243637818065;15148.697026059417;400652;405774;407552;410246;411457;50583.49416505788;51047.489525104276;51189.232161517604;51227.48772512227;51233.48766512287;1090.7000574841823;1146.696125526736;1192.1297452859462;1205.1744554979866;1206.7224538356227;28341.858290708413;29314.7068529312;29600;29800.764942628957;30233.69766302397;41443.37834932418;41764.1647167061;42164.78917605392;42335.3649695261;42339.57660423356;313462;316560;316776;316887;317811;22279.443013924134;22870.199543015915;24640.137595184082;25198.748012520373;25214.74785252124;41854.58145418507;42322.576774231864;42565;43234;43370.78314608533;36328.63671363358;36371.560882593505;36581.26837463289;36588.634113658525;37102.44346334861;35656.4651530222;36315.45526817047;36471.45292820663;36473.63526364809;36633.45049824201;35913.82043089768;36223.818880905426;36299.81850090733;36375;36595.26809463849;31268.68731312658;32430.513542296412;32764.67235327616;32832.1791955203;32888.506672400414;24668.506629866944;25259.89385596955;25312;25581.616275755507;25799.484010320062 09:49:23 INFO - PROCESS | 10975 | |2;jquery.html;353.85845661735306;360.83040970743747;361.8190904547726;370.5183261759712;373.4827264239028;15826.920865395672;16136.19319034048;16847.157642117876;16858.7471187932;16863;16114.83885161151;16706.331746730117;16870.662586748258;17170.57073573158;17194.74207886883;4882.804687812483;5102.974485127569;5141.742912854361;5149.124648809692;5149.639525233235;3066.5706801047872;4890.608751299906;5630.943690563083;5955.583109182359;5960.403959604027;5959.612625179371;5964.821055368346;5983.252093488314;5995;6029.427204415595;5636.436356364372;5935.3471118177185;5938.732757025901;5942.970285148568;5946.108083787423;2800.747932686068;4816.975915120437;5142.177251639757;5145.228215767665;5155.226715992593;19914.701279480818;20128.899355503276;20181.697274540893;20337.491562710904;20338.898305508526;1826.8173182681626;1831.2217307644198;1911.4265720283859;1916.1664675866043;1940.0615262478827;9363.34456588039;9365.531723413871;9512.191463725592;11592.014678752315;12079.879201207963;1439.4673970630934;1456.9125852448888;1570.1756577796634;1582.185174635064;1618.8543031127138;59003.70498147482;67777;67948;68023;68089.65955170193;9513.14381705636;9710.223182145412;9725.513724313756;9765.658201962897;9928.305018648769;13601.115927464683;13691;13702.177869327672;13702.93148534271;13706;7416.666250018762;7434.293742094493;7550.471466997257;7634.50375725576;7671.961640191875;7315.817104572428;7321.231270716605;7343;7458.440616953751;7468.4025277977635;4337.978310108492;4363.956360436355;4397.36238245459;4415.911681766347;4418.248897687401;1684.713598688226;1704.2586474883465;1788.1416919878532;1824.297645406528;1826.844718198968;745.5414919824269;808.4704518540366;826.9669213231404;904.3714618340322;956.6077908057663;15365.846341536666;15884.364625415084;16272.267747951371;16596;17162.22769975354;808.6199486241458;876.0976194519527;887.8623813308948;902.6163880350824;903.3541018172039;9312.487813170204;9405.341626086109;9484.573194206278;9562.856557151648;9705.417674939526;364952;375950;376447;376728;376971;74421.62789186019;86948;88766.55616721875;90539;91924.54037729769;933.0669330669331;961.9615215391445;967.3567077893263;972.5866506734609;989.7871957529165;15563.76654350163;15645.921770391531;15764.448244311394;15819.920900395424;15935.920320398323;38353.42469862899;38743.612563874;38800.22399552049;39414;39802.004949876486;53506.46493535015;55302.958337291835;55422;55686.16470753023;56625.43374566202;4873.028481787332;4904.877378065434;7124.536905101152;7646.732364367221;7824.882626760489;10304;11353.716157096138;11787.057035436974;11873.82189267179;12086.818697719365;9485.146336829719;9681.225501959685;9872.753181170528;9902.702918912444;9941.900580994097;5903.848749493979;8631.6978905738;10486.632967846088;10632.096271816983;10637.840432393365;9154.450732956044;9936.012797440397;10090.293679442368;10223.948880255848;10324.122449591569;7462;7667.69329226847;7671.156172821097;7795.4543181976715;7847.9607601961625;9820.263480238867;10146.949265253626;10217.693469195936;10361.11930485887;10407.271490995558 09:49:23 INFO - PROCESS | 10975 | |3;mootools.html;1219.110049663746;1377.9379927903246;1412.5409241996351;1494.9925250373747;1711.9743203851936;6638.468922486201;7525.849483010336;7828.590853646341;7852.764417067483;8027;7748.767536973885;7762.844743105149;7810.726624568141;7861.135275119746;7870.409719271049;2159.0608085482786;2183.683365911942;2190.9561808763815;2191.693162957179;2201.9449513762206;2095.8428117891144;2129.7550781660075;2200.262911924507;2201.2625770366867;2202.0641227478336;2140.4327853118934;2153.849230553862;2170.4899348653053;2176.619091658961;2189.704389907358;2024.6456870047757;2027.7566691996908;2028.8376929845724;2029.1984666056899;2031.7561892572912;2113.7357830271217;2169.034779523113;2169.7721739217313;2174.804267615922;2176.7605563388015;7445.664945077485;7883.36933045355;7967.840643187162;7990.600469976478;8009.038915330139;4442.133783912139;4530.75080870552;4548.613367863735;4552.954470455286;4576.633869290449;2676.330917270682;2737.178846346088;2763.557830747091;2797.9720202797916;2834.576437146231;892.5849479991834;898.6764764684708;908.3142227618106;912.0605776050678;913.9177474027302;10636.946815265952;10721.35671859691;10758.784824303548;10772.622958196504;10788.244822862403;3998.1803730235233;4076.7961601919787;4141.91716165681;4148.979255103705;4158.066499077943;8556.443831150955;8565.743027709179;8609.440386374865;8626.094260102724;8654;4595.609373203249;4619.260918253063;4643.071385722869;4650.465196502446;4651.558101980307;3468.8612455502002;4106;4275.978620106879;4287.249731297011;4290.313549832012;3387.6442973487924;3412.8805491807666;3501.1947252132154;3509.666581674737;3514.8066856322635;1000.4397537379091;1000.6397696829281;1003;1025.5077562769911;1035.2287545778443;673.2291526202471;715.7137145141985;794.5907857453416;819.663937785517;821.3347188776991;5034.974825125851;5164.56101231392;5173.586113111018;5212.9739351303;5506.146547285177;852.4235522940544;890.8708237305555;920.1283023732037;935.1863878425677;946.621351459408;3380.695737383647;3440.1915549845767;3480.80855552947;3570.2145527983803;3650.5984341722387;9357.812843743088;9542.188913942255;9580.520973951274;9596.136347728598;9622.182114520205;9046.773830654154;9438.528073596293;9467.337286389886;9492.90507094934;9633.807323853624;7284.344409003215;7396.519226250384;7451.254874512505;7481.027466429329;7508.662110205054;5083.491650834887;5231.712255825966;5306.204069389468;5321.946780532146;5355.812546560852;8578.313734901318;8679.869801953102;8894.377393582647;8950.597223124845;9050.728478145666;8394.118617545315;8993.730188094367;9043.547822608974;9063.093690630883;9150.862737059082;7127.2516385778745;7320.304571065741;7340.779776606711;7434.107907050972;7459.888101678588;7045.859082818418;7313.561186328625;7330.120385553554;7369.668364923698;7412.444066695128;5547.528460080777;6247.562670613013;6781.42357899584;6841.418479429304;6926;6427.421532062137;6510.5117116217425;6664.466842652673;6752.122224111031;6824.283450237654;5942.435468630473;6076.54425918049;6078.057901025348;6102.206713127265;6102.908456373247;4328.978355108205;4372.80322385487;4384.05742765307;4519.186546421675;4548.295014272793;4447.621952133975;4553.2259515881715;4585.747783871919;4587.564181402761;4596.4024676791805 09:49:23 INFO - PROCESS | 10975 | |4;prototype.html;286.8637397236312;286.9354395261067;295.2117845352907;297.95828583998247;298.4285094044904;4703.05938812238;4706.458757242914;4721.527847215277;4748.620110391169;4752.382190315258;4642.930356044662;4671.743054132022;4674.6494012949;4689.226277664181;4708.152532544141;3477.1828620274277;3568.964310356902;3586.2289607734333;3655.4882316475714;3703.4446232099763;3681.0245284999496;3706.314331848617;3715.7213209009296;3719.1260053887313;3723;3486.779627130497;3675.117971686789;3676.724245681571;3682.1346983458866;3685.0050486368664;3520.5775306963073;3608.1160115771804;3609.3322735294055;3643.143861192618;3648.5986541480415;3177.6663450337614;3194.37709646619;3216.5979252593424;3218.8229647369385;3230.4185246655593;4564.995700945787;4584.4957054723955;4622.352870598119;4643.791029403685;4658.627309815207;4040.474738284004;4217.135487225111;4232.788360581959;4233;4242.893927651802;4916.287138364917;4940.48124946879;4941.357623508957;4955.207166853323;4960.553550180501;3598.6581274778855;3610.855565777366;3617.963820361815;3618.2763447310645;3627.5828279747902;4992.956098823689;5160.819371321985;5198.324217851655;5201.141811601081;5220.034293655686;3630.146915474861;3662.7252956028406;3664.5052917855746;3673.8897833065053;3674.6141655125825;3636.9634654123447;3667.651573100551;3733.9544927420366;3734.79458629778;3744.8876533704033;4202.495700515897;4205.642520385802;4205.789710514462;4207.853994462846;4226.11937687726;4790.952090479121;4908.582770464551;4917.385326834145;4926.1379258629595;4936.160852655057;1290.7741145299535;1299.9805002924963;1303.4590644882267;1305.8965174427594;1307.2287350463273;839.8278352937633;842.5071333270106;888.595688961521;891.3893982621795;898.1512470715242;4368.825246990084;4386.407834942306;4417.160739459492;4434.312681534368;4463.933041004388;5023.773930173078;5027.340977477424;5042.949570504321;5051.1413059779925;5083.186690129562;4199.853005144805;4358.738475691469;4392.736435813861;4419.1824512464655;4428.158649856581;2705.850013744151;2713.782897368206;2717.6874659414025;2719.2386131883104;2725.8909643614033;4747.548982846624;4828.130936431406;4831.613470922318;4839.669090999932;4872.878178045577;4936.259561065797;5135.101357262464;5168.2764412982215;5181.171012638035;5254.737263136828;4821.349117869113;4873.244647079709;4881.560659540658;4896.36347274852;4901;5134.820281290137;5152.046871328816;5176.1200595899545;5179.378474583074;5187.844364669066;4845.370101886732;5005.7997680092385;5012.573931215742;5054.974725126351;5067.189249720027;4842.201036829025;4855.611551075976;4868.488808675038;4877.707337559757;4879.829205977774;3593.6406359363855;3610.6028336883446;3619.1856832212543;3619.9276014480088;3630.2376500935097;4978.800847966041;5145.176771716508;5215.16557350822;5217.121836138911;5218.504242096995;4910.091633047898;4984.728894131973;4993.675411098267;5000.874978125576;5004.199328107631;4953.851384458472;4970.155073637563;4985.8781774100535;5010.248462730619;5035.093683137071;4629.213033784197;4941.135301322326;4944.48082951285;4953.405591329064;4959.628027897994;4793.640476964311;4888.608911287018;4973.676711013773;4992.675476094042;5014.924776128434;4882.145624515624;4886.315915771866;4917.950820491749;4929.852104436873;4955.950440495549 09:49:23 INFO - PROCESS | 10975 | |5;yui.html;558.5057224356444;563.3718403979564;571.2373980735717;607.8632307730761;611.9877602447951;10636.787264254719;11358.091352691785;11397.601083962063;11412.144089193313;11412.258203216785;11361.659150225485;12346.135770496068;12355.629331120059;12357.073219508527;12362.320072396014;615.796787060269;758.3743411685354;784.6233807772259;791.8099656082527;797.6171437709903;769.5459678789513;771.6488997506121;773.5938632218074;781.2148790465602;781.4881252779438;809.7975506123469;811.8416908702806;812.5368539932241;812.9796755081111;813.2802469814227;631.1574048645041;788.2984144111745;802.506458528004;802.7671975127206;814.2468216899344;593.2080672302482;597.6354423801478;598.1327075740151;599.379642070455;600.7356763024255;10713.517891694892;10722.195835312383;10747.08649764771;10750.838737418944;10753.946230268877;12335.568255111119;12722.6463104326;12827.102102852805;13187.472501099945;13207.075504714674;10722.678319650424;10793.83809242862;10901.83647245292;11058.778824423547;11357.716057098556;4137.565555616678;4153.833846646131;4206.684498662582;4256.063665993476;4348;58773;58804;58883;58916.70541647307;58988.99999999957;8876.733697989072;9172.6789562365;9269.768255793659;9709.611615535441;10034.197264218845;17647;17968.640627187382;17979.820201798077;17996.560275178217;18018.639627207645;6175.62946223228;6180.81457556274;6296.779612713624;6361.650109244036;6544.345565443513;3305.438075527118;3420.521127042216;3421.6749408806622;3612.2956023575152;3621.4748861414946;2562.1160699558623;2638.14260365382;2646.5236257473452;2647.880845361963;2702.9459410811673;465.80901830249434;467.3783867456275;470.35796138271013;476.1239319651857;477.28883962895037;452.11836918009357;482.5102520941247;492.9580985616191;494.7278996551882;495.26205953130295;6455.225372955276;6471.417572418411;6498.285188629247;6513.055606937062;6601.141851559267;438.3184148648818;458.6995517935757;477.8924741933037;486.72986492496295;488.819136919335;3079.168624471425;3098.4422803895513;3107.1610665120293;3115.797473164237;3130.483470227387;70080.2991970084;73616;73813;90293;92879;46942.5305746945;66464.66767666131;77965;78307.21692783;79688;55484.72257638686;71337.2866271341;72569.6371518139;72808.63595682093;73540.11679065663;7251.166115896739;7313.561186328838;7407.814804629712;7447.069116360455;7464.92535074664;43691;43713;44907.326390103524;45145.097098057195;45164.32253516265;52021.47978520166;60698;60960.69519652551;61529;61812.69093654503;9838.65564705232;9981.351212171186;10743.140548755924;10924.508397122308;10975.560977560808;11136.610218642309;11147.554097835995;11337.829932551183;11498.425078746197;11628.476718547516;10017.298789084985;10146.289759716748;10150.89849101529;10459.424731639832;10575.048245657928;10942.069924056545;11124.288661437571;11236.438178091226;11300.660980170607;11338.206325557132;11100.5559777608;11326.263792853439;11373.886261137282;12000.219985700902;12005.39973001364;9129.45223286605;9171.908280917372;9265.907340926504;9430.292728045286;9730.805383892424;8892.73321800347;9109.77225569366;9124.315676324435;9131.223845973167;9316 09:49:23 INFO - PROCESS | 10975 | __end_tp_report 09:49:23 INFO - PROCESS | 10975 | __start_cc_report 09:49:23 INFO - PROCESS | 10975 | _x_x_mozilla_cycle_collect,1016 09:49:23 INFO - PROCESS | 10975 | __end_cc_report 09:49:23 INFO - PROCESS | 10975 | __startTimestamp1465490963662__endTimestamp 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | ------- Summary: start ------- 09:49:23 INFO - PROCESS | 10975 | Number of tests: 6 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#0] dojo.html Cycles:165 Average:4659.26 Median:4793.76 stddev:488.56 (10.2%) stddev-sans-first:462.85 09:49:23 INFO - PROCESS | 10975 | Values: 2610.0 2617.7 2648.1 2653.6 2659.6 4550.6 4633.2 4692.3 4723.2 4769.0 4714.7 4720.2 4733.6 4781.5 4790.8 4287.5 4293.0 4367.4 4393.3 4465.3 4358.9 4395.3 4412.9 4417.6 4444.6 4175.1 4226.3 4299.5 4340.0 4402.6 4316.1 4331.2 4337.8 4368.5 4388.5 4311.1 4331.2 4331.5 4339.0 4394.6 4588.0 4612.9 4656.5 4657.3 4707.2 4941.7 4981.3 4998.1 5000.2 5004.9 4997.6 5000.7 5011.6 5021.6 5022.1 4553.2 4705.4 4726.1 4734.9 4768.8 5215.9 5223.9 5235.1 5238.4 5241.0 4761.4 5011.4 5016.8 5017.1 5017.1 4988.8 5025.3 5027.0 5040.9 5055.7 4994.1 5002.2 5002.8 5011.6 5050.5 4808.4 4957.0 4960.5 4965.7 5014.2 4207.0 4207.4 4227.2 4268.6 4270.6 3678.4 3700.4 3702.4 3711.7 3731.9 4305.9 4346.5 4461.0 4492.7 4505.3 5007.5 5050.4 5056.0 5058.5 5060.8 4386.2 4395.2 4416.5 4418.0 4455.2 4366.8 4492.3 4498.3 4515.5 4527.7 4793.8 4820.4 4840.3 4885.2 4889.3 5052.8 5053.1 5057.0 5062.4 5108.0 4454.7 4759.9 4767.8 4769.5 4819.5 4955.7 4998.2 5012.5 5013.5 5057.3 5084.9 5093.8 5101.4 5109.4 5148.0 4710.7 4877.1 4909.9 4943.5 4945.2 4910.4 4934.5 4935.0 4935.4 4970.0 4850.5 4859.7 4880.7 4909.0 4911.2 4697.1 4865.1 4880.6 4909.5 4996.6 4807.8 4807.9 4815.9 4816.1 4868.6 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#1] ext.html Cycles:180 Average:45716.37 Median:36373.28 stddev:83835.86 (230.5%) stddev-sans-first:84002.46 09:49:23 INFO - PROCESS | 10975 | Values: 553.3 576.1 576.2 583.5 588.7 28057.4 28610.7 30596.2 40346.8 41464.8 42176.8 42618.6 42637.0 42667.6 42733.4 7783.0 7911.8 7912.0 7916.0 7916.6 7812.3 7899.9 7911.1 7921.3 7922.2 7903.5 7927.4 7943.2 7948.0 7948.0 7834.4 7879.2 7890.1 7899.1 7904.2 7846.6 7897.6 7901.4 7906.7 7915.6 39340.6 39654.2 39691.8 39692.8 39729.0 2710.7 2725.8 2786.6 2798.2 2845.1 29806.9 29827.6 30543.7 30841.1 31227.4 3509.4 3532.2 3538.7 3546.3 3717.5 190129.0 190753.0 190755.0 191008.0 191249.0 50663.0 50835.2 50935.2 50983.0 50987.7 32901.3 33705.7 33709.8 35537.0 35572.8 14987.7 15220.9 15224.5 15273.2 15279.5 10786.3 10822.5 10864.2 10866.9 10873.0 18106.4 18110.9 18186.9 18216.6 18301.5 6848.3 7125.4 7210.2 7225.2 7275.3 797.6 856.6 867.3 897.5 926.0 27787.0 28056.0 28196.7 28278.3 28480.7 946.6 956.9 963.7 1053.1 1078.1 14366.6 14540.7 14861.6 15127.2 15148.7 400652.0 405774.0 407552.0 410246.0 411457.0 50583.5 51047.5 51189.2 51227.5 51233.5 1090.7 1146.7 1192.1 1205.2 1206.7 28341.9 29314.7 29600.0 29800.8 30233.7 41443.4 41764.2 42164.8 42335.4 42339.6 313462.0 316560.0 316776.0 316887.0 317811.0 22279.4 22870.2 24640.1 25198.7 25214.7 41854.6 42322.6 42565.0 43234.0 43370.8 36328.6 36371.6 36581.3 36588.6 37102.4 35656.5 36315.5 36471.5 36473.6 36633.5 35913.8 36223.8 36299.8 36375.0 36595.3 31268.7 32430.5 32764.7 32832.2 32888.5 24668.5 25259.9 25312.0 25581.6 25799.5 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#2] jquery.html Cycles:180 Average:24140.09 Median:5141.96 stddev:62185.95 (1209.4%) stddev-sans-first:62334.75 09:49:23 INFO - PROCESS | 10975 | Values: 353.9 360.8 361.8 370.5 373.5 15826.9 16136.2 16847.2 16858.7 16863.0 16114.8 16706.3 16870.7 17170.6 17194.7 4882.8 5103.0 5141.7 5149.1 5149.6 3066.6 4890.6 5630.9 5955.6 5960.4 5959.6 5964.8 5983.3 5995.0 6029.4 5636.4 5935.3 5938.7 5943.0 5946.1 2800.7 4817.0 5142.2 5145.2 5155.2 19914.7 20128.9 20181.7 20337.5 20338.9 1826.8 1831.2 1911.4 1916.2 1940.1 9363.3 9365.5 9512.2 11592.0 12079.9 1439.5 1456.9 1570.2 1582.2 1618.9 59003.7 67777.0 67948.0 68023.0 68089.7 9513.1 9710.2 9725.5 9765.7 9928.3 13601.1 13691.0 13702.2 13702.9 13706.0 7416.7 7434.3 7550.5 7634.5 7672.0 7315.8 7321.2 7343.0 7458.4 7468.4 4338.0 4364.0 4397.4 4415.9 4418.2 1684.7 1704.3 1788.1 1824.3 1826.8 745.5 808.5 827.0 904.4 956.6 15365.8 15884.4 16272.3 16596.0 17162.2 808.6 876.1 887.9 902.6 903.4 9312.5 9405.3 9484.6 9562.9 9705.4 364952.0 375950.0 376447.0 376728.0 376971.0 74421.6 86948.0 88766.6 90539.0 91924.5 933.1 962.0 967.4 972.6 989.8 15563.8 15645.9 15764.4 15819.9 15935.9 38353.4 38743.6 38800.2 39414.0 39802.0 53506.5 55303.0 55422.0 55686.2 56625.4 4873.0 4904.9 7124.5 7646.7 7824.9 10304.0 11353.7 11787.1 11873.8 12086.8 9485.1 9681.2 9872.8 9902.7 9941.9 5903.8 8631.7 10486.6 10632.1 10637.8 9154.5 9936.0 10090.3 10223.9 10324.1 7462.0 7667.7 7671.2 7795.5 7848.0 9820.3 10146.9 10217.7 10361.1 10407.3 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#3] mootools.html Cycles:180 Average:5077.99 Median:5268.96 stddev:2871.61 (54.5%) stddev-sans-first:2865.03 09:49:23 INFO - PROCESS | 10975 | Values: 1219.1 1377.9 1412.5 1495.0 1712.0 6638.5 7525.8 7828.6 7852.8 8027.0 7748.8 7762.8 7810.7 7861.1 7870.4 2159.1 2183.7 2191.0 2191.7 2201.9 2095.8 2129.8 2200.3 2201.3 2202.1 2140.4 2153.8 2170.5 2176.6 2189.7 2024.6 2027.8 2028.8 2029.2 2031.8 2113.7 2169.0 2169.8 2174.8 2176.8 7445.7 7883.4 7967.8 7990.6 8009.0 4442.1 4530.8 4548.6 4553.0 4576.6 2676.3 2737.2 2763.6 2798.0 2834.6 892.6 898.7 908.3 912.1 913.9 10636.9 10721.4 10758.8 10772.6 10788.2 3998.2 4076.8 4141.9 4149.0 4158.1 8556.4 8565.7 8609.4 8626.1 8654.0 4595.6 4619.3 4643.1 4650.5 4651.6 3468.9 4106.0 4276.0 4287.2 4290.3 3387.6 3412.9 3501.2 3509.7 3514.8 1000.4 1000.6 1003.0 1025.5 1035.2 673.2 715.7 794.6 819.7 821.3 5035.0 5164.6 5173.6 5213.0 5506.1 852.4 890.9 920.1 935.2 946.6 3380.7 3440.2 3480.8 3570.2 3650.6 9357.8 9542.2 9580.5 9596.1 9622.2 9046.8 9438.5 9467.3 9492.9 9633.8 7284.3 7396.5 7451.3 7481.0 7508.7 5083.5 5231.7 5306.2 5321.9 5355.8 8578.3 8679.9 8894.4 8950.6 9050.7 8394.1 8993.7 9043.5 9063.1 9150.9 7127.3 7320.3 7340.8 7434.1 7459.9 7045.9 7313.6 7330.1 7369.7 7412.4 5547.5 6247.6 6781.4 6841.4 6926.0 6427.4 6510.5 6664.5 6752.1 6824.3 5942.4 6076.5 6078.1 6102.2 6102.9 4329.0 4372.8 4384.1 4519.2 4548.3 4447.6 4553.2 4585.7 4587.6 4596.4 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#4] prototype.html Cycles:180 Average:4124.80 Median:4704.76 stddev:1194.90 (25.4%) stddev-sans-first:1163.01 09:49:23 INFO - PROCESS | 10975 | Values: 286.9 286.9 295.2 298.0 298.4 4703.1 4706.5 4721.5 4748.6 4752.4 4642.9 4671.7 4674.6 4689.2 4708.2 3477.2 3569.0 3586.2 3655.5 3703.4 3681.0 3706.3 3715.7 3719.1 3723.0 3486.8 3675.1 3676.7 3682.1 3685.0 3520.6 3608.1 3609.3 3643.1 3648.6 3177.7 3194.4 3216.6 3218.8 3230.4 4565.0 4584.5 4622.4 4643.8 4658.6 4040.5 4217.1 4232.8 4233.0 4242.9 4916.3 4940.5 4941.4 4955.2 4960.6 3598.7 3610.9 3618.0 3618.3 3627.6 4993.0 5160.8 5198.3 5201.1 5220.0 3630.1 3662.7 3664.5 3673.9 3674.6 3637.0 3667.7 3734.0 3734.8 3744.9 4202.5 4205.6 4205.8 4207.9 4226.1 4791.0 4908.6 4917.4 4926.1 4936.2 1290.8 1300.0 1303.5 1305.9 1307.2 839.8 842.5 888.6 891.4 898.2 4368.8 4386.4 4417.2 4434.3 4463.9 5023.8 5027.3 5042.9 5051.1 5083.2 4199.9 4358.7 4392.7 4419.2 4428.2 2705.9 2713.8 2717.7 2719.2 2725.9 4747.5 4828.1 4831.6 4839.7 4872.9 4936.3 5135.1 5168.3 5181.2 5254.7 4821.3 4873.2 4881.6 4896.4 4901.0 5134.8 5152.0 5176.1 5179.4 5187.8 4845.4 5005.8 5012.6 5055.0 5067.2 4842.2 4855.6 4868.5 4877.7 4879.8 3593.6 3610.6 3619.2 3619.9 3630.2 4978.8 5145.2 5215.2 5217.1 5218.5 4910.1 4984.7 4993.7 5000.9 5004.2 4953.9 4970.2 4985.9 5010.2 5035.1 4629.2 4941.1 4944.5 4953.4 4959.6 4793.6 4888.6 4973.7 4992.7 5014.9 4882.1 4886.3 4918.0 4929.9 4956.0 09:49:23 INFO - PROCESS | 10975 | 09:49:23 INFO - PROCESS | 10975 | [#5] yui.html Cycles:180 Average:16109.07 Median:487.77 stddev:22468.32 (4606.3%) stddev-sans-first:22501.01 09:49:23 INFO - PROCESS | 10975 | Values: 558.5 563.4 571.2 607.9 612.0 10636.8 11358.1 11397.6 11412.1 11412.3 11361.7 12346.1 12355.6 12357.1 12362.3 615.8 758.4 784.6 791.8 797.6 769.5 771.6 773.6 781.2 781.5 809.8 811.8 812.5 813.0 813.3 631.2 788.3 802.5 802.8 814.2 593.2 597.6 598.1 599.4 600.7 10713.5 10722.2 10747.1 10750.8 10753.9 12335.6 12722.6 12827.1 13187.5 13207.1 10722.7 10793.8 10901.8 11058.8 11357.7 4137.6 4153.8 4206.7 4256.1 4348.0 58773.0 58804.0 58883.0 58916.7 58989.0 8876.7 9172.7 9269.8 9709.6 10034.2 17647.0 17968.6 17979.8 17996.6 18018.6 6175.6 6180.8 6296.8 6361.7 6544.3 3305.4 3420.5 3421.7 3612.3 3621.5 2562.1 2638.1 2646.5 2647.9 2702.9 465.8 467.4 470.4 476.1 477.3 452.1 482.5 493.0 494.7 495.3 6455.2 6471.4 6498.3 6513.1 6601.1 438.3 458.7 477.9 486.7 488.8 3079.2 3098.4 3107.2 3115.8 3130.5 70080.3 73616.0 73813.0 90293.0 92879.0 46942.5 66464.7 77965.0 78307.2 79688.0 55484.7 71337.3 72569.6 72808.6 73540.1 7251.2 7313.6 7407.8 7447.1 7464.9 43691.0 43713.0 44907.3 45145.1 45164.3 52021.5 60698.0 60960.7 61529.0 61812.7 9838.7 9981.4 10743.1 10924.5 10975.6 11136.6 11147.6 11337.8 11498.4 11628.5 10017.3 10146.3 10150.9 10459.4 10575.0 10942.1 11124.3 11236.4 11300.7 11338.2 11100.6 11326.3 11373.9 12000.2 12005.4 9129.5 9171.9 9265.9 9430.3 9730.8 8892.7 9109.8 9124.3 9131.2 9316.0 09:49:23 INFO - PROCESS | 10975 | -------- Summary: end -------- 09:49:23 INFO - PROCESS | 10975 | 09:49:24 INFO - TEST-INFO | 10975: exit 0 09:49:24 INFO - TEST-OK | dromaeo_css | took 1119354ms 09:49:24 INFO - TEST-START | kraken 09:49:24 INFO - operating with platform_type : linux_ 09:49:24 INFO - Initialising browser for kraken test... 09:49:24 INFO - TEST-INFO | started process 11160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOHvev/profile http://localhost:40380/getInfo.html) 09:49:28 INFO - PROCESS | 11160 | __metrics Screen width/height:1600/1200 09:49:28 INFO - PROCESS | 11160 | colorDepth:24 09:49:28 INFO - PROCESS | 11160 | Browser inner width/height: 1024/697 09:49:28 INFO - PROCESS | 11160 | __metrics 09:49:29 ERROR - PROCESS | 11160 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:49:30 INFO - PROCESS | 11160 | console.error: PushService: 09:49:30 INFO - PROCESS | 11160 | stateChangeProcessEnqueue: Error transitioning state 09:49:30 INFO - PROCESS | 11160 | UnknownError 09:49:30 INFO - TEST-INFO | 11160: exit 0 09:49:30 INFO - Browser initialized. 09:49:30 INFO - Running cycle 1/1 for kraken test... 09:49:30 INFO - TEST-INFO | started process 11238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOHvev/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:43 INFO - PROCESS | 11238 | RSS: Main: 174878720 09:49:43 INFO - PROCESS | 11238 | 09:49:45 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40380/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:46 INFO - PROCESS | 11238 | RSS: Main: 232103936 09:49:46 INFO - PROCESS | 11238 | 09:49:49 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40380/tests/kraken/driver.html?testName=audio-dft) 09:49:50 INFO - PROCESS | 11238 | RSS: Main: 219422720 09:49:50 INFO - PROCESS | 11238 | 09:49:53 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40380/tests/kraken/driver.html?testName=audio-fft) 09:49:54 INFO - PROCESS | 11238 | RSS: Main: 287944704 09:49:54 INFO - PROCESS | 11238 | 09:49:56 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40380/tests/kraken/driver.html?testName=audio-oscillator) 09:49:56 INFO - PROCESS | 11238 | RSS: Main: 197779456 09:49:56 INFO - PROCESS | 11238 | 09:49:59 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:59 INFO - PROCESS | 11238 | RSS: Main: 201412608 09:49:59 INFO - PROCESS | 11238 | 09:50:02 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40380/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:03 INFO - PROCESS | 11238 | RSS: Main: 237912064 09:50:03 INFO - PROCESS | 11238 | 09:50:07 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40380/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:07 INFO - PROCESS | 11238 | RSS: Main: 233189376 09:50:07 INFO - PROCESS | 11238 | 09:50:10 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40380/tests/kraken/driver.html?testName=json-parse-financial) 09:50:11 INFO - PROCESS | 11238 | RSS: Main: 236101632 09:50:11 INFO - PROCESS | 11238 | 09:50:12 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:13 INFO - PROCESS | 11238 | RSS: Main: 223399936 09:50:13 INFO - PROCESS | 11238 | 09:50:15 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:16 INFO - PROCESS | 11238 | RSS: Main: 225972224 09:50:16 INFO - PROCESS | 11238 | 09:50:18 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:19 INFO - PROCESS | 11238 | RSS: Main: 234729472 09:50:19 INFO - PROCESS | 11238 | 09:50:21 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:22 INFO - PROCESS | 11238 | RSS: Main: 240308224 09:50:22 INFO - PROCESS | 11238 | 09:50:25 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:25 INFO - PROCESS | 11238 | RSS: Main: 238391296 09:50:25 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | Cycle 1(1): loaded http://localhost:40380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40380/tests/kraken/driver.html?testName=ai-astar) 09:50:27 INFO - PROCESS | 11238 | RSS: Main: 281350144 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | __start_tp_report 09:50:27 INFO - PROCESS | 11238 | _x_x_mozilla_page_load 09:50:27 INFO - PROCESS | 11238 | _x_x_mozilla_page_load_details 09:50:27 INFO - PROCESS | 11238 | |i|pagename|runs| 09:50:27 INFO - PROCESS | 11238 | |0;ai-astar;114;107;114;115;113;115;111;112;113;113 09:50:27 INFO - PROCESS | 11238 | |1;audio-beat-detection;156;133;138;195;139;132;155;130;184;130 09:50:27 INFO - PROCESS | 11238 | |2;audio-dft;162;161;161;161;162;162;161;160;161;159 09:50:27 INFO - PROCESS | 11238 | |3;audio-fft;75;78;76;116;75;77;74;74;101;76 09:50:27 INFO - PROCESS | 11238 | |4;audio-oscillator;87;87;116;86;87;87;113;87;86;131 09:50:27 INFO - PROCESS | 11238 | |5;imaging-gaussian-blur;117;116;116;117;118;116;116;116;116;117 09:50:27 INFO - PROCESS | 11238 | |6;imaging-darkroom;147;148;147;147;150;147;147;147;147;147 09:50:27 INFO - PROCESS | 11238 | |7;imaging-desaturate;96;94;95;95;95;96;95;95;95;94 09:50:27 INFO - PROCESS | 11238 | |8;json-parse-financial;62;63;63;63;64;63;63;63;63;63 09:50:27 INFO - PROCESS | 11238 | |9;json-stringify-tinderbox;65;65;65;68;65;65;74;65;64;64 09:50:27 INFO - PROCESS | 11238 | |10;stanford-crypto-aes;82;83;83;83;84;84;86;85;126;88 09:50:27 INFO - PROCESS | 11238 | |11;stanford-crypto-ccm;142;137;140;128;130;147;142;131;148;147 09:50:27 INFO - PROCESS | 11238 | |12;stanford-crypto-pbkdf2;170;168;167;172;168;170;169;166;170;168 09:50:27 INFO - PROCESS | 11238 | |13;stanford-crypto-sha256-iterative;68;72;67;67;66;66;70;65;65;66 09:50:27 INFO - PROCESS | 11238 | __end_tp_report 09:50:27 INFO - PROCESS | 11238 | __start_cc_report 09:50:27 INFO - PROCESS | 11238 | _x_x_mozilla_cycle_collect,1884 09:50:27 INFO - PROCESS | 11238 | __end_cc_report 09:50:27 INFO - PROCESS | 11238 | __startTimestamp1465491027921__endTimestamp 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | ------- Summary: start ------- 09:50:27 INFO - PROCESS | 11238 | Number of tests: 14 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:2.36 (2.1%) stddev-sans-first:2.46 09:50:27 INFO - PROCESS | 11238 | Values: 114.0 107.0 114.0 115.0 113.0 115.0 111.0 112.0 113.0 113.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:147.00 stddev:23.37 (15.9%) stddev-sans-first:24.65 09:50:27 INFO - PROCESS | 11238 | Values: 156.0 133.0 138.0 195.0 139.0 132.0 155.0 130.0 184.0 130.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 09:50:27 INFO - PROCESS | 11238 | Values: 162.0 161.0 161.0 161.0 162.0 162.0 161.0 160.0 161.0 159.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:14.36 (19.0%) stddev-sans-first:14.99 09:50:27 INFO - PROCESS | 11238 | Values: 75.0 78.0 76.0 116.0 75.0 77.0 74.0 74.0 101.0 76.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:87.00 stddev:16.71 (19.2%) stddev-sans-first:17.35 09:50:27 INFO - PROCESS | 11238 | Values: 87.0 87.0 116.0 86.0 87.0 87.0 113.0 87.0 86.0 131.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 09:50:27 INFO - PROCESS | 11238 | Values: 117.0 116.0 116.0 117.0 118.0 116.0 116.0 116.0 116.0 117.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 09:50:27 INFO - PROCESS | 11238 | Values: 147.0 148.0 147.0 147.0 150.0 147.0 147.0 147.0 147.0 147.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:50:27 INFO - PROCESS | 11238 | Values: 96.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 09:50:27 INFO - PROCESS | 11238 | Values: 62.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:3.02 (4.6%) stddev-sans-first:3.18 09:50:27 INFO - PROCESS | 11238 | Values: 65.0 65.0 65.0 68.0 65.0 65.0 74.0 65.0 64.0 64.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:84.00 stddev:13.33 (15.9%) stddev-sans-first:13.93 09:50:27 INFO - PROCESS | 11238 | Values: 82.0 83.0 83.0 83.0 84.0 84.0 86.0 85.0 126.0 88.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:142.00 stddev:7.44 (5.2%) stddev-sans-first:7.82 09:50:27 INFO - PROCESS | 11238 | Values: 142.0 137.0 140.0 128.0 130.0 147.0 142.0 131.0 148.0 147.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:1.75 (1.0%) stddev-sans-first:1.80 09:50:27 INFO - PROCESS | 11238 | Values: 170.0 168.0 167.0 172.0 168.0 170.0 169.0 166.0 170.0 168.0 09:50:27 INFO - PROCESS | 11238 | 09:50:27 INFO - PROCESS | 11238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.25 (3.4%) stddev-sans-first:2.37 09:50:27 INFO - PROCESS | 11238 | Values: 68.0 72.0 67.0 67.0 66.0 66.0 70.0 65.0 65.0 66.0 09:50:27 INFO - PROCESS | 11238 | -------- Summary: end -------- 09:50:27 INFO - PROCESS | 11238 | 09:50:28 INFO - TEST-INFO | 11238: exit 0 09:50:28 INFO - TEST-OK | kraken | took 64497ms 09:50:28 INFO - SUITE-END | took 1183s 09:50:29 INFO - Completed test suite (00:19:43) 09:50:29 INFO - javascript benchmark 09:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.960850587241, 2617.7120516743144, 2648.1128821844686, 2653.601959706044, 2659.640948471957, 4550.567696068876, 4633.212353899837, 4692.296155576665, 4723.220668589687, 4769.046190761844, 4714.717116972984, 4720.221163508026, 4733.5739783419485, 4781.497942716017, 4790.832320868771, 4287.528371879091, 4292.957070429303, 4367.432233809616, 4393.340998850182, 4465.330200469923, 4358.869233922987, 4395.296752519597, 4412.911741765162, 4417.624501917341, 4444.644428445717, 4175.102352994106, 4226.3026600610865, 4299.462567179103, 4339.978300108479, 4402.603765661074, 4316.115196384733, 4331.198728235287, 4337.804798784062, 4368.49762277339, 4388.517263101056, 4311.094670119279, 4331.177076355482, 4331.45856767904, 4338.978305108486, 4394.582514661102, 4588.0365123324145, 4612.86161415158, 4656.534346565317, 4657.347971284023, 4707.223308154151, 4941.715154059934, 4981.327520784684, 4998.050370429607, 5000.249962505617, 5004.8999020019755, 4997.62517811162, 5000.74996250186, 5011.624128190364, 5021.648484606079, 5022.146235140035, 4553.180427523078, 4705.364775755229, 4726.1020406122725, 4734.857954261378, 4768.783960090155, 5215.87858610393, 5223.9290945356115, 5235.110031294689, 5238.449962753933, 5241.030409374202, 4761.40482439695, 5011.448740638527, 5016.799328026911, 5017.096922553902, 5017.122003649347, 4988.775505102279, 5025.346704928409, 5027.0, 5040.924386134211, 5055.7219352935945, 4994.076095922266, 5002.199648056367, 5002.774875130628, 5011.649184557046, 5050.545450909436, 4808.422989241313, 4957.03337849116, 4960.50394960501, 4965.652404331662, 5014.222795466709, 4206.978965105155, 4207.389928460356, 4227.175700738388, 4268.551802060739, 4270.615644592001, 3678.3562876496508, 3700.3524383232825, 3702.407614781622, 3711.740178187555, 3731.850725970931, 4305.870823875289, 4346.521882592912, 4460.955390446119, 4492.685512014193, 4505.279155335131, 5007.499250075036, 5050.419201791841, 5056.0, 5058.494150584912, 5060.822871199491, 4386.210482113186, 4395.208862404797, 4416.53626369233, 4417.955820441819, 4455.22033644111, 4366.847160349373, 4492.281235002384, 4498.347739577743, 4515.503294637587, 4527.660425468037, 4793.760311984387, 4820.4456487504385, 4840.273958906192, 4885.218365061573, 4889.339939108175, 5052.823151189691, 5053.140966035856, 5057.0, 5062.417821950376, 5107.974460127824, 4454.732716037048, 4759.857204283877, 4767.785449654704, 4769.451513076041, 4819.542143496362, 4955.6531042826655, 4998.225275082368, 5012.548870601663, 5013.548780609763, 5057.266696329085, 5084.898302033865, 5093.796248150033, 5101.438841727481, 5109.3613298337705, 5147.974260128675, 4710.670253082251, 4877.097736918681, 4909.852704418873, 4943.456219815889, 4945.23348880924, 4910.410750709938, 4934.5312195341385, 4935.0, 4935.383077115361, 4970.0, 4850.5149485052625, 4859.708417494961, 4880.6583539153335, 4908.950910490849, 4911.238757992517, 4697.13103075932, 4865.148598995091, 4880.6095512358215, 4909.459959404391, 4996.575291100297, 4807.7836497357, 4807.903841923212, 4815.903681926412, 4816.133096042746, 4868.634852386014], "value": 4628.159822250801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3094166998841, 576.0581449330347, 576.2451188942483, 583.5477504933676, 588.7262422973316, 28057.43885122299, 28610.713892861066, 30596.235094122658, 40346.7982660087, 41464.79267603658, 42176.78911605437, 42618.57381426185, 42637.0, 42667.57332426675, 42733.35899961503, 7782.961085194566, 7911.8417631647335, 7911.9604401978195, 7915.96042019792, 7916.564588947605, 7812.3359514441345, 7899.9210007899765, 7911.129775724666, 7921.287084162424, 7922.168172341908, 7903.525788452711, 7927.40544459165, 7943.20567943204, 7947.96026019872, 7948.046234451874, 7834.412419068564, 7879.172686867853, 7890.0926393464915, 7899.091604465502, 7904.249096335839, 7846.568438735867, 7897.5656338901335, 7901.446898717092, 7906.6837326506875, 7915.604219789045, 39340.60659393398, 39654.20691586152, 39691.80154099211, 39692.801535992425, 39729.0, 2710.715374885648, 2725.7683096936785, 2786.582012698091, 2798.188525327673, 2845.089571337173, 29806.85096574525, 29827.552586711216, 30543.69456305431, 30841.074767757003, 31227.37545249105, 3509.3507701075127, 3532.1522834519787, 3538.6992105671047, 3546.3261980223674, 3717.4609681596016, 190129.04935475372, 190753.04623476794, 190755.0, 191008.0, 191249.0, 50663.0, 50835.237471437955, 50935.23597145972, 50983.0, 50987.7450612752, 32901.34197316088, 33705.662943370255, 33709.83145084259, 35537.0, 35572.82213588915, 14987.700245995236, 15220.923895380674, 15224.543263702106, 15273.236338183046, 15279.541613751606, 10786.298890572089, 10822.458877056115, 10864.239503234856, 10866.891331086588, 10873.0, 18106.3662771805, 18110.90944545295, 18186.909065454587, 18216.63566728658, 18301.450956471326, 6848.280930502226, 7125.35871771543, 7210.170830354471, 7225.169105552929, 7275.308845659654, 797.6370751308141, 856.6059612578284, 867.280157469299, 897.528797381367, 925.9722208333761, 27787.0, 28056.0, 28196.71803281982, 28278.293042673686, 28480.715192847805, 946.5787724462685, 956.9473678947586, 963.7301555564453, 1053.0943388685723, 1078.1267173589417, 14366.640833979234, 14540.709185816224, 14861.628459288388, 15127.243637818065, 15148.697026059417, 400652.0, 405774.0, 407552.0, 410246.0, 411457.0, 50583.49416505788, 51047.489525104276, 51189.232161517604, 51227.48772512227, 51233.48766512287, 1090.7000574841823, 1146.696125526736, 1192.1297452859462, 1205.1744554979866, 1206.7224538356227, 28341.858290708413, 29314.7068529312, 29600.0, 29800.764942628957, 30233.69766302397, 41443.37834932418, 41764.1647167061, 42164.78917605392, 42335.3649695261, 42339.57660423356, 313462.0, 316560.0, 316776.0, 316887.0, 317811.0, 22279.443013924134, 22870.199543015915, 24640.137595184082, 25198.748012520373, 25214.74785252124, 41854.58145418507, 42322.576774231864, 42565.0, 43234.0, 43370.78314608533, 36328.63671363358, 36371.560882593505, 36581.26837463289, 36588.634113658525, 37102.44346334861, 35656.4651530222, 36315.45526817047, 36471.45292820663, 36473.63526364809, 36633.45049824201, 35913.82043089768, 36223.818880905426, 36299.81850090733, 36375.0, 36595.26809463849, 31268.68731312658, 32430.513542296412, 32764.67235327616, 32832.1791955203, 32888.506672400414, 24668.506629866944, 25259.89385596955, 25312.0, 25581.616275755507, 25799.484010320062], "value": 17204.487985901764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.85845661735306, 360.83040970743747, 361.8190904547726, 370.5183261759712, 373.4827264239028, 15826.920865395672, 16136.19319034048, 16847.157642117876, 16858.7471187932, 16863.0, 16114.83885161151, 16706.331746730117, 16870.662586748258, 17170.57073573158, 17194.74207886883, 4882.804687812483, 5102.974485127569, 5141.742912854361, 5149.124648809692, 5149.639525233235, 3066.5706801047872, 4890.608751299906, 5630.943690563083, 5955.583109182359, 5960.403959604027, 5959.612625179371, 5964.821055368346, 5983.252093488314, 5995.0, 6029.427204415595, 5636.436356364372, 5935.3471118177185, 5938.732757025901, 5942.970285148568, 5946.108083787423, 2800.747932686068, 4816.975915120437, 5142.177251639757, 5145.228215767665, 5155.226715992593, 19914.701279480818, 20128.899355503276, 20181.697274540893, 20337.491562710904, 20338.898305508526, 1826.8173182681626, 1831.2217307644198, 1911.4265720283859, 1916.1664675866043, 1940.0615262478827, 9363.34456588039, 9365.531723413871, 9512.191463725592, 11592.014678752315, 12079.879201207963, 1439.4673970630934, 1456.9125852448888, 1570.1756577796634, 1582.185174635064, 1618.8543031127138, 59003.70498147482, 67777.0, 67948.0, 68023.0, 68089.65955170193, 9513.14381705636, 9710.223182145412, 9725.513724313756, 9765.658201962897, 9928.305018648769, 13601.115927464683, 13691.0, 13702.177869327672, 13702.93148534271, 13706.0, 7416.666250018762, 7434.293742094493, 7550.471466997257, 7634.50375725576, 7671.961640191875, 7315.817104572428, 7321.231270716605, 7343.0, 7458.440616953751, 7468.4025277977635, 4337.978310108492, 4363.956360436355, 4397.36238245459, 4415.911681766347, 4418.248897687401, 1684.713598688226, 1704.2586474883465, 1788.1416919878532, 1824.297645406528, 1826.844718198968, 745.5414919824269, 808.4704518540366, 826.9669213231404, 904.3714618340322, 956.6077908057663, 15365.846341536666, 15884.364625415084, 16272.267747951371, 16596.0, 17162.22769975354, 808.6199486241458, 876.0976194519527, 887.8623813308948, 902.6163880350824, 903.3541018172039, 9312.487813170204, 9405.341626086109, 9484.573194206278, 9562.856557151648, 9705.417674939526, 364952.0, 375950.0, 376447.0, 376728.0, 376971.0, 74421.62789186019, 86948.0, 88766.55616721875, 90539.0, 91924.54037729769, 933.0669330669331, 961.9615215391445, 967.3567077893263, 972.5866506734609, 989.7871957529165, 15563.76654350163, 15645.921770391531, 15764.448244311394, 15819.920900395424, 15935.920320398323, 38353.42469862899, 38743.612563874, 38800.22399552049, 39414.0, 39802.004949876486, 53506.46493535015, 55302.958337291835, 55422.0, 55686.16470753023, 56625.43374566202, 4873.028481787332, 4904.877378065434, 7124.536905101152, 7646.732364367221, 7824.882626760489, 10304.0, 11353.716157096138, 11787.057035436974, 11873.82189267179, 12086.818697719365, 9485.146336829719, 9681.225501959685, 9872.753181170528, 9902.702918912444, 9941.900580994097, 5903.848749493979, 8631.6978905738, 10486.632967846088, 10632.096271816983, 10637.840432393365, 9154.450732956044, 9936.012797440397, 10090.293679442368, 10223.948880255848, 10324.122449591569, 7462.0, 7667.69329226847, 7671.156172821097, 7795.4543181976715, 7847.9607601961625, 9820.263480238867, 10146.949265253626, 10217.693469195936, 10361.11930485887, 10407.271490995558], "value": 8148.319090976156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.110049663746, 1377.9379927903246, 1412.5409241996351, 1494.9925250373747, 1711.9743203851936, 6638.468922486201, 7525.849483010336, 7828.590853646341, 7852.764417067483, 8027.0, 7748.767536973885, 7762.844743105149, 7810.726624568141, 7861.135275119746, 7870.409719271049, 2159.0608085482786, 2183.683365911942, 2190.9561808763815, 2191.693162957179, 2201.9449513762206, 2095.8428117891144, 2129.7550781660075, 2200.262911924507, 2201.2625770366867, 2202.0641227478336, 2140.4327853118934, 2153.849230553862, 2170.4899348653053, 2176.619091658961, 2189.704389907358, 2024.6456870047757, 2027.7566691996908, 2028.8376929845724, 2029.1984666056899, 2031.7561892572912, 2113.7357830271217, 2169.034779523113, 2169.7721739217313, 2174.804267615922, 2176.7605563388015, 7445.664945077485, 7883.36933045355, 7967.840643187162, 7990.600469976478, 8009.038915330139, 4442.133783912139, 4530.75080870552, 4548.613367863735, 4552.954470455286, 4576.633869290449, 2676.330917270682, 2737.178846346088, 2763.557830747091, 2797.9720202797916, 2834.576437146231, 892.5849479991834, 898.6764764684708, 908.3142227618106, 912.0605776050678, 913.9177474027302, 10636.946815265952, 10721.35671859691, 10758.784824303548, 10772.622958196504, 10788.244822862403, 3998.1803730235233, 4076.7961601919787, 4141.91716165681, 4148.979255103705, 4158.066499077943, 8556.443831150955, 8565.743027709179, 8609.440386374865, 8626.094260102724, 8654.0, 4595.609373203249, 4619.260918253063, 4643.071385722869, 4650.465196502446, 4651.558101980307, 3468.8612455502002, 4106.0, 4275.978620106879, 4287.249731297011, 4290.313549832012, 3387.6442973487924, 3412.8805491807666, 3501.1947252132154, 3509.666581674737, 3514.8066856322635, 1000.4397537379091, 1000.6397696829281, 1003.0, 1025.5077562769911, 1035.2287545778443, 673.2291526202471, 715.7137145141985, 794.5907857453416, 819.663937785517, 821.3347188776991, 5034.974825125851, 5164.56101231392, 5173.586113111018, 5212.9739351303, 5506.146547285177, 852.4235522940544, 890.8708237305555, 920.1283023732037, 935.1863878425677, 946.621351459408, 3380.695737383647, 3440.1915549845767, 3480.80855552947, 3570.2145527983803, 3650.5984341722387, 9357.812843743088, 9542.188913942255, 9580.520973951274, 9596.136347728598, 9622.182114520205, 9046.773830654154, 9438.528073596293, 9467.337286389886, 9492.90507094934, 9633.807323853624, 7284.344409003215, 7396.519226250384, 7451.254874512505, 7481.027466429329, 7508.662110205054, 5083.491650834887, 5231.712255825966, 5306.204069389468, 5321.946780532146, 5355.812546560852, 8578.313734901318, 8679.869801953102, 8894.377393582647, 8950.597223124845, 9050.728478145666, 8394.118617545315, 8993.730188094367, 9043.547822608974, 9063.093690630883, 9150.862737059082, 7127.2516385778745, 7320.304571065741, 7340.779776606711, 7434.107907050972, 7459.888101678588, 7045.859082818418, 7313.561186328625, 7330.120385553554, 7369.668364923698, 7412.444066695128, 5547.528460080777, 6247.562670613013, 6781.42357899584, 6841.418479429304, 6926.0, 6427.421532062137, 6510.5117116217425, 6664.466842652673, 6752.122224111031, 6824.283450237654, 5942.435468630473, 6076.54425918049, 6078.057901025348, 6102.206713127265, 6102.908456373247, 4328.978355108205, 4372.80322385487, 4384.05742765307, 4519.186546421675, 4548.295014272793, 4447.621952133975, 4553.2259515881715, 4585.747783871919, 4587.564181402761, 4596.4024676791805], "value": 4066.189010067091, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.8637397236312, 286.9354395261067, 295.2117845352907, 297.95828583998247, 298.4285094044904, 4703.05938812238, 4706.458757242914, 4721.527847215277, 4748.620110391169, 4752.382190315258, 4642.930356044662, 4671.743054132022, 4674.6494012949, 4689.226277664181, 4708.152532544141, 3477.1828620274277, 3568.964310356902, 3586.2289607734333, 3655.4882316475714, 3703.4446232099763, 3681.0245284999496, 3706.314331848617, 3715.7213209009296, 3719.1260053887313, 3723.0, 3486.779627130497, 3675.117971686789, 3676.724245681571, 3682.1346983458866, 3685.0050486368664, 3520.5775306963073, 3608.1160115771804, 3609.3322735294055, 3643.143861192618, 3648.5986541480415, 3177.6663450337614, 3194.37709646619, 3216.5979252593424, 3218.8229647369385, 3230.4185246655593, 4564.995700945787, 4584.4957054723955, 4622.352870598119, 4643.791029403685, 4658.627309815207, 4040.474738284004, 4217.135487225111, 4232.788360581959, 4233.0, 4242.893927651802, 4916.287138364917, 4940.48124946879, 4941.357623508957, 4955.207166853323, 4960.553550180501, 3598.6581274778855, 3610.855565777366, 3617.963820361815, 3618.2763447310645, 3627.5828279747902, 4992.956098823689, 5160.819371321985, 5198.324217851655, 5201.141811601081, 5220.034293655686, 3630.146915474861, 3662.7252956028406, 3664.5052917855746, 3673.8897833065053, 3674.6141655125825, 3636.9634654123447, 3667.651573100551, 3733.9544927420366, 3734.79458629778, 3744.8876533704033, 4202.495700515897, 4205.642520385802, 4205.789710514462, 4207.853994462846, 4226.11937687726, 4790.952090479121, 4908.582770464551, 4917.385326834145, 4926.1379258629595, 4936.160852655057, 1290.7741145299535, 1299.9805002924963, 1303.4590644882267, 1305.8965174427594, 1307.2287350463273, 839.8278352937633, 842.5071333270106, 888.595688961521, 891.3893982621795, 898.1512470715242, 4368.825246990084, 4386.407834942306, 4417.160739459492, 4434.312681534368, 4463.933041004388, 5023.773930173078, 5027.340977477424, 5042.949570504321, 5051.1413059779925, 5083.186690129562, 4199.853005144805, 4358.738475691469, 4392.736435813861, 4419.1824512464655, 4428.158649856581, 2705.850013744151, 2713.782897368206, 2717.6874659414025, 2719.2386131883104, 2725.8909643614033, 4747.548982846624, 4828.130936431406, 4831.613470922318, 4839.669090999932, 4872.878178045577, 4936.259561065797, 5135.101357262464, 5168.2764412982215, 5181.171012638035, 5254.737263136828, 4821.349117869113, 4873.244647079709, 4881.560659540658, 4896.36347274852, 4901.0, 5134.820281290137, 5152.046871328816, 5176.1200595899545, 5179.378474583074, 5187.844364669066, 4845.370101886732, 5005.7997680092385, 5012.573931215742, 5054.974725126351, 5067.189249720027, 4842.201036829025, 4855.611551075976, 4868.488808675038, 4877.707337559757, 4879.829205977774, 3593.6406359363855, 3610.6028336883446, 3619.1856832212543, 3619.9276014480088, 3630.2376500935097, 4978.800847966041, 5145.176771716508, 5215.16557350822, 5217.121836138911, 5218.504242096995, 4910.091633047898, 4984.728894131973, 4993.675411098267, 5000.874978125576, 5004.199328107631, 4953.851384458472, 4970.155073637563, 4985.8781774100535, 5010.248462730619, 5035.093683137071, 4629.213033784197, 4941.135301322326, 4944.48082951285, 4953.405591329064, 4959.628027897994, 4793.640476964311, 4888.608911287018, 4973.676711013773, 4992.675476094042, 5014.924776128434, 4882.145624515624, 4886.315915771866, 4917.950820491749, 4929.852104436873, 4955.950440495549], "value": 3747.8591501060987, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5057224356444, 563.3718403979564, 571.2373980735717, 607.8632307730761, 611.9877602447951, 10636.787264254719, 11358.091352691785, 11397.601083962063, 11412.144089193313, 11412.258203216785, 11361.659150225485, 12346.135770496068, 12355.629331120059, 12357.073219508527, 12362.320072396014, 615.796787060269, 758.3743411685354, 784.6233807772259, 791.8099656082527, 797.6171437709903, 769.5459678789513, 771.6488997506121, 773.5938632218074, 781.2148790465602, 781.4881252779438, 809.7975506123469, 811.8416908702806, 812.5368539932241, 812.9796755081111, 813.2802469814227, 631.1574048645041, 788.2984144111745, 802.506458528004, 802.7671975127206, 814.2468216899344, 593.2080672302482, 597.6354423801478, 598.1327075740151, 599.379642070455, 600.7356763024255, 10713.517891694892, 10722.195835312383, 10747.08649764771, 10750.838737418944, 10753.946230268877, 12335.568255111119, 12722.6463104326, 12827.102102852805, 13187.472501099945, 13207.075504714674, 10722.678319650424, 10793.83809242862, 10901.83647245292, 11058.778824423547, 11357.716057098556, 4137.565555616678, 4153.833846646131, 4206.684498662582, 4256.063665993476, 4348.0, 58773.0, 58804.0, 58883.0, 58916.70541647307, 58988.99999999957, 8876.733697989072, 9172.6789562365, 9269.768255793659, 9709.611615535441, 10034.197264218845, 17647.0, 17968.640627187382, 17979.820201798077, 17996.560275178217, 18018.639627207645, 6175.62946223228, 6180.81457556274, 6296.779612713624, 6361.650109244036, 6544.345565443513, 3305.438075527118, 3420.521127042216, 3421.6749408806622, 3612.2956023575152, 3621.4748861414946, 2562.1160699558623, 2638.14260365382, 2646.5236257473452, 2647.880845361963, 2702.9459410811673, 465.80901830249434, 467.3783867456275, 470.35796138271013, 476.1239319651857, 477.28883962895037, 452.11836918009357, 482.5102520941247, 492.9580985616191, 494.7278996551882, 495.26205953130295, 6455.225372955276, 6471.417572418411, 6498.285188629247, 6513.055606937062, 6601.141851559267, 438.3184148648818, 458.6995517935757, 477.8924741933037, 486.72986492496295, 488.819136919335, 3079.168624471425, 3098.4422803895513, 3107.1610665120293, 3115.797473164237, 3130.483470227387, 70080.2991970084, 73616.0, 73813.0, 90293.0, 92879.0, 46942.5305746945, 66464.66767666131, 77965.0, 78307.21692783, 79688.0, 55484.72257638686, 71337.2866271341, 72569.6371518139, 72808.63595682093, 73540.11679065663, 7251.166115896739, 7313.561186328838, 7407.814804629712, 7447.069116360455, 7464.92535074664, 43691.0, 43713.0, 44907.326390103524, 45145.097098057195, 45164.32253516265, 52021.47978520166, 60698.0, 60960.69519652551, 61529.0, 61812.69093654503, 9838.65564705232, 9981.351212171186, 10743.140548755924, 10924.508397122308, 10975.560977560808, 11136.610218642309, 11147.554097835995, 11337.829932551183, 11498.425078746197, 11628.476718547516, 10017.298789084985, 10146.289759716748, 10150.89849101529, 10459.424731639832, 10575.048245657928, 10942.069924056545, 11124.288661437571, 11236.438178091226, 11300.660980170607, 11338.206325557132, 11100.5559777608, 11326.263792853439, 11373.886261137282, 12000.219985700902, 12005.39973001364, 9129.45223286605, 9171.908280917372, 9265.907340926504, 9430.292728045286, 9730.805383892424, 8892.73321800347, 9109.77225569366, 9124.315676324435, 9131.223845973167, 9316.0], "value": 6052.941166432469, "unit": "score"}], "name": "dromaeo_css", "value": 6254.379963341762, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 114.0, 115.0, 113.0, 115.0, 111.0, 112.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 138.0, 195.0, 139.0, 132.0, 155.0, 130.0, 184.0, 130.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 116.0, 75.0, 77.0, 74.0, 74.0, 101.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 116.0, 86.0, 87.0, 87.0, 113.0, 87.0, 86.0, 131.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 118.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 150.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 68.0, 65.0, 65.0, 74.0, 65.0, 64.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 83.0, 84.0, 84.0, 86.0, 85.0, 126.0, 88.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 140.0, 128.0, 130.0, 147.0, 142.0, 131.0, 148.0, 147.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 167.0, 172.0, 168.0, 170.0, 169.0, 166.0, 170.0, 168.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 67.0, 67.0, 66.0, 66.0, 70.0, 65.0, 65.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1553.3, "alertThreshold": 2.0}]} 09:50:29 INFO - Return code: 0 09:50:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:29 ERROR - # TBPL SUCCESS # 09:50:29 INFO - Running post-action listener: _resource_record_post_action 09:50:29 INFO - ##### 09:50:29 INFO - ##### Finished run-tests step (success) 09:50:29 INFO - ##### 09:50:29 INFO - Running post-run listener: _resource_record_post_run 09:50:29 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295911424; Read time: 28; Write time: 287960 09:50:29 INFO - TinderboxPrint: CPU usage
13.1% 09:50:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 09:50:29 INFO - TinderboxPrint: I/O write bytes / time
295,911,424 / 287,960 09:50:29 INFO - TinderboxPrint: CPU idle
8,327.2 (86.9%) 09:50:29 INFO - TinderboxPrint: CPU user
1,211.7 (12.6%) 09:50:29 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1462272; Read time: 0; Write time: 48 09:50:29 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294449152; Read time: 28; Write time: 287912 09:50:29 INFO - Running post-run listener: _upload_blobber_files 09:50:29 INFO - Blob upload gear active. 09:50:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:29 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 09:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:50:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:50:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:50:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:30 INFO - (blobuploader) - INFO - Done attempting. 09:50:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:31 INFO - (blobuploader) - INFO - Done attempting. 09:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:35 INFO - (blobuploader) - INFO - Done attempting. 09:50:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:35 INFO - Return code: 0 09:50:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d8013383333d615adcb7204b7f34902555ff3e3420a33e8c6c0d8c06eb1f3303deaa02451450a49faef65941a5368bc90963f5be2b6082af202319740a36165", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2947aeff02d025c995972e06621b17f0491da9db725ac463ea7561dc2939ad7c9c64b48558570bcf5a46534836d56ac63ff2556500ab38c4c32d00aa4166e7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e73345a16e79b149836fc7ec5fb29a4971f4a0a47531724cdd97104a39dc64f3ca3b9a82ba680b1e81fc0373dc5fb20928717742e04a5a48567b0c3545f92f"} 09:50:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:35 INFO - Contents: 09:50:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d8013383333d615adcb7204b7f34902555ff3e3420a33e8c6c0d8c06eb1f3303deaa02451450a49faef65941a5368bc90963f5be2b6082af202319740a36165", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2947aeff02d025c995972e06621b17f0491da9db725ac463ea7561dc2939ad7c9c64b48558570bcf5a46534836d56ac63ff2556500ab38c4c32d00aa4166e7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e73345a16e79b149836fc7ec5fb29a4971f4a0a47531724cdd97104a39dc64f3ca3b9a82ba680b1e81fc0373dc5fb20928717742e04a5a48567b0c3545f92f"} 09:50:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:35 INFO - Copying logs to upload dir... 09:50:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.531850 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 09:50:35.834272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:50:35.837915) ========= 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=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d8013383333d615adcb7204b7f34902555ff3e3420a33e8c6c0d8c06eb1f3303deaa02451450a49faef65941a5368bc90963f5be2b6082af202319740a36165", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2947aeff02d025c995972e06621b17f0491da9db725ac463ea7561dc2939ad7c9c64b48558570bcf5a46534836d56ac63ff2556500ab38c4c32d00aa4166e7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e73345a16e79b149836fc7ec5fb29a4971f4a0a47531724cdd97104a39dc64f3ca3b9a82ba680b1e81fc0373dc5fb20928717742e04a5a48567b0c3545f92f"} build_url:https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d8013383333d615adcb7204b7f34902555ff3e3420a33e8c6c0d8c06eb1f3303deaa02451450a49faef65941a5368bc90963f5be2b6082af202319740a36165", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2947aeff02d025c995972e06621b17f0491da9db725ac463ea7561dc2939ad7c9c64b48558570bcf5a46534836d56ac63ff2556500ab38c4c32d00aa4166e7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e73345a16e79b149836fc7ec5fb29a4971f4a0a47531724cdd97104a39dc64f3ca3b9a82ba680b1e81fc0373dc5fb20928717742e04a5a48567b0c3545f92f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:50:35.863281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:50:35.863612) ========= 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=0e2a256762fed810e2f0f810000001b3-1465489788.179324-708475597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:50:35.950442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:50:35.950801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:50:35.951096) ========= ========= Total master_lag: 0.17 =========