builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1465435525.06 results: success (0) buildid: 20160608170732 builduid: b3392bba59544c07bfca965038a74022 revision: 249d57fa78a0522f63a5b1ed1fdda55f383156e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.062570) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.063047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.063372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.149331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.149699) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 18:25:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.7M=0s 2016-06-08 18:25:25 (90.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075146 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.242846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.243212) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018485 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.312423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:25.312845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 249d57fa78a0522f63a5b1ed1fdda55f383156e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 249d57fa78a0522f63a5b1ed1fdda55f383156e0 --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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 18:25:25,565 truncating revision to first 12 chars 2016-06-08 18:25:25,566 Setting DEBUG logging. 2016-06-08 18:25:25,566 attempt 1/10 2016-06-08 18:25:25,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/249d57fa78a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 18:25:25,886 unpacking tar archive at: mozilla-central-249d57fa78a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:26.005149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:26.005524) ========= script_repo_revision: 249d57fa78a0522f63a5b1ed1fdda55f383156e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:26.005984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:26.006303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:25:26.017617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-08 18:25:26.018027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:26 INFO - MultiFileLogger online at 20160608 18:25:26 in /builds/slave/test 18:25:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:25:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:26 INFO - {'append_to_log': False, 18:25:26 INFO - 'base_work_dir': '/builds/slave/test', 18:25:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:25:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:26 INFO - 'branch': 'Firefox-Non-PGO', 18:25:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:26 INFO - 'config_files': ('talos/linux_config.py',), 18:25:26 INFO - 'default_actions': ('clobber', 18:25:26 INFO - 'read-buildbot-config', 18:25:26 INFO - 'download-and-extract', 18:25:26 INFO - 'populate-webroot', 18:25:26 INFO - 'create-virtualenv', 18:25:26 INFO - 'install', 18:25:26 INFO - 'run-tests'), 18:25:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:26 INFO - 'download_minidump_stackwalk': True, 18:25:26 INFO - 'download_symbols': 'ondemand', 18:25:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:26 INFO - 'installer_path': 'installer.exe', 18:25:26 INFO - 'log_level': 'info', 18:25:26 INFO - 'log_name': 'talos', 18:25:26 INFO - 'log_to_console': True, 18:25:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:26 INFO - 'opt_config_files': (), 18:25:26 INFO - 'pip_index': False, 18:25:26 INFO - 'sps_profile': False, 18:25:26 INFO - 'sps_profile_interval': 0, 18:25:26 INFO - 'suite': 'dromaeojs-e10s', 18:25:26 INFO - 'system_bits': '32', 18:25:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:26 INFO - 'title': 'talos-linux64-ix-051', 18:25:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:26 INFO - 'use_talos_json': True, 18:25:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:26 INFO - 'work_dir': 'build'} 18:25:26 INFO - ##### 18:25:26 INFO - ##### Running clobber step. 18:25:26 INFO - ##### 18:25:26 INFO - Running pre-action listener: _resource_record_pre_action 18:25:26 INFO - Running main action method: clobber 18:25:26 INFO - rmtree: /builds/slave/test/build 18:25:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:27 INFO - Running post-action listener: _resource_record_post_action 18:25:27 INFO - ##### 18:25:27 INFO - ##### Finished clobber step (success) 18:25:27 INFO - ##### 18:25:27 INFO - ##### 18:25:27 INFO - ##### Running read-buildbot-config step. 18:25:27 INFO - ##### 18:25:27 INFO - Running pre-action listener: _resource_record_pre_action 18:25:27 INFO - Running main action method: read_buildbot_config 18:25:27 INFO - Using buildbot properties: 18:25:27 INFO - { 18:25:27 INFO - "project": "", 18:25:27 INFO - "product": "firefox", 18:25:27 INFO - "script_repo_revision": "production", 18:25:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:25:27 INFO - "repository": "", 18:25:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:25:27 INFO - "buildid": "20160608170732", 18:25:27 INFO - "pgo_build": "False", 18:25:27 INFO - "basedir": "/builds/slave/test", 18:25:27 INFO - "buildnumber": 343, 18:25:27 INFO - "slavename": "talos-linux64-ix-051", 18:25:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:27 INFO - "platform": "ubuntu64_hw", 18:25:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:25:27 INFO - "branch": "mozilla-central", 18:25:27 INFO - "repo_path": "mozilla-central", 18:25:27 INFO - "revision": "249d57fa78a0522f63a5b1ed1fdda55f383156e0", 18:25:27 INFO - "stage_platform": "linux64", 18:25:27 INFO - "builduid": "b3392bba59544c07bfca965038a74022", 18:25:27 INFO - "slavebuilddir": "test" 18:25:27 INFO - } 18:25:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:25:27 INFO - Running post-action listener: _resource_record_post_action 18:25:27 INFO - ##### 18:25:27 INFO - ##### Finished read-buildbot-config step (success) 18:25:27 INFO - ##### 18:25:27 INFO - ##### 18:25:27 INFO - ##### Running download-and-extract step. 18:25:27 INFO - ##### 18:25:27 INFO - Running pre-action listener: _resource_record_pre_action 18:25:27 INFO - Running main action method: download_and_extract 18:25:27 INFO - mkdir: /builds/slave/test/build/tests 18:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:27 INFO - https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:25:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:25:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:25:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:29 INFO - Downloaded 1361 bytes. 18:25:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:25:29 INFO - Using the following test package requirements: 18:25:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:25:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'jsshell-linux-x86_64.zip'], 18:25:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:29 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')]} 18:25:29 INFO - https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:32 INFO - Downloaded 22879054 bytes. 18:25:32 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'] 18:25:32 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 18:25:34 INFO - Return code: 0 18:25:34 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 18:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:34 INFO - https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:37 INFO - Downloaded 22879054 bytes. 18:25:37 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'] 18:25:37 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 18:25:38 INFO - Return code: 0 18:25:38 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')]} 18:25:38 INFO - https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:39 INFO - Downloaded 10833369 bytes. 18:25:39 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'] 18:25:39 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 18:25:39 INFO - Return code: 0 18:25:39 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')]} 18:25:39 INFO - https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzftmnNDQ0a67FXxeCX56Q/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 18:25:42 INFO - Downloaded 55342405 bytes. 18:25:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:25:42 INFO - mkdir: /builds/slave/test/properties 18:25:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:42 INFO - Contents: 18:25:42 INFO - build_url:https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:25:43 INFO - Running post-action listener: _resource_record_post_action 18:25:43 INFO - Running post-action listener: set_extra_try_arguments 18:25:43 INFO - ##### 18:25:43 INFO - ##### Finished download-and-extract step (success) 18:25:43 INFO - ##### 18:25:43 INFO - ##### 18:25:43 INFO - ##### Running populate-webroot step. 18:25:43 INFO - ##### 18:25:43 INFO - Running pre-action listener: _resource_record_pre_action 18:25:43 INFO - Running main action method: populate_webroot 18:25:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:43 INFO - '--tppagecycles', 18:25:43 INFO - '7'], 18:25:43 INFO - 'tests': ['tsvgm']}}, 18:25:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['damp', 'tps']}, 18:25:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'tests': ['damp', 'tps']}, 18:25:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['dromaeo_dom']}, 18:25:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['a11yr', 18:25:43 INFO - 'ts_paint', 18:25:43 INFO - 'tpaint', 18:25:43 INFO - 'sessionrestore', 18:25:43 INFO - 'sessionrestore_no_auto_restore', 18:25:43 INFO - 'tabpaint']}, 18:25:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['tsvgx', 18:25:43 INFO - 'tsvgr_opacity', 18:25:43 INFO - 'tart', 18:25:43 INFO - 'tscrollx', 18:25:43 INFO - 'cart']}, 18:25:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:43 INFO - 'tsvgr_opacity', 18:25:43 INFO - 'tart', 18:25:43 INFO - 'tscrollx', 18:25:43 INFO - 'cart']}, 18:25:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'talos_options': ['--disable-e10s'], 18:25:43 INFO - 'tests': ['tp5o']}, 18:25:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'tests': ['tp5o']}, 18:25:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'talos_options': ['--disable-e10s', 18:25:43 INFO - '--xperf_path', 18:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:43 INFO - 'tests': ['tp5n']}, 18:25:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:43 INFO - 'talos_options': ['--xperf_path', 18:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:43 INFO - 'tests': ['tp5n']}}, 18:25:43 INFO - 'talos.zip': {'path': '', 18:25:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:43 INFO - Running post-action listener: _resource_record_post_action 18:25:43 INFO - ##### 18:25:43 INFO - ##### Finished populate-webroot step (success) 18:25:43 INFO - ##### 18:25:43 INFO - ##### 18:25:43 INFO - ##### Running create-virtualenv step. 18:25:43 INFO - ##### 18:25:43 INFO - Running pre-action listener: _resource_record_pre_action 18:25:43 INFO - Running main action method: create_virtualenv 18:25:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:43 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 18:25:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:43 INFO - Using real prefix '/usr' 18:25:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:46 INFO - Installing pip.................done. 18:25:46 INFO - Return code: 0 18:25:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:46 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:46 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 18:25:46 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 18:25:46 INFO - Using env: {'DISPLAY': ':0', 18:25:46 INFO - 'HOME': '/home/cltbld', 18:25:46 INFO - 'LANG': 'en_US.UTF-8', 18:25:46 INFO - 'LANGUAGE': 'en_US:en', 18:25:46 INFO - 'LOGNAME': 'cltbld', 18:25:46 INFO - 'MAIL': '/var/mail/cltbld', 18:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:46 INFO - 'MOZ_NO_REMOTE': '1', 18:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:46 INFO - 'NO_EM_RESTART': '1', 18:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:46 INFO - 'PWD': '/builds/slave/test', 18:25:46 INFO - 'SHELL': '/bin/bash', 18:25:46 INFO - 'SHLVL': '1', 18:25:46 INFO - 'TERM': 'linux', 18:25:46 INFO - 'TMOUT': '86400', 18:25:46 INFO - 'USER': 'cltbld', 18:25:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:46 INFO - '_': '/tools/buildbot/bin/python'} 18:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:46 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 18:25:46 INFO - Cleaning up... 18:25:46 INFO - Return code: 0 18:25:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:46 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:46 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 18:25:46 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 18:25:46 INFO - Using env: {'DISPLAY': ':0', 18:25:46 INFO - 'HOME': '/home/cltbld', 18:25:46 INFO - 'LANG': 'en_US.UTF-8', 18:25:46 INFO - 'LANGUAGE': 'en_US:en', 18:25:46 INFO - 'LOGNAME': 'cltbld', 18:25:46 INFO - 'MAIL': '/var/mail/cltbld', 18:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:46 INFO - 'MOZ_NO_REMOTE': '1', 18:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:46 INFO - 'NO_EM_RESTART': '1', 18:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:46 INFO - 'PWD': '/builds/slave/test', 18:25:46 INFO - 'SHELL': '/bin/bash', 18:25:46 INFO - 'SHLVL': '1', 18:25:46 INFO - 'TERM': 'linux', 18:25:46 INFO - 'TMOUT': '86400', 18:25:46 INFO - 'USER': 'cltbld', 18:25:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:46 INFO - '_': '/tools/buildbot/bin/python'} 18:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:46 INFO - Downloading/unpacking psutil>=3.1.1 18:25:46 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 18:25:46 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 18:25:46 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 18:25:46 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 18:25:46 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 18:25:46 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 18:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:48 INFO - Installing collected packages: psutil 18:25:48 INFO - Running setup.py install for psutil 18:25:48 INFO - building 'psutil._psutil_linux' extension 18:25:48 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 18:25:48 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 18:25:48 INFO - building 'psutil._psutil_posix' extension 18:25:48 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 18:25:49 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 18:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:49 INFO - Successfully installed psutil 18:25:49 INFO - Cleaning up... 18:25:49 INFO - Return code: 0 18:25:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:25:49 INFO - Using env: {'DISPLAY': ':0', 18:25:49 INFO - 'HOME': '/home/cltbld', 18:25:49 INFO - 'LANG': 'en_US.UTF-8', 18:25:49 INFO - 'LANGUAGE': 'en_US:en', 18:25:49 INFO - 'LOGNAME': 'cltbld', 18:25:49 INFO - 'MAIL': '/var/mail/cltbld', 18:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:49 INFO - 'MOZ_NO_REMOTE': '1', 18:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:49 INFO - 'NO_EM_RESTART': '1', 18:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:49 INFO - 'PWD': '/builds/slave/test', 18:25:49 INFO - 'SHELL': '/bin/bash', 18:25:49 INFO - 'SHLVL': '1', 18:25:49 INFO - 'TERM': 'linux', 18:25:49 INFO - 'TMOUT': '86400', 18:25:49 INFO - 'USER': 'cltbld', 18:25:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:49 INFO - '_': '/tools/buildbot/bin/python'} 18:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:51 INFO - Installing collected packages: mozsystemmonitor 18:25:51 INFO - Running setup.py install for mozsystemmonitor 18:25:51 INFO - Successfully installed mozsystemmonitor 18:25:51 INFO - Cleaning up... 18:25:51 INFO - Return code: 0 18:25:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:25:51 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')]} 18:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:51 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')]} 18:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:51 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:51 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 18:25:51 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 18:25:51 INFO - Using env: {'DISPLAY': ':0', 18:25:51 INFO - 'HOME': '/home/cltbld', 18:25:51 INFO - 'LANG': 'en_US.UTF-8', 18:25:51 INFO - 'LANGUAGE': 'en_US:en', 18:25:51 INFO - 'LOGNAME': 'cltbld', 18:25:51 INFO - 'MAIL': '/var/mail/cltbld', 18:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:51 INFO - 'MOZ_NO_REMOTE': '1', 18:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:51 INFO - 'NO_EM_RESTART': '1', 18:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:51 INFO - 'PWD': '/builds/slave/test', 18:25:51 INFO - 'SHELL': '/bin/bash', 18:25:51 INFO - 'SHLVL': '1', 18:25:51 INFO - 'TERM': 'linux', 18:25:51 INFO - 'TMOUT': '86400', 18:25:51 INFO - 'USER': 'cltbld', 18:25:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:51 INFO - '_': '/tools/buildbot/bin/python'} 18:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:51 INFO - Downloading/unpacking jsonschema==2.5.1 18:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:53 INFO - warning: no files found matching '*.txt' 18:25:53 INFO - no previously-included directories found matching 'build' 18:25:53 INFO - no previously-included directories found matching 'dist' 18:25:53 INFO - no previously-included directories found matching '.git*' 18:25:53 INFO - Installing collected packages: jsonschema, functools32 18:25:53 INFO - Running setup.py install for functools32 18:25:53 INFO - warning: no files found matching '*.txt' 18:25:53 INFO - no previously-included directories found matching 'build' 18:25:53 INFO - no previously-included directories found matching 'dist' 18:25:53 INFO - no previously-included directories found matching '.git*' 18:25:53 INFO - Successfully installed jsonschema functools32 18:25:53 INFO - Cleaning up... 18:25:54 INFO - Return code: 0 18:25:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:54 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')]} 18:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:54 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')]} 18:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:54 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:54 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 18:25:54 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 18:25:54 INFO - Using env: {'DISPLAY': ':0', 18:25:54 INFO - 'HOME': '/home/cltbld', 18:25:54 INFO - 'LANG': 'en_US.UTF-8', 18:25:54 INFO - 'LANGUAGE': 'en_US:en', 18:25:54 INFO - 'LOGNAME': 'cltbld', 18:25:54 INFO - 'MAIL': '/var/mail/cltbld', 18:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:54 INFO - 'MOZ_NO_REMOTE': '1', 18:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:54 INFO - 'NO_EM_RESTART': '1', 18:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:54 INFO - 'PWD': '/builds/slave/test', 18:25:54 INFO - 'SHELL': '/bin/bash', 18:25:54 INFO - 'SHLVL': '1', 18:25:54 INFO - 'TERM': 'linux', 18:25:54 INFO - 'TMOUT': '86400', 18:25:54 INFO - 'USER': 'cltbld', 18:25:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:54 INFO - '_': '/tools/buildbot/bin/python'} 18:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:25:54 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 18:25:54 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 18:25:54 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 18:25:54 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 18:25:54 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 18:25:54 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 18:25:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 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 18:25:56 INFO - Downloading docopt-0.6.1.tar.gz 18:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:57 INFO - Running setup.py install for blobuploader 18:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:57 INFO - Running setup.py install for requests 18:25:57 INFO - Running setup.py install for docopt 18:25:57 INFO - Successfully installed blobuploader requests docopt 18:25:57 INFO - Cleaning up... 18:25:57 INFO - Return code: 0 18:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:57 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')]} 18:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:57 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')]} 18:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:57 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:25:57 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 18:25:57 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 18:25:57 INFO - Using env: {'DISPLAY': ':0', 18:25:57 INFO - 'HOME': '/home/cltbld', 18:25:57 INFO - 'LANG': 'en_US.UTF-8', 18:25:57 INFO - 'LANGUAGE': 'en_US:en', 18:25:57 INFO - 'LOGNAME': 'cltbld', 18:25:57 INFO - 'MAIL': '/var/mail/cltbld', 18:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:57 INFO - 'MOZ_NO_REMOTE': '1', 18:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:57 INFO - 'NO_EM_RESTART': '1', 18:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:57 INFO - 'PWD': '/builds/slave/test', 18:25:57 INFO - 'SHELL': '/bin/bash', 18:25:57 INFO - 'SHLVL': '1', 18:25:57 INFO - 'TERM': 'linux', 18:25:57 INFO - 'TMOUT': '86400', 18:25:57 INFO - 'USER': 'cltbld', 18:25:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:57 INFO - '_': '/tools/buildbot/bin/python'} 18:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:57 INFO - Running setup.py (path:/tmp/pip-znNncd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:57 INFO - Running setup.py (path:/tmp/pip-qj423x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:58 INFO - Running setup.py (path:/tmp/pip-O9Z7e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:58 INFO - Running setup.py (path:/tmp/pip-V1T07G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:58 INFO - Running setup.py (path:/tmp/pip-qUPZNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:58 INFO - Running setup.py (path:/tmp/pip-ExsoPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:58 INFO - Running setup.py (path:/tmp/pip-LFRaNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:58 INFO - Running setup.py (path:/tmp/pip-5fTqJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:58 INFO - Running setup.py (path:/tmp/pip-4rcax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:58 INFO - Running setup.py (path:/tmp/pip-ycsSVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:58 INFO - Running setup.py (path:/tmp/pip-QIFPtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:58 INFO - Running setup.py (path:/tmp/pip-OsUfXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:58 INFO - Running setup.py (path:/tmp/pip-E2aGEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:58 INFO - Running setup.py (path:/tmp/pip-OgAj8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:58 INFO - Running setup.py (path:/tmp/pip-YpsVSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:58 INFO - Running setup.py (path:/tmp/pip-pChaj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:59 INFO - Running setup.py (path:/tmp/pip-5Pl8IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:59 INFO - Running setup.py install for manifestparser 18:25:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Running setup.py install for mozcrash 18:25:59 INFO - Running setup.py install for mozdebug 18:25:59 INFO - Running setup.py install for mozdevice 18:25:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Running setup.py install for mozfile 18:25:59 INFO - Running setup.py install for mozhttpd 18:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Running setup.py install for mozinfo 18:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Running setup.py install for mozInstall 18:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:59 INFO - Running setup.py install for mozleak 18:25:59 INFO - Running setup.py install for mozlog 18:26:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Running setup.py install for moznetwork 18:26:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Running setup.py install for mozprocess 18:26:00 INFO - Running setup.py install for mozprofile 18:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Running setup.py install for mozrunner 18:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Running setup.py install for mozscreenshot 18:26:00 INFO - Running setup.py install for moztest 18:26:00 INFO - Running setup.py install for mozversion 18:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:00 INFO - Cleaning up... 18:26:00 INFO - Return code: 0 18:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:26:00 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 18:26:00 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 18:26:00 INFO - Using env: {'DISPLAY': ':0', 18:26:00 INFO - 'HOME': '/home/cltbld', 18:26:00 INFO - 'LANG': 'en_US.UTF-8', 18:26:00 INFO - 'LANGUAGE': 'en_US:en', 18:26:00 INFO - 'LOGNAME': 'cltbld', 18:26:00 INFO - 'MAIL': '/var/mail/cltbld', 18:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:00 INFO - 'MOZ_NO_REMOTE': '1', 18:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:00 INFO - 'NO_EM_RESTART': '1', 18:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:00 INFO - 'PWD': '/builds/slave/test', 18:26:00 INFO - 'SHELL': '/bin/bash', 18:26:00 INFO - 'SHLVL': '1', 18:26:00 INFO - 'TERM': 'linux', 18:26:00 INFO - 'TMOUT': '86400', 18:26:00 INFO - 'USER': 'cltbld', 18:26:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:00 INFO - '_': '/tools/buildbot/bin/python'} 18:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:01 INFO - Running setup.py (path:/tmp/pip-cQZmHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:01 INFO - Running setup.py (path:/tmp/pip-urOpBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:01 INFO - Running setup.py (path:/tmp/pip-lIoHbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:01 INFO - Running setup.py (path:/tmp/pip-pTYz71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:01 INFO - Running setup.py (path:/tmp/pip-wvNosN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:01 INFO - Running setup.py (path:/tmp/pip-o9rySA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:01 INFO - Running setup.py (path:/tmp/pip-KlY4vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:01 INFO - Running setup.py (path:/tmp/pip-G57r4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:01 INFO - Running setup.py (path:/tmp/pip-V3aEyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:01 INFO - Running setup.py (path:/tmp/pip-bcZs0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:01 INFO - Running setup.py (path:/tmp/pip-l6qU0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:01 INFO - Running setup.py (path:/tmp/pip-yW04mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:01 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)) 18:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:01 INFO - Running setup.py (path:/tmp/pip-bUoLb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:02 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)) 18:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:02 INFO - Running setup.py (path:/tmp/pip-afr5nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:02 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)) 18:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:02 INFO - Running setup.py (path:/tmp/pip-qdO1Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:02 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)) 18:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:02 INFO - Running setup.py (path:/tmp/pip-FQ9g4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:02 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)) 18:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:02 INFO - Running setup.py (path:/tmp/pip-b5tU1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:02 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)) 18:26:02 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)) 18:26:02 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)) 18:26:02 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)) 18:26:02 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)) 18:26:02 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)) 18:26:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:04 INFO - Downloading blessings-1.6.tar.gz 18:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:04 INFO - Installing collected packages: blessings 18:26:04 INFO - Running setup.py install for blessings 18:26:04 INFO - Successfully installed blessings 18:26:04 INFO - Cleaning up... 18:26:04 INFO - Return code: 0 18:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:04 INFO - Reading from file tmpfile_stdout 18:26:04 INFO - Current package versions: 18:26:04 INFO - argparse == 1.2.1 18:26:04 INFO - blessings == 1.6 18:26:04 INFO - blobuploader == 1.2.4 18:26:04 INFO - docopt == 0.6.1 18:26:04 INFO - functools32 == 3.2.3-2 18:26:04 INFO - jsonschema == 2.5.1 18:26:04 INFO - manifestparser == 1.1 18:26:04 INFO - mozInstall == 1.12 18:26:04 INFO - mozcrash == 0.17 18:26:04 INFO - mozdebug == 0.1 18:26:04 INFO - mozdevice == 0.48 18:26:04 INFO - mozfile == 1.2 18:26:04 INFO - mozhttpd == 0.7 18:26:04 INFO - mozinfo == 0.9 18:26:04 INFO - mozleak == 0.1 18:26:04 INFO - mozlog == 3.2 18:26:04 INFO - moznetwork == 0.27 18:26:04 INFO - mozprocess == 0.22 18:26:04 INFO - mozprofile == 0.28 18:26:04 INFO - mozrunner == 6.11 18:26:04 INFO - mozscreenshot == 0.1 18:26:04 INFO - mozsystemmonitor == 0.3 18:26:04 INFO - moztest == 0.7 18:26:04 INFO - mozversion == 1.4 18:26:04 INFO - psutil == 3.1.1 18:26:04 INFO - requests == 1.2.3 18:26:04 INFO - wsgiref == 0.1.2 18:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:04 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:26:04 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 18:26:04 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 18:26:04 INFO - Using env: {'DISPLAY': ':0', 18:26:04 INFO - 'HOME': '/home/cltbld', 18:26:04 INFO - 'LANG': 'en_US.UTF-8', 18:26:04 INFO - 'LANGUAGE': 'en_US:en', 18:26:04 INFO - 'LOGNAME': 'cltbld', 18:26:04 INFO - 'MAIL': '/var/mail/cltbld', 18:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:04 INFO - 'MOZ_NO_REMOTE': '1', 18:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:04 INFO - 'NO_EM_RESTART': '1', 18:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:04 INFO - 'PWD': '/builds/slave/test', 18:26:04 INFO - 'SHELL': '/bin/bash', 18:26:04 INFO - 'SHLVL': '1', 18:26:04 INFO - 'TERM': 'linux', 18:26:04 INFO - 'TMOUT': '86400', 18:26:04 INFO - 'USER': 'cltbld', 18:26:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:04 INFO - '_': '/tools/buildbot/bin/python'} 18:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 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)) 18:26:04 INFO - Cleaning up... 18:26:04 INFO - Return code: 0 18:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:26: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', 'jsonschema'] in /builds/slave/test/build 18:26: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 jsonschema 18:26:04 INFO - Using env: {'DISPLAY': ':0', 18:26:04 INFO - 'HOME': '/home/cltbld', 18:26:04 INFO - 'LANG': 'en_US.UTF-8', 18:26:04 INFO - 'LANGUAGE': 'en_US:en', 18:26:04 INFO - 'LOGNAME': 'cltbld', 18:26:04 INFO - 'MAIL': '/var/mail/cltbld', 18:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:04 INFO - 'MOZ_NO_REMOTE': '1', 18:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:04 INFO - 'NO_EM_RESTART': '1', 18:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:04 INFO - 'PWD': '/builds/slave/test', 18:26:04 INFO - 'SHELL': '/bin/bash', 18:26:04 INFO - 'SHLVL': '1', 18:26:04 INFO - 'TERM': 'linux', 18:26:04 INFO - 'TMOUT': '86400', 18:26:04 INFO - 'USER': 'cltbld', 18:26:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:04 INFO - '_': '/tools/buildbot/bin/python'} 18:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:05 INFO - Cleaning up... 18:26:05 INFO - Return code: 0 18:26:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:05 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 0x7f001a16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', '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 18:26:05 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 18:26:05 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 18:26:05 INFO - Using env: {'DISPLAY': ':0', 18:26:05 INFO - 'HOME': '/home/cltbld', 18:26:05 INFO - 'LANG': 'en_US.UTF-8', 18:26:05 INFO - 'LANGUAGE': 'en_US:en', 18:26:05 INFO - 'LOGNAME': 'cltbld', 18:26:05 INFO - 'MAIL': '/var/mail/cltbld', 18:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:05 INFO - 'MOZ_NO_REMOTE': '1', 18:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:05 INFO - 'NO_EM_RESTART': '1', 18:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:05 INFO - 'PWD': '/builds/slave/test', 18:26:05 INFO - 'SHELL': '/bin/bash', 18:26:05 INFO - 'SHLVL': '1', 18:26:05 INFO - 'TERM': 'linux', 18:26:05 INFO - 'TMOUT': '86400', 18:26:05 INFO - 'USER': 'cltbld', 18:26:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:05 INFO - '_': '/tools/buildbot/bin/python'} 18:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:05 INFO - Downloading/unpacking flake8 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:26:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:26:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:07 INFO - no previously-included directories found matching 'docs/_build' 18:26:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:26:07 INFO - Running setup.py install for pep8 18:26:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:08 INFO - no previously-included directories found matching 'docs/_build' 18:26:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:26:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:26:08 INFO - Cleaning up... 18:26:08 INFO - Return code: 0 18:26:08 INFO - Running post-action listener: _resource_record_post_action 18:26:08 INFO - Running post-action listener: _start_resource_monitoring 18:26:08 INFO - Starting resource monitoring. 18:26:08 INFO - ##### 18:26:08 INFO - ##### Finished create-virtualenv step (success) 18:26:08 INFO - ##### 18:26:08 INFO - ##### 18:26:08 INFO - ##### Running install step. 18:26:08 INFO - ##### 18:26:08 INFO - Running pre-action listener: _resource_record_pre_action 18:26:08 INFO - Running main action method: install 18:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:08 INFO - Reading from file tmpfile_stdout 18:26:08 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:08 INFO - Reading from file tmpfile_stdout 18:26:08 INFO - Output received: 18:26:08 INFO - Usage: mozinstall [options] installer 18:26:08 INFO - Options: 18:26:08 INFO - -h, --help show this help message and exit 18:26:08 INFO - -d DEST, --destination=DEST 18:26:08 INFO - Directory to install application into. [default: 18:26:08 INFO - "/builds/slave/test"] 18:26:08 INFO - --app=APP Application being installed. [default: firefox] 18:26:08 INFO - mkdir: /builds/slave/test/build/application 18:26:08 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'] 18:26:08 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 18:26:24 INFO - Reading from file tmpfile_stdout 18:26:24 INFO - Output received: 18:26:24 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:24 INFO - Running post-action listener: _resource_record_post_action 18:26:24 INFO - ##### 18:26:24 INFO - ##### Finished install step (success) 18:26:24 INFO - ##### 18:26:24 INFO - ##### 18:26:24 INFO - ##### Running run-tests step. 18:26:24 INFO - ##### 18:26:24 INFO - Running pre-action listener: _resource_record_pre_action 18:26:24 INFO - Running main action method: run_tests 18:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:24 INFO - Python 2.7.3 18:26:24 INFO - Return code: 0 18:26:24 INFO - grabbing minidump binary from tooltool 18:26: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')]} 18:26:24 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 0x26fe1c0>, '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 0x26ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ff550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:24 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 18:26:24 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 18:26:24 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 18:26:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:24 INFO - Return code: 0 18:26:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:26:25 INFO - Return code: 0 18:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:26:25 INFO - Using env: {'DISPLAY': ':0', 18:26:25 INFO - 'HOME': '/home/cltbld', 18:26:25 INFO - 'LANG': 'en_US.UTF-8', 18:26:25 INFO - 'LANGUAGE': 'en_US:en', 18:26:25 INFO - 'LOGNAME': 'cltbld', 18:26:25 INFO - 'MAIL': '/var/mail/cltbld', 18:26:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:25 INFO - 'MOZ_NO_REMOTE': '1', 18:26:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:25 INFO - 'NO_EM_RESTART': '1', 18:26:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:25 INFO - 'PWD': '/builds/slave/test', 18:26:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:25 INFO - 'SHELL': '/bin/bash', 18:26:25 INFO - 'SHLVL': '1', 18:26:25 INFO - 'TERM': 'linux', 18:26:25 INFO - 'TMOUT': '86400', 18:26:25 INFO - 'USER': 'cltbld', 18:26:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809', 18:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:25 INFO - '_': '/tools/buildbot/bin/python'} 18:26:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:26:25 INFO - mozversion application_buildid: 20160608170732 18:26:25 INFO - mozversion application_changeset: 249d57fa78a0522f63a5b1ed1fdda55f383156e0 18:26:25 INFO - mozversion application_display_name: Nightly 18:26:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:25 INFO - mozversion application_name: Firefox 18:26:25 INFO - mozversion application_remotingname: firefox 18:26:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:26:25 INFO - mozversion application_vendor: Mozilla 18:26:25 INFO - mozversion application_version: 50.0a1 18:26:25 INFO - mozversion platform_buildid: 20160608170732 18:26:25 INFO - mozversion platform_changeset: 249d57fa78a0522f63a5b1ed1fdda55f383156e0 18:26:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:26:25 INFO - mozversion platform_version: 50.0a1 18:26:25 INFO - using testdate: 1465435585 18:26:25 INFO - actual date: 1465435585 18:26:25 INFO - starting webserver on 'localhost:52483' 18:26:25 INFO - SUITE-START | Running 2 tests 18:26:25 INFO - TEST-START | dromaeo_css 18:26:25 INFO - operating with platform_type : linux_ 18:26:25 INFO - Initialising browser for dromaeo_css test... 18:26:25 INFO - TEST-INFO | started process 23645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6TnAsu/profile http://localhost:52483/getInfo.html) 18:26:30 INFO - PROCESS | 23645 | __metrics Screen width/height:1600/1200 18:26:30 INFO - PROCESS | 23645 | colorDepth:24 18:26:30 INFO - PROCESS | 23645 | Browser inner width/height: 1024/697 18:26:30 INFO - PROCESS | 23645 | __metrics 18:26:31 ERROR - PROCESS | 23645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:26:32 INFO - TEST-INFO | 23645: exit 0 18:26:32 INFO - Browser initialized. 18:26:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:32 INFO - TEST-INFO | started process 23765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6TnAsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:44 INFO - PROCESS | 23765 | RSS: Main: 168337408 18:26:44 INFO - PROCESS | 23765 | 18:27:33 INFO - PROCESS | 23765 | 1465435653723 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] 18:29:45 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52483/tests/dromaeo/cssquery-ext.html) 18:29:46 INFO - PROCESS | 23765 | RSS: Main: 170831872 18:29:46 INFO - PROCESS | 23765 | 18:32:48 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-ext.html (next: http://localhost:52483/tests/dromaeo/cssquery-jquery.html) 18:32:49 INFO - PROCESS | 23765 | RSS: Main: 169906176 18:32:49 INFO - PROCESS | 23765 | 18:35:50 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52483/tests/dromaeo/cssquery-mootools.html) 18:35:51 INFO - PROCESS | 23765 | RSS: Main: 171126784 18:35:51 INFO - PROCESS | 23765 | 18:38:53 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52483/tests/dromaeo/cssquery-prototype.html) 18:38:54 INFO - PROCESS | 23765 | RSS: Main: 168722432 18:38:54 INFO - PROCESS | 23765 | 18:41:56 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52483/tests/dromaeo/cssquery-yui.html) 18:41:57 INFO - PROCESS | 23765 | RSS: Main: 170971136 18:41:57 INFO - PROCESS | 23765 | 18:44:59 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-yui.html (next: http://localhost:52483/tests/dromaeo/cssquery-dojo.html) 18:45:00 INFO - PROCESS | 23765 | RSS: Main: 172019712 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | __start_tp_report 18:45:00 INFO - PROCESS | 23765 | _x_x_mozilla_page_load 18:45:00 INFO - PROCESS | 23765 | _x_x_mozilla_page_load_details 18:45:00 INFO - PROCESS | 23765 | |i|pagename|runs| 18:45:00 INFO - PROCESS | 23765 | |0;dojo.html;2640.6303117563543;2685.1675980446057;2709.4987427325946;2713.8371697698126;2718.8368697878127;4682.953170468294;4690.413698287714;4697.037107392985;4809.519048095189;4843.757812109398;4616.953830461703;4643.883902902429;4648.953985353294;4674;4725.196716558185;4314.892127696801;4324.783760811963;4336.392904993288;4426.336049592571;4431.202383570972;4303.397524346594;4307.095509942916;4344.695871289011;4396.670249731283;4444.2222611042935;624.1820195308569;4335.544767799367;4355.259605866979;4358.4987726411555;4424.181526417607;4297.03316753731;4299.50555686097;4317.676174286941;4347.260965635849;4351.260285751398;4269.466316710411;4272.188284225987;4291.270484017725;4301.397804307399;4332.480102387703;4521.231390663562;4521.502634710179;4560;4607.0325231701045;4630.351750754897;5040.621953353477;5040.747962601892;5046.772895219724;5050.4697006814495;5094.5160209780015;5086.16078347076;5089.720065396402;5095;5104.897902041938;5135.075686376451;4661.394018777572;4683.601893838993;4689.531046895283;4700.130475861976;4749.121412538657;5113.054084994214;5116.74416279192;5125.384953805493;5130.4356520782685;5180.533751962342;4796.664233503621;4895.755212239374;4902.558769710672;4904.730239836772;4949.925751113737;4939;5087.516685914832;5125.333706618116;5139.897202055938;5147.794088236504;5033.798648054037;5081.161608334657;5086.745662716849;5093.414257360377;5127;4821.083994041121;5072.340595722532;5078.390593128848;5091.847244582668;5105.055564720538;4084.387341898739;4189.371594260824;4193.329067349209;4197.139586384845;4198.769067701244;3697.519322488113;3704.8518059277867;3710.220853620716;3717.2565486902186;3754.737168398186;4286.292761694348;4478.104379124188;4525.094981003813;4525.841595544141;4531.320301954667;5049.873753156127;5067.721275329893;5118.257852611425;5140.820071297561;5154.587632989352;4436.955630443655;4461.464624245112;4483.75339356332;4484.506704262529;4490.461144662661;4389.4513185851765;4492.303692927601;4514.68397212192;4549.476810166807;4556.703814252063;4798.208295631322;4813.3983252093485;4823.517648235148;4839;4909.214525675875;5055.115354812967;5066.695998240118;5086.237064440215;5101.158308879142;5102.438731739431;4652.209124448784;4822.8794280143275;4828.734419606955;4834.178189707688;4887.804487820447;5050.343455350928;5076.593872490266;5076.949230507647;5090.669106508065;5129.256257842667;5149.742512874416;5152.613553983541;5157.6647517911215;5169.06956747789;5178.378594568676;4832.8791780205775;4841.588464980516;4862.878428039327;4894.730789806595;4978.30303757467;4870.512948705101;4871.707697538159;4876.731779752147;4895.6083513318135;4920;4801.9039619208115;4807.326974223682;4811.951880481291;4836.250381190921;4845.1520983828395;4758;4768.070226305837;4892.0705066037335;4936.160852655129;4940.752962351796;4793.49668284839;4805.37530121082;4807.855764327076;4825.541573550507;4869.0261947609915 18:45:00 INFO - PROCESS | 23765 | |1;ext.html;560.5403569073359;572.8768314812314;576.4466112531969;581.77601623375;597.160988810721;35756.46365304519;40060.399094013614;40313.99215019622;40327.19345613086;40350.39474407886;39737.20525589486;40264.19471610573;40290.59709402905;40319.79840100795;40488.595114048854;7645.617719114036;7764.456488045839;7780.6887724491235;7787.454878158531;7815.218478152196;7616.581088040156;7733.342665873408;7752.224777522231;7775.883361749578;7776.688932442724;7576.318131368176;7608.543487390774;7613;7614.73348432805;7626.542407455543;7686.423518236154;7727.690892364299;7730.729424470144;7739.9613001935195;7761.650725717356;7675.577843218621;7707.421943354271;7752.186020467826;7754.263344982218;7755.2632499912415;36290.63709362899;36551.26897462062;36554;36675.449868252;36796.81601592002;2630.9605355919675;3079.230192451887;3205.0705295464286;3272.280098378353;3582.22982058856;28184.718152818416;29648.8517557413;30026.699733002828;30104.849475752482;30211.546826797614;3532.8586856525967;3551.893443196708;3581.855764130883;3611.981940090309;3642.908927276813;252928;253462;254454.72772636203;254768;254946;32451.18872028218;33369.83315083409;53740.73129634327;53854;54242.18636720452;33813.154671133416;34281.657183428346;34316;34389.65610343865;34405.139871503416;12785.552505662257;12932.741345173044;12947;13045.804312935314;13093.148945318524;11397.145214108976;11418.200725949104;11455.312681238986;11468.885311146949;11521.942390287995;7953.761387158394;7980.122186559473;8026.317762990211;8087;8113.107558168596;3068.9079327620207;3092.3196896682693;3151.0861850063225;3161.9525707114412;3169.8256595887447;920.5535315372039;933.780561568031;1016.6884718712926;1020.505055048301;1074.3607553505651;27945;28141.71858281432;28487.857560712062;28895;29080.418391632047;974.2595627323285;982.6413359123868;1035.2390992620417;1035.8860525342207;1040.7450174707244;15146.469873554373;15163.848361516244;15225.695486090437;15445.922770386076;15477;359950;362761;362966;363199;363612;49240.261396079084;49663.50336496661;49704.25443618349;49854;49860.75069624629;1210.6005018343926;1221.2550344289975;1255.7865162922326;1257.792464243408;1264.7849865523067;26854.328641784112;28167.57748633813;28289;28496.43007139804;28774.42451151007;38264;43709.34435983526;44085.11829763451;44107.779461103775;44178.779106104266;343869;345759;346141;347903;348121;25080.37299067538;25183.622245665963;25292.74707252904;25710;25889.870550647127;41702.58297416987;41871;42041;42248;42349.78825105855;36259.45610815787;37268;37564.24871502609;37778.244435111694;38309.808450957564;35512.46731298981;36203.09492262715;36720.63279367172;36741.44887826631;36906.63093369032;30539.389212216076;34599.19408865073;35244.47133293054;35772;36502.8174859124;31224.063278101694;32370.35259294848;32529.512057318687;34332.14169645779;34577.13557161091;25087.498250035263;25443.36391590225;25566.360840979123;25607.743922560538;25917.6112358311 18:45:00 INFO - PROCESS | 23765 | |2;jquery.html;344.3612099555325;356.8750937171989;360.963903609639;367.874922526341;380.6098748782499;15461.768073478892;16323.428679996203;17243.05163216024;17293.481195564153;17385.391511297108;13991.860081399209;15066.3220155093;15111.319990600421;15164.165970871598;15207.239638018082;4636;5075.340205773245;5080.695158290496;5091.287219789214;5093.745312734349;3687.870924517629;4984.177610694231;5564.4713752193675;5820.738066786984;5853.619514731528;5884.823455296327;5894.204282421882;5895.557833162508;5902.380250073745;5908.734106965197;5724.370319264877;5960.403959604048;5967.522598192134;5974.193483879664;5986.102084687288;4548.295014272793;5161.638685292031;5182.196759502283;5212.687238765686;5248.501392367719;16263.186840658038;16279.430219942364;16393.34426622934;16428.507144785555;20167;1891.5838515526561;1907.9618407631908;1929.2379510093574;2021.3329601231558;2058.9176432942663;8914.108589141098;9079.137481939206;9302.348835581512;9323.300752443525;9340.019297973682;1634.517817243916;1753.877228593999;1776.0853160622162;1776.8312010359125;1815.5370380552874;47335.76332118352;67942.66028669824;67971.320286797;68713;70084.29915700828;9667.129958303787;9695.418274903528;9887.604495820087;9909.972367756418;10641.255112142077;13598.320083995959;13673.589792306248;13762.311884405939;13777.793333100011;13784;7459.36595389398;7525.473216874766;7540.698372065166;7569.659365328574;7719.65261563231;7196.532225405332;7202.603856787822;7273.8545229095125;7340.486165968331;7406.518576292524;4256.34026725858;4279.593438623326;4313.102235016583;4320.265554855682;4340.587644173798;1678.8237235090385;1687.8565321947772;1804.3955274982766;1824.6806808808406;1831.1851226204478;778.7936196907824;840.1598401598402;870.7344260000634;874.2961915657829;990.0248255468358;16214.51356459308;16216.918915405347;16357.182140892908;16561.83438165627;16769.413070542472;878.3017501086524;881.7839629290736;887.9023307436177;898.2948385517337;948.5399581203111;9082;9189.63241470347;9289.814203716023;9457.810843783085;9569.808603828023;379606;398169;398491;400326;404316;82705.58647206725;84092;85418.57290713632;86114.56942715247;87747;949.107838631684;957.411192116857;970.2965350121247;970.5001924009282;990.3562684255292;15260.847391525942;15267.3893044277;15297.235138243266;15297.388104475696;15773.132477713836;35745.642543574235;36486.63513364832;36525.63474365329;37121.443178352885;37127.62872371242;49803.75098124486;51969.22046169235;52715.472845271055;53238.4676153249;53386.46613533815;7567.772966811004;7675.117361503499;7750.302472777477;7872.645730942236;7994.320482759031;10766.192535560021;11156.832647510131;11436.256643318158;11626.825597615873;11830.290182589073;10674.83987740169;10743.838842417526;10750.784984300113;10920.56317747313;11032.503537340679;10627.309224900357;10745.570177193138;11047.668569942914;11153;11172.497237624164;10972.122230221403;11021.614243501439;11119.27724697892;11313.151513636345;11324.32054076758;7871.606419679108;7923.524588524707;8023.237792409712;8208.630611622611;8346.666133354598;9597.184239339455;10989.780204395707;11083.72290692739;11091.223614346918;11168.66494005181 18:45:00 INFO - PROCESS | 23765 | |3;mootools.html;1391.6381740747406;1431.3272761801952;1519.2024187301665;1646.9341226350946;1718.312674930028;6754.898676519844;7214.711411543545;7654.655540500677;8268.46254993425;8277.503349799017;7303.488755787097;7567.62161891906;7657.157712651618;7661.310482056628;7664.1952594977565;2089.247870766527;2117.9894100529477;2122.352682431858;2122.384508492535;2125.829933605308;2087.6242276390244;2126.2345555599973;2139.871607703543;2140.176032227596;2140.8180304674042;2094.7695753467106;2096.0986775686447;2109.377733568593;2121.8514703970727;2145.570885822834;2065.5455799724036;2077.8441616878717;2079.7088407622946;2089.0599230346406;2097.895105244739;2026.3110542415502;2035.3486884197064;2070.3167954574956;2079.792020797923;2094.5915546468445;7499.850002999964;7564;7573.659185336673;7608.581528015957;7621.466497345188;4391.956080439219;4508.188526065307;4533.070720502289;4544.545545445462;4564.726116433025;2685.4827022732093;2748.7800975922078;2766.7233276672373;2816.281848128714;2849.7577705895023;875.916787905148;901.8016036471965;912.2246090822748;916.6196028648103;919.7516670498928;10732.409717465536;10755.83866242007;10773.35359878402;10793;10795.46022698862;4012.4583181270154;4015;4088.264112459726;4102.323116685713;4121.4848143982;9126.26989840811;9176.08239176077;9201.677941272023;9220.90779092214;9237.07629237071;4367.235733746646;4420.469543654782;4435.3125265583885;4443.955560444354;4448.110377924428;3528.364894318996;4028.738132021409;4033.213523362916;4064.2684316822665;4206.11671548972;3513.1744040151057;3534.6317966961683;3583.8028908409765;3627.3108109459117;3647.562292524914;1129.5312445335258;1136.6987748246722;1143.2740209966564;1146.4439746722833;1148.8396719313553;773.7872085176622;812.8699408094794;813.3980854167874;843.8101427178835;848.4951453884929;5214.113600687892;5279.392869819943;5297.5232229099565;5433.972830135824;5514.393416724157;871.333429926107;872.3457406944791;896.1665650944553;916.0244339778116;940.1209868772719;3537.327907697529;3593.3531964246686;3621.1309285771226;3678.2459595782802;3693.298273328059;9032.954835225913;9275.95362023199;9311.813763724687;9314.115159059878;9373.812523749486;9134.086591340945;9135.40619859707;9192.21866141372;9204.171624553688;9261.536923153815;7338.77983660491;7382.040334756554;7441.107067151868;7441.776746697607;7468.365188958999;5309.46905309466;5394.9460505394445;5412.891742165213;5494.203340515683;5497.780088796403;8644.697435589724;8958.552072396484;9024.142706442877;9034.503102329172;9141.862872056792;9001.234895033733;9090;9133.634654613741;9159.633614655606;9287.117723816227;5977.9103313451205;6692.966535167293;6874.381305682513;6934.791956241321;7036.718531258897;7577.848443031219;7632.274933881273;7678.193789652006;7697.88453173214;7704.036995375578;6696.430803381767;6834.1457317835275;6953.096097507291;6984.196817366068;6991.860162796817;6586.077949087227;6679.265280819203;6719.992001199859;6734.966325168539;6754.527183097136;6282.120503129474;6302.495800336053;6396.808095757135;6410.358964103552;6454.548181627429;4463.977680111579;4621.514740952151;4632.490426053064;4642.744649044335;4643.187442197669;4394.494633117105;4460.487043989853;4495.43807024122;4563.429571303587;4566 18:45:00 INFO - PROCESS | 23765 | |4;prototype.html;274.97800175985924;277.091141057332;284.7110183164088;288.18300119162177;288.9494338490765;4772.689775164612;4829.541193586608;4834.274858771186;4927.630427717922;4949.901001979958;4821.987382649648;4857.344258525098;4864.7324397158145;4900.950990490094;4921.843366808797;3815.599362066978;3818.618138186187;3833.1950290438904;3836.5396152461603;3853.1312313527915;3544.4683297505453;3837.1366442550484;3838.2323535292912;3852.9036774080732;3870.1098747288142;3678.337899178147;3715.9628403716024;3723.1995121048967;3733.2720119576693;3742.943855842151;3729.5710993235853;3737.2808508086314;3743.2139250757373;3746.2882052410228;3750.456183853353;3148.3703259347994;3248.31785325082;3260.4131256373844;3262.2659901522206;3275.852586633607;4669.836555720567;4679.60223381013;4683.274092515666;4724.12603668319;4742.596879265232;4250.659947204216;4267.4025636410925;4274.358846173068;4274.935875961863;4279.550647182064;4994.525520075587;5058.46886076964;5110.10573149701;5128.820491282824;5135.794568217267;3507.5089487471773;3516.4549494828343;3536.2142118230386;3540.5928318243473;3556.982215088934;5375.3280839895015;5413.729313534308;5426.864328391743;5429.425466614677;5434.701091439969;3575.8021062944204;3596.345680986723;3605.008622628746;3605.0987253186704;3607.3867442534834;3491.114798009047;3648.9418068759765;3673.1368128489785;3678.4850120983083;3683.6684698377276;4207.810648520824;4251.4685664291965;4262.914741705148;4267.25323068468;4274.850380236677;5161.812783059842;5197.870053248624;5207.505286997729;5217.478252174828;5221.738913054332;1183.3432444993111;1276.5468258768003;1297.8247936528637;1307.6142537951328;1311.8294621699308;833.98332033359;837.367787320569;837.9329653627696;849.1423662101322;850.8596081646459;4016.6987475939422;4085.3871919212356;4131.566185550534;4133.297339452301;4163.2298024865495;4732.574068333866;4738.289256611467;4755;4763.237881938942;4777.641676874248;4098.323776576891;4146.3365861462025;4146.626803587692;4168.541460439349;4219.9578004220175;2552.731963143843;2593.9092131775296;2823.661160660734;2834.2489240351324;2859.170840456286;5048.697078175322;5059.418166910778;5071.594272458195;5080.5681517070725;5086.626610815059;5336.839894803162;5463.617546771768;5480.095784195642;5484.203056441164;5487.780488780404;4980.352554167935;4994.1759609663995;5026.44709082008;5030.37120359955;5056.873578160502;5293.682379057269;5306.734663266899;5329.387120481039;5354.473974917286;5363.383210930637;5005.549500544823;5140.820071297487;5219.895602087861;5226;5232.9738351308;5063.696178229318;5068.442471328077;5074.035933172685;5075.213341932006;5101.362329708786;3585.5338805955057;3604.7837129772297;3609.711223102093;3614.1145419372424;3631.5097461842315;5231.424543300158;5345.572354211731;5351.705656188947;5351.812686555952;5357.142857142839;5078.669886457516;5109.054824857413;5124.769385377742;5143.228515722672;5161.974190129175;5116.795328186831;5126.641135120506;5149.382074150976;5160.509751573594;5171.3535808024;4828.468868424541;5031.471695472069;5079.339685840965;5091.974540127276;5108.872278193075;5199.610029247746;5215.713135777569;5221.660592061504;5229.555487783581;5233.528982391603;5112.284280200849;5121.667091639031;5127.6410651254055;5131.92302115476;5131.92302115476 18:45:00 INFO - PROCESS | 23765 | |5;yui.html;602.9186059881914;693.9590614078882;725.9818504537386;734.1520543771945;764.0563903579081;11625.825612615807;12570.371481425915;12619.864212220898;12684.365781710912;12828.16616919902;12730.236185828857;13077.934610326958;13311.400986955587;13394.196348219113;13409.932950335258;627.7771391156142;767.7811823630267;768.2010708862804;785.9449838511307;795.761271618515;790.7192946503994;794.3764145146062;797.513516754782;800.2837460472873;802.2779498451382;834.5993922917004;837.983240335196;838.1325328285226;838.7944953486405;839.5172775653992;827.6275675945818;830.2030051150903;830.5639539241886;832.1553623072587;834.5493433545878;607.8055022392836;608.4554323880103;608.5071092415158;608.9634621922654;609.439315829438;13387.732245355135;13400.329983500786;13411.865881341158;13433.798493022612;13447.394867230998;13362.465501379933;13364.131331463424;13472.797908031387;13551.051426400156;14050.648733781738;10632.893671063344;10652.307600005975;10739.355638661706;10781.514831832508;10872.45637718111;3397.915052123692;3400.897973060812;3413.7781044232293;3443.3113377324385;3535.9646403535894;59230.40769592249;59533;59550.70224648892;59806.10290845641;59858.700706496624;10107.191424686007;10155.644552440777;10206.642767503101;10207.030332118436;10386.169106471616;18911.527211819815;19000.429987100408;19022.524436889187;19042.714359284622;19072.71390929137;6243.875122497525;6452.806415807533;6534.705938232791;6535.836604084936;6537.117489139;3432.7597068204986;3567.0547304964207;3585.515955346047;3590.676839084495;3600.9279814403567;2585.146901522493;2672.3319170207446;2681.1956413076;2689.3007817967077;2699.082312013925;477.0411472939347;483.6662702735102;485.1243505472656;487.68787975695585;502.1012387825824;555.4584280326649;567.4665814134701;573.4065242474103;574.0757380617202;581.61425202624;7576.962115189389;7963.243491868263;7992.200779921961;8044.83910321802;8149.429539932148;510.4308695804226;512.2469969145351;512.5463964391466;537.5135502370362;570.4067769519736;3404.676555727202;3468.2023134679166;3544.379733546619;3558.3061303045656;3581.910452238663;84825.57587212024;86460.56769716111;86594.56702716446;86917;88586;76876;77473.18951078692;77789.61105194438;78660;79102.6044869772;69821.30178698148;70098.29901700918;70564.29435705577;70913.64543177251;71079.64460177769;7085.2560481150795;7168.749093781693;7208.56748595065;7244.855102897807;7308.488405811542;43130.353044704985;43257.78371108124;43575.98876129286;44245.33631995587;44585.10829783451;56697;59581.40418595759;60161.39838601733;60189.69905150446;60308.396916032034;9007.279417646703;9075.092490750872;9328.953355233452;9364.344495885223;9401.153896149379;9890.406575605486;9995.650152244636;10156.89843101589;10490.580376784843;10643.733906652396;9431.198348140484;9577.329586928849;9752.414855108716;9796.559154838193;9840.753981150528;9899;9928.205743540644;9941;9954.502274886081;10143.898561014295;9614;9659;9689.563969621244;9733.513324333897;9749.658761943298;8125.512469251627;8281.627326770431;8334.166583341617;8379.83240335202;8433.451825631315;7702.961485192763;7790.571518566533;7812.101608315116;7871.33093687043;8005.07941586725 18:45:00 INFO - PROCESS | 23765 | __end_tp_report 18:45:00 INFO - PROCESS | 23765 | __start_cc_report 18:45:00 INFO - PROCESS | 23765 | _x_x_mozilla_cycle_collect,382 18:45:00 INFO - PROCESS | 23765 | __end_cc_report 18:45:00 INFO - PROCESS | 23765 | __startTimestamp1465436700187__endTimestamp 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | ------- Summary: start ------- 18:45:00 INFO - PROCESS | 23765 | Number of tests: 6 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#0] dojo.html Cycles:165 Average:4648.14 Median:4809.52 stddev:582.10 (12.1%) stddev-sans-first:562.18 18:45:00 INFO - PROCESS | 23765 | Values: 2640.6 2685.2 2709.5 2713.8 2718.8 4683.0 4690.4 4697.0 4809.5 4843.8 4617.0 4643.9 4649.0 4674.0 4725.2 4314.9 4324.8 4336.4 4426.3 4431.2 4303.4 4307.1 4344.7 4396.7 4444.2 624.2 4335.5 4355.3 4358.5 4424.2 4297.0 4299.5 4317.7 4347.3 4351.3 4269.5 4272.2 4291.3 4301.4 4332.5 4521.2 4521.5 4560.0 4607.0 4630.4 5040.6 5040.7 5046.8 5050.5 5094.5 5086.2 5089.7 5095.0 5104.9 5135.1 4661.4 4683.6 4689.5 4700.1 4749.1 5113.1 5116.7 5125.4 5130.4 5180.5 4796.7 4895.8 4902.6 4904.7 4949.9 4939.0 5087.5 5125.3 5139.9 5147.8 5033.8 5081.2 5086.7 5093.4 5127.0 4821.1 5072.3 5078.4 5091.8 5105.1 4084.4 4189.4 4193.3 4197.1 4198.8 3697.5 3704.9 3710.2 3717.3 3754.7 4286.3 4478.1 4525.1 4525.8 4531.3 5049.9 5067.7 5118.3 5140.8 5154.6 4437.0 4461.5 4483.8 4484.5 4490.5 4389.5 4492.3 4514.7 4549.5 4556.7 4798.2 4813.4 4823.5 4839.0 4909.2 5055.1 5066.7 5086.2 5101.2 5102.4 4652.2 4822.9 4828.7 4834.2 4887.8 5050.3 5076.6 5076.9 5090.7 5129.3 5149.7 5152.6 5157.7 5169.1 5178.4 4832.9 4841.6 4862.9 4894.7 4978.3 4870.5 4871.7 4876.7 4895.6 4920.0 4801.9 4807.3 4812.0 4836.3 4845.2 4758.0 4768.1 4892.1 4936.2 4940.8 4793.5 4805.4 4807.9 4825.5 4869.0 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#1] ext.html Cycles:180 Average:46446.31 Median:3582.04 stddev:85539.87 (2388.0%) stddev-sans-first:85710.45 18:45:00 INFO - PROCESS | 23765 | Values: 560.5 572.9 576.4 581.8 597.2 35756.5 40060.4 40314.0 40327.2 40350.4 39737.2 40264.2 40290.6 40319.8 40488.6 7645.6 7764.5 7780.7 7787.5 7815.2 7616.6 7733.3 7752.2 7775.9 7776.7 7576.3 7608.5 7613.0 7614.7 7626.5 7686.4 7727.7 7730.7 7740.0 7761.7 7675.6 7707.4 7752.2 7754.3 7755.3 36290.6 36551.3 36554.0 36675.4 36796.8 2631.0 3079.2 3205.1 3272.3 3582.2 28184.7 29648.9 30026.7 30104.8 30211.5 3532.9 3551.9 3581.9 3612.0 3642.9 252928.0 253462.0 254454.7 254768.0 254946.0 32451.2 33369.8 53740.7 53854.0 54242.2 33813.2 34281.7 34316.0 34389.7 34405.1 12785.6 12932.7 12947.0 13045.8 13093.1 11397.1 11418.2 11455.3 11468.9 11521.9 7953.8 7980.1 8026.3 8087.0 8113.1 3068.9 3092.3 3151.1 3162.0 3169.8 920.6 933.8 1016.7 1020.5 1074.4 27945.0 28141.7 28487.9 28895.0 29080.4 974.3 982.6 1035.2 1035.9 1040.7 15146.5 15163.8 15225.7 15445.9 15477.0 359950.0 362761.0 362966.0 363199.0 363612.0 49240.3 49663.5 49704.3 49854.0 49860.8 1210.6 1221.3 1255.8 1257.8 1264.8 26854.3 28167.6 28289.0 28496.4 28774.4 38264.0 43709.3 44085.1 44107.8 44178.8 343869.0 345759.0 346141.0 347903.0 348121.0 25080.4 25183.6 25292.7 25710.0 25889.9 41702.6 41871.0 42041.0 42248.0 42349.8 36259.5 37268.0 37564.2 37778.2 38309.8 35512.5 36203.1 36720.6 36741.4 36906.6 30539.4 34599.2 35244.5 35772.0 36502.8 31224.1 32370.4 32529.5 34332.1 34577.1 25087.5 25443.4 25566.4 25607.7 25917.6 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#2] jquery.html Cycles:180 Average:24530.38 Median:4444.44 stddev:65525.91 (1474.3%) stddev-sans-first:65684.56 18:45:00 INFO - PROCESS | 23765 | Values: 344.4 356.9 361.0 367.9 380.6 15461.8 16323.4 17243.1 17293.5 17385.4 13991.9 15066.3 15111.3 15164.2 15207.2 4636.0 5075.3 5080.7 5091.3 5093.7 3687.9 4984.2 5564.5 5820.7 5853.6 5884.8 5894.2 5895.6 5902.4 5908.7 5724.4 5960.4 5967.5 5974.2 5986.1 4548.3 5161.6 5182.2 5212.7 5248.5 16263.2 16279.4 16393.3 16428.5 20167.0 1891.6 1908.0 1929.2 2021.3 2058.9 8914.1 9079.1 9302.3 9323.3 9340.0 1634.5 1753.9 1776.1 1776.8 1815.5 47335.8 67942.7 67971.3 68713.0 70084.3 9667.1 9695.4 9887.6 9910.0 10641.3 13598.3 13673.6 13762.3 13777.8 13784.0 7459.4 7525.5 7540.7 7569.7 7719.7 7196.5 7202.6 7273.9 7340.5 7406.5 4256.3 4279.6 4313.1 4320.3 4340.6 1678.8 1687.9 1804.4 1824.7 1831.2 778.8 840.2 870.7 874.3 990.0 16214.5 16216.9 16357.2 16561.8 16769.4 878.3 881.8 887.9 898.3 948.5 9082.0 9189.6 9289.8 9457.8 9569.8 379606.0 398169.0 398491.0 400326.0 404316.0 82705.6 84092.0 85418.6 86114.6 87747.0 949.1 957.4 970.3 970.5 990.4 15260.8 15267.4 15297.2 15297.4 15773.1 35745.6 36486.6 36525.6 37121.4 37127.6 49803.8 51969.2 52715.5 53238.5 53386.5 7567.8 7675.1 7750.3 7872.6 7994.3 10766.2 11156.8 11436.3 11626.8 11830.3 10674.8 10743.8 10750.8 10920.6 11032.5 10627.3 10745.6 11047.7 11153.0 11172.5 10972.1 11021.6 11119.3 11313.2 11324.3 7871.6 7923.5 8023.2 8208.6 8346.7 9597.2 10989.8 11083.7 11091.2 11168.7 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#3] mootools.html Cycles:180 Average:5101.03 Median:5423.43 stddev:2875.55 (53.0%) stddev-sans-first:2870.10 18:45:00 INFO - PROCESS | 23765 | Values: 1391.6 1431.3 1519.2 1646.9 1718.3 6754.9 7214.7 7654.7 8268.5 8277.5 7303.5 7567.6 7657.2 7661.3 7664.2 2089.2 2118.0 2122.4 2122.4 2125.8 2087.6 2126.2 2139.9 2140.2 2140.8 2094.8 2096.1 2109.4 2121.9 2145.6 2065.5 2077.8 2079.7 2089.1 2097.9 2026.3 2035.3 2070.3 2079.8 2094.6 7499.9 7564.0 7573.7 7608.6 7621.5 4392.0 4508.2 4533.1 4544.5 4564.7 2685.5 2748.8 2766.7 2816.3 2849.8 875.9 901.8 912.2 916.6 919.8 10732.4 10755.8 10773.4 10793.0 10795.5 4012.5 4015.0 4088.3 4102.3 4121.5 9126.3 9176.1 9201.7 9220.9 9237.1 4367.2 4420.5 4435.3 4444.0 4448.1 3528.4 4028.7 4033.2 4064.3 4206.1 3513.2 3534.6 3583.8 3627.3 3647.6 1129.5 1136.7 1143.3 1146.4 1148.8 773.8 812.9 813.4 843.8 848.5 5214.1 5279.4 5297.5 5434.0 5514.4 871.3 872.3 896.2 916.0 940.1 3537.3 3593.4 3621.1 3678.2 3693.3 9033.0 9276.0 9311.8 9314.1 9373.8 9134.1 9135.4 9192.2 9204.2 9261.5 7338.8 7382.0 7441.1 7441.8 7468.4 5309.5 5394.9 5412.9 5494.2 5497.8 8644.7 8958.6 9024.1 9034.5 9141.9 9001.2 9090.0 9133.6 9159.6 9287.1 5977.9 6693.0 6874.4 6934.8 7036.7 7577.8 7632.3 7678.2 7697.9 7704.0 6696.4 6834.1 6953.1 6984.2 6991.9 6586.1 6679.3 6720.0 6735.0 6754.5 6282.1 6302.5 6396.8 6410.4 6454.5 4464.0 4621.5 4632.5 4642.7 4643.2 4394.5 4460.5 4495.4 4563.4 4566.0 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#4] prototype.html Cycles:180 Average:4210.55 Median:4799.81 stddev:1260.18 (26.3%) stddev-sans-first:1228.61 18:45:00 INFO - PROCESS | 23765 | Values: 275.0 277.1 284.7 288.2 288.9 4772.7 4829.5 4834.3 4927.6 4949.9 4822.0 4857.3 4864.7 4901.0 4921.8 3815.6 3818.6 3833.2 3836.5 3853.1 3544.5 3837.1 3838.2 3852.9 3870.1 3678.3 3716.0 3723.2 3733.3 3742.9 3729.6 3737.3 3743.2 3746.3 3750.5 3148.4 3248.3 3260.4 3262.3 3275.9 4669.8 4679.6 4683.3 4724.1 4742.6 4250.7 4267.4 4274.4 4274.9 4279.6 4994.5 5058.5 5110.1 5128.8 5135.8 3507.5 3516.5 3536.2 3540.6 3557.0 5375.3 5413.7 5426.9 5429.4 5434.7 3575.8 3596.3 3605.0 3605.1 3607.4 3491.1 3648.9 3673.1 3678.5 3683.7 4207.8 4251.5 4262.9 4267.3 4274.9 5161.8 5197.9 5207.5 5217.5 5221.7 1183.3 1276.5 1297.8 1307.6 1311.8 834.0 837.4 837.9 849.1 850.9 4016.7 4085.4 4131.6 4133.3 4163.2 4732.6 4738.3 4755.0 4763.2 4777.6 4098.3 4146.3 4146.6 4168.5 4220.0 2552.7 2593.9 2823.7 2834.2 2859.2 5048.7 5059.4 5071.6 5080.6 5086.6 5336.8 5463.6 5480.1 5484.2 5487.8 4980.4 4994.2 5026.4 5030.4 5056.9 5293.7 5306.7 5329.4 5354.5 5363.4 5005.5 5140.8 5219.9 5226.0 5233.0 5063.7 5068.4 5074.0 5075.2 5101.4 3585.5 3604.8 3609.7 3614.1 3631.5 5231.4 5345.6 5351.7 5351.8 5357.1 5078.7 5109.1 5124.8 5143.2 5162.0 5116.8 5126.6 5149.4 5160.5 5171.4 4828.5 5031.5 5079.3 5092.0 5108.9 5199.6 5215.7 5221.7 5229.6 5233.5 5112.3 5121.7 5127.6 5131.9 5131.9 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - PROCESS | 23765 | [#5] yui.html Cycles:180 Average:16564.84 Median:608.13 stddev:23499.85 (3864.3%) stddev-sans-first:23535.21 18:45:00 INFO - PROCESS | 23765 | Values: 602.9 694.0 726.0 734.2 764.1 11625.8 12570.4 12619.9 12684.4 12828.2 12730.2 13077.9 13311.4 13394.2 13409.9 627.8 767.8 768.2 785.9 795.8 790.7 794.4 797.5 800.3 802.3 834.6 838.0 838.1 838.8 839.5 827.6 830.2 830.6 832.2 834.5 607.8 608.5 608.5 609.0 609.4 13387.7 13400.3 13411.9 13433.8 13447.4 13362.5 13364.1 13472.8 13551.1 14050.6 10632.9 10652.3 10739.4 10781.5 10872.5 3397.9 3400.9 3413.8 3443.3 3536.0 59230.4 59533.0 59550.7 59806.1 59858.7 10107.2 10155.6 10206.6 10207.0 10386.2 18911.5 19000.4 19022.5 19042.7 19072.7 6243.9 6452.8 6534.7 6535.8 6537.1 3432.8 3567.1 3585.5 3590.7 3600.9 2585.1 2672.3 2681.2 2689.3 2699.1 477.0 483.7 485.1 487.7 502.1 555.5 567.5 573.4 574.1 581.6 7577.0 7963.2 7992.2 8044.8 8149.4 510.4 512.2 512.5 537.5 570.4 3404.7 3468.2 3544.4 3558.3 3581.9 84825.6 86460.6 86594.6 86917.0 88586.0 76876.0 77473.2 77789.6 78660.0 79102.6 69821.3 70098.3 70564.3 70913.6 71079.6 7085.3 7168.7 7208.6 7244.9 7308.5 43130.4 43257.8 43576.0 44245.3 44585.1 56697.0 59581.4 60161.4 60189.7 60308.4 9007.3 9075.1 9329.0 9364.3 9401.2 9890.4 9995.7 10156.9 10490.6 10643.7 9431.2 9577.3 9752.4 9796.6 9840.8 9899.0 9928.2 9941.0 9954.5 10143.9 9614.0 9659.0 9689.6 9733.5 9749.7 8125.5 8281.6 8334.2 8379.8 8433.5 7703.0 7790.6 7812.1 7871.3 8005.1 18:45:00 INFO - PROCESS | 23765 | -------- Summary: end -------- 18:45:00 INFO - PROCESS | 23765 | 18:45:00 INFO - TEST-INFO | 23765: exit 0 18:45:00 INFO - TEST-OK | dromaeo_css | took 1115267ms 18:45:00 INFO - TEST-START | kraken 18:45:00 INFO - operating with platform_type : linux_ 18:45:00 INFO - Initialising browser for kraken test... 18:45:00 INFO - TEST-INFO | started process 24003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXACwBS/profile http://localhost:52483/getInfo.html) 18:45:05 INFO - PROCESS | 24003 | __metrics Screen width/height:1600/1200 18:45:05 INFO - PROCESS | 24003 | colorDepth:24 18:45:05 INFO - PROCESS | 24003 | Browser inner width/height: 1024/697 18:45:05 INFO - PROCESS | 24003 | __metrics 18:45:05 ERROR - PROCESS | 24003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:45:06 INFO - TEST-INFO | 24003: exit 0 18:45:06 INFO - Browser initialized. 18:45:06 INFO - Running cycle 1/1 for kraken test... 18:45:06 INFO - TEST-INFO | started process 24121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXACwBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:18 INFO - PROCESS | 24121 | RSS: Main: 168849408 18:45:18 INFO - PROCESS | 24121 | 18:45:21 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:22 INFO - PROCESS | 24121 | RSS: Main: 173236224 18:45:22 INFO - PROCESS | 24121 | 18:45:25 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-dft) 18:45:25 INFO - PROCESS | 24121 | RSS: Main: 173297664 18:45:25 INFO - PROCESS | 24121 | 18:45:28 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-fft) 18:45:29 INFO - PROCESS | 24121 | RSS: Main: 168099840 18:45:29 INFO - PROCESS | 24121 | 18:45:31 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-oscillator) 18:45:32 INFO - PROCESS | 24121 | RSS: Main: 168468480 18:45:32 INFO - PROCESS | 24121 | 18:45:34 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:35 INFO - PROCESS | 24121 | RSS: Main: 168902656 18:45:35 INFO - PROCESS | 24121 | 18:45:38 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:39 INFO - PROCESS | 24121 | RSS: Main: 169213952 18:45:39 INFO - PROCESS | 24121 | 18:45:42 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:43 INFO - PROCESS | 24121 | RSS: Main: 167100416 18:45:43 INFO - PROCESS | 24121 | 18:45:46 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52483/tests/kraken/driver.html?testName=json-parse-financial) 18:45:46 INFO - PROCESS | 24121 | RSS: Main: 168353792 18:45:46 INFO - PROCESS | 24121 | 18:45:48 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:49 INFO - PROCESS | 24121 | RSS: Main: 168886272 18:45:49 INFO - PROCESS | 24121 | 18:45:50 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:51 INFO - PROCESS | 24121 | RSS: Main: 168660992 18:45:51 INFO - PROCESS | 24121 | 18:45:53 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:54 INFO - PROCESS | 24121 | RSS: Main: 169148416 18:45:54 INFO - PROCESS | 24121 | 18:45:57 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:57 INFO - PROCESS | 24121 | RSS: Main: 169418752 18:45:57 INFO - PROCESS | 24121 | 18:46:00 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:01 INFO - PROCESS | 24121 | RSS: Main: 169709568 18:46:01 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52483/tests/kraken/driver.html?testName=ai-astar) 18:46:03 INFO - PROCESS | 24121 | RSS: Main: 170889216 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | __start_tp_report 18:46:03 INFO - PROCESS | 24121 | _x_x_mozilla_page_load 18:46:03 INFO - PROCESS | 24121 | _x_x_mozilla_page_load_details 18:46:03 INFO - PROCESS | 24121 | |i|pagename|runs| 18:46:03 INFO - PROCESS | 24121 | |0;ai-astar;114;111;113;113;114;114;114;115;115;114 18:46:03 INFO - PROCESS | 24121 | |1;audio-beat-detection;155;133;159;199;136;168;158;130;192;134 18:46:03 INFO - PROCESS | 24121 | |2;audio-dft;163;165;167;176;163;163;162;164;162;160 18:46:03 INFO - PROCESS | 24121 | |3;audio-fft;75;75;78;154;76;77;77;75;157;77 18:46:03 INFO - PROCESS | 24121 | |4;audio-oscillator;87;87;155;86;86;86;132;87;87;132 18:46:03 INFO - PROCESS | 24121 | |5;imaging-gaussian-blur;117;118;118;118;118;119;118;118;123;118 18:46:03 INFO - PROCESS | 24121 | |6;imaging-darkroom;148;147;147;147;147;147;147;149;149;148 18:46:03 INFO - PROCESS | 24121 | |7;imaging-desaturate;95;96;96;96;96;97;97;96;95;95 18:46:03 INFO - PROCESS | 24121 | |8;json-parse-financial;64;64;65;66;63;65;65;65;65;66 18:46:03 INFO - PROCESS | 24121 | |9;json-stringify-tinderbox;65;67;66;66;66;65;65;66;73;66 18:46:03 INFO - PROCESS | 24121 | |10;stanford-crypto-aes;85;85;84;84;87;86;86;85;113;84 18:46:03 INFO - PROCESS | 24121 | |11;stanford-crypto-ccm;140;129;140;133;133;129;131;135;147;156 18:46:03 INFO - PROCESS | 24121 | |12;stanford-crypto-pbkdf2;173;173;170;167;178;168;166;173;174;165 18:46:03 INFO - PROCESS | 24121 | |13;stanford-crypto-sha256-iterative;67;67;68;72;68;68;68;74;66;71 18:46:03 INFO - PROCESS | 24121 | __end_tp_report 18:46:03 INFO - PROCESS | 24121 | __start_cc_report 18:46:03 INFO - PROCESS | 24121 | _x_x_mozilla_cycle_collect,965 18:46:03 INFO - PROCESS | 24121 | __end_cc_report 18:46:03 INFO - PROCESS | 24121 | __startTimestamp1465436763486__endTimestamp 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | ------- Summary: start ------- 18:46:03 INFO - PROCESS | 24121 | Number of tests: 14 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 18:46:03 INFO - PROCESS | 24121 | Values: 114.0 111.0 113.0 113.0 114.0 114.0 114.0 115.0 115.0 114.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:158.50 stddev:24.47 (15.4%) stddev-sans-first:25.95 18:46:03 INFO - PROCESS | 24121 | Values: 155.0 133.0 159.0 199.0 136.0 168.0 158.0 130.0 192.0 134.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:4.45 (2.7%) stddev-sans-first:4.69 18:46:03 INFO - PROCESS | 24121 | Values: 163.0 165.0 167.0 176.0 163.0 163.0 162.0 164.0 162.0 160.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.50 stddev:33.44 (43.7%) stddev-sans-first:34.89 18:46:03 INFO - PROCESS | 24121 | Values: 75.0 75.0 78.0 154.0 76.0 77.0 77.0 75.0 157.0 77.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:86.50 stddev:26.40 (30.5%) stddev-sans-first:27.40 18:46:03 INFO - PROCESS | 24121 | Values: 87.0 87.0 155.0 86.0 86.0 86.0 132.0 87.0 87.0 132.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.65 (1.4%) stddev-sans-first:1.66 18:46:03 INFO - PROCESS | 24121 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 123.0 118.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 18:46:03 INFO - PROCESS | 24121 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 149.0 148.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 18:46:03 INFO - PROCESS | 24121 | Values: 95.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 95.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 18:46:03 INFO - PROCESS | 24121 | Values: 64.0 64.0 65.0 66.0 63.0 65.0 65.0 65.0 65.0 66.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:2.37 (3.6%) stddev-sans-first:2.45 18:46:03 INFO - PROCESS | 24121 | Values: 65.0 67.0 66.0 66.0 66.0 65.0 65.0 66.0 73.0 66.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.00 stddev:8.88 (10.4%) stddev-sans-first:9.35 18:46:03 INFO - PROCESS | 24121 | Values: 85.0 85.0 84.0 84.0 87.0 86.0 86.0 85.0 113.0 84.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:137.50 stddev:8.68 (6.3%) stddev-sans-first:9.15 18:46:03 INFO - PROCESS | 24121 | Values: 140.0 129.0 140.0 133.0 133.0 129.0 131.0 135.0 147.0 156.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:173.00 stddev:4.16 (2.4%) stddev-sans-first:4.33 18:46:03 INFO - PROCESS | 24121 | Values: 173.0 173.0 170.0 167.0 178.0 168.0 166.0 173.0 174.0 165.0 18:46:03 INFO - PROCESS | 24121 | 18:46:03 INFO - PROCESS | 24121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.00 stddev:2.56 (3.8%) stddev-sans-first:2.62 18:46:03 INFO - PROCESS | 24121 | Values: 67.0 67.0 68.0 72.0 68.0 68.0 68.0 74.0 66.0 71.0 18:46:03 INFO - PROCESS | 24121 | -------- Summary: end -------- 18:46:03 INFO - PROCESS | 24121 | 18:46:04 INFO - TEST-INFO | 24121: exit 0 18:46:04 INFO - TEST-OK | kraken | took 63599ms 18:46:04 INFO - SUITE-END | took 1178s 18:46:04 INFO - Completed test suite (00:19:38) 18:46:04 INFO - javascript benchmark 18:46:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6269.830411552683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.6303117563543, 2685.1675980446057, 2709.4987427325946, 2713.8371697698126, 2718.8368697878127, 4682.953170468294, 4690.413698287714, 4697.037107392985, 4809.519048095189, 4843.757812109398, 4616.953830461703, 4643.883902902429, 4648.953985353294, 4674.0, 4725.196716558185, 4314.892127696801, 4324.783760811963, 4336.392904993288, 4426.336049592571, 4431.202383570972, 4303.397524346594, 4307.095509942916, 4344.695871289011, 4396.670249731283, 4444.2222611042935, 624.1820195308569, 4335.544767799367, 4355.259605866979, 4358.4987726411555, 4424.181526417607, 4297.03316753731, 4299.50555686097, 4317.676174286941, 4347.260965635849, 4351.260285751398, 4269.466316710411, 4272.188284225987, 4291.270484017725, 4301.397804307399, 4332.480102387703, 4521.231390663562, 4521.502634710179, 4560.0, 4607.0325231701045, 4630.351750754897, 5040.621953353477, 5040.747962601892, 5046.772895219724, 5050.4697006814495, 5094.5160209780015, 5086.16078347076, 5089.720065396402, 5095.0, 5104.897902041938, 5135.075686376451, 4661.394018777572, 4683.601893838993, 4689.531046895283, 4700.130475861976, 4749.121412538657, 5113.054084994214, 5116.74416279192, 5125.384953805493, 5130.4356520782685, 5180.533751962342, 4796.664233503621, 4895.755212239374, 4902.558769710672, 4904.730239836772, 4949.925751113737, 4939.0, 5087.516685914832, 5125.333706618116, 5139.897202055938, 5147.794088236504, 5033.798648054037, 5081.161608334657, 5086.745662716849, 5093.414257360377, 5127.0, 4821.083994041121, 5072.340595722532, 5078.390593128848, 5091.847244582668, 5105.055564720538, 4084.387341898739, 4189.371594260824, 4193.329067349209, 4197.139586384845, 4198.769067701244, 3697.519322488113, 3704.8518059277867, 3710.220853620716, 3717.2565486902186, 3754.737168398186, 4286.292761694348, 4478.104379124188, 4525.094981003813, 4525.841595544141, 4531.320301954667, 5049.873753156127, 5067.721275329893, 5118.257852611425, 5140.820071297561, 5154.587632989352, 4436.955630443655, 4461.464624245112, 4483.75339356332, 4484.506704262529, 4490.461144662661, 4389.4513185851765, 4492.303692927601, 4514.68397212192, 4549.476810166807, 4556.703814252063, 4798.208295631322, 4813.3983252093485, 4823.517648235148, 4839.0, 4909.214525675875, 5055.115354812967, 5066.695998240118, 5086.237064440215, 5101.158308879142, 5102.438731739431, 4652.209124448784, 4822.8794280143275, 4828.734419606955, 4834.178189707688, 4887.804487820447, 5050.343455350928, 5076.593872490266, 5076.949230507647, 5090.669106508065, 5129.256257842667, 5149.742512874416, 5152.613553983541, 5157.6647517911215, 5169.06956747789, 5178.378594568676, 4832.8791780205775, 4841.588464980516, 4862.878428039327, 4894.730789806595, 4978.30303757467, 4870.512948705101, 4871.707697538159, 4876.731779752147, 4895.6083513318135, 4920.0, 4801.9039619208115, 4807.326974223682, 4811.951880481291, 4836.250381190921, 4845.1520983828395, 4758.0, 4768.070226305837, 4892.0705066037335, 4936.160852655129, 4940.752962351796, 4793.49668284839, 4805.37530121082, 4807.855764327076, 4825.541573550507, 4869.0261947609915], "value": 4613.682152666262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.5403569073359, 572.8768314812314, 576.4466112531969, 581.77601623375, 597.160988810721, 35756.46365304519, 40060.399094013614, 40313.99215019622, 40327.19345613086, 40350.39474407886, 39737.20525589486, 40264.19471610573, 40290.59709402905, 40319.79840100795, 40488.595114048854, 7645.617719114036, 7764.456488045839, 7780.6887724491235, 7787.454878158531, 7815.218478152196, 7616.581088040156, 7733.342665873408, 7752.224777522231, 7775.883361749578, 7776.688932442724, 7576.318131368176, 7608.543487390774, 7613.0, 7614.73348432805, 7626.542407455543, 7686.423518236154, 7727.690892364299, 7730.729424470144, 7739.9613001935195, 7761.650725717356, 7675.577843218621, 7707.421943354271, 7752.186020467826, 7754.263344982218, 7755.2632499912415, 36290.63709362899, 36551.26897462062, 36554.0, 36675.449868252, 36796.81601592002, 2630.9605355919675, 3079.230192451887, 3205.0705295464286, 3272.280098378353, 3582.22982058856, 28184.718152818416, 29648.8517557413, 30026.699733002828, 30104.849475752482, 30211.546826797614, 3532.8586856525967, 3551.893443196708, 3581.855764130883, 3611.981940090309, 3642.908927276813, 252928.0, 253462.0, 254454.72772636203, 254768.0, 254946.0, 32451.18872028218, 33369.83315083409, 53740.73129634327, 53854.0, 54242.18636720452, 33813.154671133416, 34281.657183428346, 34316.0, 34389.65610343865, 34405.139871503416, 12785.552505662257, 12932.741345173044, 12947.0, 13045.804312935314, 13093.148945318524, 11397.145214108976, 11418.200725949104, 11455.312681238986, 11468.885311146949, 11521.942390287995, 7953.761387158394, 7980.122186559473, 8026.317762990211, 8087.0, 8113.107558168596, 3068.9079327620207, 3092.3196896682693, 3151.0861850063225, 3161.9525707114412, 3169.8256595887447, 920.5535315372039, 933.780561568031, 1016.6884718712926, 1020.505055048301, 1074.3607553505651, 27945.0, 28141.71858281432, 28487.857560712062, 28895.0, 29080.418391632047, 974.2595627323285, 982.6413359123868, 1035.2390992620417, 1035.8860525342207, 1040.7450174707244, 15146.469873554373, 15163.848361516244, 15225.695486090437, 15445.922770386076, 15477.0, 359950.0, 362761.0, 362966.0, 363199.0, 363612.0, 49240.261396079084, 49663.50336496661, 49704.25443618349, 49854.0, 49860.75069624629, 1210.6005018343926, 1221.2550344289975, 1255.7865162922326, 1257.792464243408, 1264.7849865523067, 26854.328641784112, 28167.57748633813, 28289.0, 28496.43007139804, 28774.42451151007, 38264.0, 43709.34435983526, 44085.11829763451, 44107.779461103775, 44178.779106104266, 343869.0, 345759.0, 346141.0, 347903.0, 348121.0, 25080.37299067538, 25183.622245665963, 25292.74707252904, 25710.0, 25889.870550647127, 41702.58297416987, 41871.0, 42041.0, 42248.0, 42349.78825105855, 36259.45610815787, 37268.0, 37564.24871502609, 37778.244435111694, 38309.808450957564, 35512.46731298981, 36203.09492262715, 36720.63279367172, 36741.44887826631, 36906.63093369032, 30539.389212216076, 34599.19408865073, 35244.47133293054, 35772.0, 36502.8174859124, 31224.063278101694, 32370.35259294848, 32529.512057318687, 34332.14169645779, 34577.13557161091, 25087.498250035263, 25443.36391590225, 25566.360840979123, 25607.743922560538, 25917.6112358311], "value": 16571.145662092164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.3612099555325, 356.8750937171989, 360.963903609639, 367.874922526341, 380.6098748782499, 15461.768073478892, 16323.428679996203, 17243.05163216024, 17293.481195564153, 17385.391511297108, 13991.860081399209, 15066.3220155093, 15111.319990600421, 15164.165970871598, 15207.239638018082, 4636.0, 5075.340205773245, 5080.695158290496, 5091.287219789214, 5093.745312734349, 3687.870924517629, 4984.177610694231, 5564.4713752193675, 5820.738066786984, 5853.619514731528, 5884.823455296327, 5894.204282421882, 5895.557833162508, 5902.380250073745, 5908.734106965197, 5724.370319264877, 5960.403959604048, 5967.522598192134, 5974.193483879664, 5986.102084687288, 4548.295014272793, 5161.638685292031, 5182.196759502283, 5212.687238765686, 5248.501392367719, 16263.186840658038, 16279.430219942364, 16393.34426622934, 16428.507144785555, 20167.0, 1891.5838515526561, 1907.9618407631908, 1929.2379510093574, 2021.3329601231558, 2058.9176432942663, 8914.108589141098, 9079.137481939206, 9302.348835581512, 9323.300752443525, 9340.019297973682, 1634.517817243916, 1753.877228593999, 1776.0853160622162, 1776.8312010359125, 1815.5370380552874, 47335.76332118352, 67942.66028669824, 67971.320286797, 68713.0, 70084.29915700828, 9667.129958303787, 9695.418274903528, 9887.604495820087, 9909.972367756418, 10641.255112142077, 13598.320083995959, 13673.589792306248, 13762.311884405939, 13777.793333100011, 13784.0, 7459.36595389398, 7525.473216874766, 7540.698372065166, 7569.659365328574, 7719.65261563231, 7196.532225405332, 7202.603856787822, 7273.8545229095125, 7340.486165968331, 7406.518576292524, 4256.34026725858, 4279.593438623326, 4313.102235016583, 4320.265554855682, 4340.587644173798, 1678.8237235090385, 1687.8565321947772, 1804.3955274982766, 1824.6806808808406, 1831.1851226204478, 778.7936196907824, 840.1598401598402, 870.7344260000634, 874.2961915657829, 990.0248255468358, 16214.51356459308, 16216.918915405347, 16357.182140892908, 16561.83438165627, 16769.413070542472, 878.3017501086524, 881.7839629290736, 887.9023307436177, 898.2948385517337, 948.5399581203111, 9082.0, 9189.63241470347, 9289.814203716023, 9457.810843783085, 9569.808603828023, 379606.0, 398169.0, 398491.0, 400326.0, 404316.0, 82705.58647206725, 84092.0, 85418.57290713632, 86114.56942715247, 87747.0, 949.107838631684, 957.411192116857, 970.2965350121247, 970.5001924009282, 990.3562684255292, 15260.847391525942, 15267.3893044277, 15297.235138243266, 15297.388104475696, 15773.132477713836, 35745.642543574235, 36486.63513364832, 36525.63474365329, 37121.443178352885, 37127.62872371242, 49803.75098124486, 51969.22046169235, 52715.472845271055, 53238.4676153249, 53386.46613533815, 7567.772966811004, 7675.117361503499, 7750.302472777477, 7872.645730942236, 7994.320482759031, 10766.192535560021, 11156.832647510131, 11436.256643318158, 11626.825597615873, 11830.290182589073, 10674.83987740169, 10743.838842417526, 10750.784984300113, 10920.56317747313, 11032.503537340679, 10627.309224900357, 10745.570177193138, 11047.668569942914, 11153.0, 11172.497237624164, 10972.122230221403, 11021.614243501439, 11119.27724697892, 11313.151513636345, 11324.32054076758, 7871.606419679108, 7923.524588524707, 8023.237792409712, 8208.630611622611, 8346.666133354598, 9597.184239339455, 10989.780204395707, 11083.72290692739, 11091.223614346918, 11168.66494005181], "value": 8247.041179514368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.6381740747406, 1431.3272761801952, 1519.2024187301665, 1646.9341226350946, 1718.312674930028, 6754.898676519844, 7214.711411543545, 7654.655540500677, 8268.46254993425, 8277.503349799017, 7303.488755787097, 7567.62161891906, 7657.157712651618, 7661.310482056628, 7664.1952594977565, 2089.247870766527, 2117.9894100529477, 2122.352682431858, 2122.384508492535, 2125.829933605308, 2087.6242276390244, 2126.2345555599973, 2139.871607703543, 2140.176032227596, 2140.8180304674042, 2094.7695753467106, 2096.0986775686447, 2109.377733568593, 2121.8514703970727, 2145.570885822834, 2065.5455799724036, 2077.8441616878717, 2079.7088407622946, 2089.0599230346406, 2097.895105244739, 2026.3110542415502, 2035.3486884197064, 2070.3167954574956, 2079.792020797923, 2094.5915546468445, 7499.850002999964, 7564.0, 7573.659185336673, 7608.581528015957, 7621.466497345188, 4391.956080439219, 4508.188526065307, 4533.070720502289, 4544.545545445462, 4564.726116433025, 2685.4827022732093, 2748.7800975922078, 2766.7233276672373, 2816.281848128714, 2849.7577705895023, 875.916787905148, 901.8016036471965, 912.2246090822748, 916.6196028648103, 919.7516670498928, 10732.409717465536, 10755.83866242007, 10773.35359878402, 10793.0, 10795.46022698862, 4012.4583181270154, 4015.0, 4088.264112459726, 4102.323116685713, 4121.4848143982, 9126.26989840811, 9176.08239176077, 9201.677941272023, 9220.90779092214, 9237.07629237071, 4367.235733746646, 4420.469543654782, 4435.3125265583885, 4443.955560444354, 4448.110377924428, 3528.364894318996, 4028.738132021409, 4033.213523362916, 4064.2684316822665, 4206.11671548972, 3513.1744040151057, 3534.6317966961683, 3583.8028908409765, 3627.3108109459117, 3647.562292524914, 1129.5312445335258, 1136.6987748246722, 1143.2740209966564, 1146.4439746722833, 1148.8396719313553, 773.7872085176622, 812.8699408094794, 813.3980854167874, 843.8101427178835, 848.4951453884929, 5214.113600687892, 5279.392869819943, 5297.5232229099565, 5433.972830135824, 5514.393416724157, 871.333429926107, 872.3457406944791, 896.1665650944553, 916.0244339778116, 940.1209868772719, 3537.327907697529, 3593.3531964246686, 3621.1309285771226, 3678.2459595782802, 3693.298273328059, 9032.954835225913, 9275.95362023199, 9311.813763724687, 9314.115159059878, 9373.812523749486, 9134.086591340945, 9135.40619859707, 9192.21866141372, 9204.171624553688, 9261.536923153815, 7338.77983660491, 7382.040334756554, 7441.107067151868, 7441.776746697607, 7468.365188958999, 5309.46905309466, 5394.9460505394445, 5412.891742165213, 5494.203340515683, 5497.780088796403, 8644.697435589724, 8958.552072396484, 9024.142706442877, 9034.503102329172, 9141.862872056792, 9001.234895033733, 9090.0, 9133.634654613741, 9159.633614655606, 9287.117723816227, 5977.9103313451205, 6692.966535167293, 6874.381305682513, 6934.791956241321, 7036.718531258897, 7577.848443031219, 7632.274933881273, 7678.193789652006, 7697.88453173214, 7704.036995375578, 6696.430803381767, 6834.1457317835275, 6953.096097507291, 6984.196817366068, 6991.860162796817, 6586.077949087227, 6679.265280819203, 6719.992001199859, 6734.966325168539, 6754.527183097136, 6282.120503129474, 6302.495800336053, 6396.808095757135, 6410.358964103552, 6454.548181627429, 4463.977680111579, 4621.514740952151, 4632.490426053064, 4642.744649044335, 4643.187442197669, 4394.494633117105, 4460.487043989853, 4495.43807024122, 4563.429571303587, 4566.0], "value": 4097.788178186861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.97800175985924, 277.091141057332, 284.7110183164088, 288.18300119162177, 288.9494338490765, 4772.689775164612, 4829.541193586608, 4834.274858771186, 4927.630427717922, 4949.901001979958, 4821.987382649648, 4857.344258525098, 4864.7324397158145, 4900.950990490094, 4921.843366808797, 3815.599362066978, 3818.618138186187, 3833.1950290438904, 3836.5396152461603, 3853.1312313527915, 3544.4683297505453, 3837.1366442550484, 3838.2323535292912, 3852.9036774080732, 3870.1098747288142, 3678.337899178147, 3715.9628403716024, 3723.1995121048967, 3733.2720119576693, 3742.943855842151, 3729.5710993235853, 3737.2808508086314, 3743.2139250757373, 3746.2882052410228, 3750.456183853353, 3148.3703259347994, 3248.31785325082, 3260.4131256373844, 3262.2659901522206, 3275.852586633607, 4669.836555720567, 4679.60223381013, 4683.274092515666, 4724.12603668319, 4742.596879265232, 4250.659947204216, 4267.4025636410925, 4274.358846173068, 4274.935875961863, 4279.550647182064, 4994.525520075587, 5058.46886076964, 5110.10573149701, 5128.820491282824, 5135.794568217267, 3507.5089487471773, 3516.4549494828343, 3536.2142118230386, 3540.5928318243473, 3556.982215088934, 5375.3280839895015, 5413.729313534308, 5426.864328391743, 5429.425466614677, 5434.701091439969, 3575.8021062944204, 3596.345680986723, 3605.008622628746, 3605.0987253186704, 3607.3867442534834, 3491.114798009047, 3648.9418068759765, 3673.1368128489785, 3678.4850120983083, 3683.6684698377276, 4207.810648520824, 4251.4685664291965, 4262.914741705148, 4267.25323068468, 4274.850380236677, 5161.812783059842, 5197.870053248624, 5207.505286997729, 5217.478252174828, 5221.738913054332, 1183.3432444993111, 1276.5468258768003, 1297.8247936528637, 1307.6142537951328, 1311.8294621699308, 833.98332033359, 837.367787320569, 837.9329653627696, 849.1423662101322, 850.8596081646459, 4016.6987475939422, 4085.3871919212356, 4131.566185550534, 4133.297339452301, 4163.2298024865495, 4732.574068333866, 4738.289256611467, 4755.0, 4763.237881938942, 4777.641676874248, 4098.323776576891, 4146.3365861462025, 4146.626803587692, 4168.541460439349, 4219.9578004220175, 2552.731963143843, 2593.9092131775296, 2823.661160660734, 2834.2489240351324, 2859.170840456286, 5048.697078175322, 5059.418166910778, 5071.594272458195, 5080.5681517070725, 5086.626610815059, 5336.839894803162, 5463.617546771768, 5480.095784195642, 5484.203056441164, 5487.780488780404, 4980.352554167935, 4994.1759609663995, 5026.44709082008, 5030.37120359955, 5056.873578160502, 5293.682379057269, 5306.734663266899, 5329.387120481039, 5354.473974917286, 5363.383210930637, 5005.549500544823, 5140.820071297487, 5219.895602087861, 5226.0, 5232.9738351308, 5063.696178229318, 5068.442471328077, 5074.035933172685, 5075.213341932006, 5101.362329708786, 3585.5338805955057, 3604.7837129772297, 3609.711223102093, 3614.1145419372424, 3631.5097461842315, 5231.424543300158, 5345.572354211731, 5351.705656188947, 5351.812686555952, 5357.142857142839, 5078.669886457516, 5109.054824857413, 5124.769385377742, 5143.228515722672, 5161.974190129175, 5116.795328186831, 5126.641135120506, 5149.382074150976, 5160.509751573594, 5171.3535808024, 4828.468868424541, 5031.471695472069, 5079.339685840965, 5091.974540127276, 5108.872278193075, 5199.610029247746, 5215.713135777569, 5221.660592061504, 5229.555487783581, 5233.528982391603, 5112.284280200849, 5121.667091639031, 5127.6410651254055, 5131.92302115476, 5131.92302115476], "value": 3804.971299428472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9186059881914, 693.9590614078882, 725.9818504537386, 734.1520543771945, 764.0563903579081, 11625.825612615807, 12570.371481425915, 12619.864212220898, 12684.365781710912, 12828.16616919902, 12730.236185828857, 13077.934610326958, 13311.400986955587, 13394.196348219113, 13409.932950335258, 627.7771391156142, 767.7811823630267, 768.2010708862804, 785.9449838511307, 795.761271618515, 790.7192946503994, 794.3764145146062, 797.513516754782, 800.2837460472873, 802.2779498451382, 834.5993922917004, 837.983240335196, 838.1325328285226, 838.7944953486405, 839.5172775653992, 827.6275675945818, 830.2030051150903, 830.5639539241886, 832.1553623072587, 834.5493433545878, 607.8055022392836, 608.4554323880103, 608.5071092415158, 608.9634621922654, 609.439315829438, 13387.732245355135, 13400.329983500786, 13411.865881341158, 13433.798493022612, 13447.394867230998, 13362.465501379933, 13364.131331463424, 13472.797908031387, 13551.051426400156, 14050.648733781738, 10632.893671063344, 10652.307600005975, 10739.355638661706, 10781.514831832508, 10872.45637718111, 3397.915052123692, 3400.897973060812, 3413.7781044232293, 3443.3113377324385, 3535.9646403535894, 59230.40769592249, 59533.0, 59550.70224648892, 59806.10290845641, 59858.700706496624, 10107.191424686007, 10155.644552440777, 10206.642767503101, 10207.030332118436, 10386.169106471616, 18911.527211819815, 19000.429987100408, 19022.524436889187, 19042.714359284622, 19072.71390929137, 6243.875122497525, 6452.806415807533, 6534.705938232791, 6535.836604084936, 6537.117489139, 3432.7597068204986, 3567.0547304964207, 3585.515955346047, 3590.676839084495, 3600.9279814403567, 2585.146901522493, 2672.3319170207446, 2681.1956413076, 2689.3007817967077, 2699.082312013925, 477.0411472939347, 483.6662702735102, 485.1243505472656, 487.68787975695585, 502.1012387825824, 555.4584280326649, 567.4665814134701, 573.4065242474103, 574.0757380617202, 581.61425202624, 7576.962115189389, 7963.243491868263, 7992.200779921961, 8044.83910321802, 8149.429539932148, 510.4308695804226, 512.2469969145351, 512.5463964391466, 537.5135502370362, 570.4067769519736, 3404.676555727202, 3468.2023134679166, 3544.379733546619, 3558.3061303045656, 3581.910452238663, 84825.57587212024, 86460.56769716111, 86594.56702716446, 86917.0, 88586.0, 76876.0, 77473.18951078692, 77789.61105194438, 78660.0, 79102.6044869772, 69821.30178698148, 70098.29901700918, 70564.29435705577, 70913.64543177251, 71079.64460177769, 7085.2560481150795, 7168.749093781693, 7208.56748595065, 7244.855102897807, 7308.488405811542, 43130.353044704985, 43257.78371108124, 43575.98876129286, 44245.33631995587, 44585.10829783451, 56697.0, 59581.40418595759, 60161.39838601733, 60189.69905150446, 60308.396916032034, 9007.279417646703, 9075.092490750872, 9328.953355233452, 9364.344495885223, 9401.153896149379, 9890.406575605486, 9995.650152244636, 10156.89843101589, 10490.580376784843, 10643.733906652396, 9431.198348140484, 9577.329586928849, 9752.414855108716, 9796.559154838193, 9840.753981150528, 9899.0, 9928.205743540644, 9941.0, 9954.502274886081, 10143.898561014295, 9614.0, 9659.0, 9689.563969621244, 9733.513324333897, 9749.658761943298, 8125.512469251627, 8281.627326770431, 8334.166583341617, 8379.83240335202, 8433.451825631315, 7702.961485192763, 7790.571518566533, 7812.101608315116, 7871.33093687043, 8005.07941586725], "value": 6178.566291517722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 159.0, 199.0, 136.0, 168.0, 158.0, 130.0, 192.0, 134.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 167.0, 176.0, 163.0, 163.0, 162.0, 164.0, 162.0, 160.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 154.0, 76.0, 77.0, 77.0, 75.0, 157.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 155.0, 86.0, 86.0, 86.0, 132.0, 87.0, 87.0, 132.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 123.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 149.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 63.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 73.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 87.0, 86.0, 86.0, 85.0, 113.0, 84.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 140.0, 133.0, 133.0, 129.0, 131.0, 135.0, 147.0, 156.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 170.0, 167.0, 178.0, 168.0, 166.0, 173.0, 174.0, 165.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 72.0, 68.0, 68.0, 68.0, 74.0, 66.0, 71.0], "value": 68.9, "unit": "score"}]}]} 18:46:04 INFO - Return code: 0 18:46:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:04 ERROR - # TBPL SUCCESS # 18:46:04 INFO - Running post-action listener: _resource_record_post_action 18:46:04 INFO - ##### 18:46:04 INFO - ##### Finished run-tests step (success) 18:46:04 INFO - ##### 18:46:04 INFO - Running post-run listener: _resource_record_post_run 18:46:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 524214272; Read time: 0; Write time: 434028 18:46:04 INFO - TinderboxPrint: CPU usage
13.4% 18:46:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:46:04 INFO - TinderboxPrint: I/O write bytes / time
524,214,272 / 434,028 18:46:04 INFO - TinderboxPrint: CPU idle
8,258.8 (86.5%) 18:46:04 INFO - TinderboxPrint: CPU user
1,231.7 (12.9%) 18:46:04 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237780992; Read time: 0; Write time: 204248 18:46:04 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 286433280; Read time: 0; Write time: 229780 18:46:05 INFO - Running post-run listener: _upload_blobber_files 18:46:05 INFO - Blob upload gear active. 18:46:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:05 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 18:46:05 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:05 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:05 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:06 INFO - (blobuploader) - INFO - Done attempting. 18:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:11 INFO - (blobuploader) - INFO - Done attempting. 18:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:12 INFO - (blobuploader) - INFO - Done attempting. 18:46:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:12 INFO - Return code: 0 18:46:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09a35cd4b86b303fef81af9c30233e0c229f78303b47df2f77eac5ab13110953b29c03df849bf0005c26011a643e568760fbbe674792ec85229246040e907e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc7eaf00c4be3b5df34eee8697d45895d939de6f9453a741a0db3141b7af3798321cb2285077fa0918a14eb5acda0c9d9d7109969b07c46e884163baacac66e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b9c724b1306a6bd035140f376caaa727d1686e0ab99e7442eb0a6f18a52499fa33cdc1774646eb49bd065c64d118f78999b7e736bf35933e99e62aec889958"} 18:46:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:12 INFO - Contents: 18:46:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09a35cd4b86b303fef81af9c30233e0c229f78303b47df2f77eac5ab13110953b29c03df849bf0005c26011a643e568760fbbe674792ec85229246040e907e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc7eaf00c4be3b5df34eee8697d45895d939de6f9453a741a0db3141b7af3798321cb2285077fa0918a14eb5acda0c9d9d7109969b07c46e884163baacac66e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b9c724b1306a6bd035140f376caaa727d1686e0ab99e7442eb0a6f18a52499fa33cdc1774646eb49bd065c64d118f78999b7e736bf35933e99e62aec889958"} 18:46:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:12 INFO - Copying logs to upload dir... 18:46:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.921677 ========= master_lag: 10.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-08 18:46:22.017450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 18:46:22.020953) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09a35cd4b86b303fef81af9c30233e0c229f78303b47df2f77eac5ab13110953b29c03df849bf0005c26011a643e568760fbbe674792ec85229246040e907e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc7eaf00c4be3b5df34eee8697d45895d939de6f9453a741a0db3141b7af3798321cb2285077fa0918a14eb5acda0c9d9d7109969b07c46e884163baacac66e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b9c724b1306a6bd035140f376caaa727d1686e0ab99e7442eb0a6f18a52499fa33cdc1774646eb49bd065c64d118f78999b7e736bf35933e99e62aec889958"} build_url:https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/HzftmnNDQ0a67FXxeCX56Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09a35cd4b86b303fef81af9c30233e0c229f78303b47df2f77eac5ab13110953b29c03df849bf0005c26011a643e568760fbbe674792ec85229246040e907e56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc7eaf00c4be3b5df34eee8697d45895d939de6f9453a741a0db3141b7af3798321cb2285077fa0918a14eb5acda0c9d9d7109969b07c46e884163baacac66e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b9c724b1306a6bd035140f376caaa727d1686e0ab99e7442eb0a6f18a52499fa33cdc1774646eb49bd065c64d118f78999b7e736bf35933e99e62aec889958"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 18:46:22.049902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:46:22.050623) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465434644.220968-1457721809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:46:22.103827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 18:46:22.104484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 18:46:22.105081) ========= ========= Total master_lag: 10.23 =========