builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1465636038.49 results: success (0) buildid: 20160610233028 builduid: 25e66079de4d4b7a9a32ea2ecbdbdf6f revision: 2719065dd5a6045af640e32222b5d4359ae87000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.494831) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.495467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.495843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.512639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.513154) ========= 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=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 02:07:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.7M=0s 2016-06-11 02:07:19 (63.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.630256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.630626) ========= 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=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.682814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:18.683443) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2719065dd5a6045af640e32222b5d4359ae87000 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2719065dd5a6045af640e32222b5d4359ae87000 --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=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 02:07:19,237 truncating revision to first 12 chars 2016-06-11 02:07:19,237 Setting DEBUG logging. 2016-06-11 02:07:19,237 attempt 1/10 2016-06-11 02:07:19,237 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2719065dd5a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 02:07:19,569 unpacking tar archive at: fx-team-2719065dd5a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:19.365004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:19.365480) ========= script_repo_revision: 2719065dd5a6045af640e32222b5d4359ae87000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:19.365935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:19.366264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 02:07:19.376464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-11 02:07:19.376903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:20 INFO - MultiFileLogger online at 20160611 02:07:20 in /builds/slave/test 02:07:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:20 INFO - {'append_to_log': False, 02:07:20 INFO - 'base_work_dir': '/builds/slave/test', 02:07:20 INFO - 'blob_upload_branch': 'Fx-Team', 02:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:20 INFO - 'branch': 'Fx-Team', 02:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:20 INFO - 'config_files': ('talos/linux_config.py',), 02:07:20 INFO - 'default_actions': ('clobber', 02:07:20 INFO - 'read-buildbot-config', 02:07:20 INFO - 'download-and-extract', 02:07:20 INFO - 'populate-webroot', 02:07:20 INFO - 'create-virtualenv', 02:07:20 INFO - 'install', 02:07:20 INFO - 'run-tests'), 02:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:20 INFO - 'download_minidump_stackwalk': True, 02:07:20 INFO - 'download_symbols': 'ondemand', 02:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:20 INFO - 'installer_path': 'installer.exe', 02:07:20 INFO - 'log_level': 'info', 02:07:20 INFO - 'log_name': 'talos', 02:07:20 INFO - 'log_to_console': True, 02:07:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:20 INFO - 'opt_config_files': (), 02:07:20 INFO - 'pip_index': False, 02:07:20 INFO - 'sps_profile': False, 02:07:20 INFO - 'sps_profile_interval': 0, 02:07:20 INFO - 'suite': 'dromaeojs', 02:07:20 INFO - 'system_bits': '32', 02:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:20 INFO - 'title': 'talos-linux64-ix-031', 02:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:20 INFO - 'use_talos_json': True, 02:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:20 INFO - 'work_dir': 'build'} 02:07:20 INFO - ##### 02:07:20 INFO - ##### Running clobber step. 02:07:20 INFO - ##### 02:07:20 INFO - Running pre-action listener: _resource_record_pre_action 02:07:20 INFO - Running main action method: clobber 02:07:20 INFO - rmtree: /builds/slave/test/build 02:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:20 INFO - Running post-action listener: _resource_record_post_action 02:07:20 INFO - ##### 02:07:20 INFO - ##### Finished clobber step (success) 02:07:20 INFO - ##### 02:07:20 INFO - ##### 02:07:20 INFO - ##### Running read-buildbot-config step. 02:07:20 INFO - ##### 02:07:20 INFO - Running pre-action listener: _resource_record_pre_action 02:07:20 INFO - Running main action method: read_buildbot_config 02:07:20 INFO - Using buildbot properties: 02:07:20 INFO - { 02:07:20 INFO - "project": "", 02:07:20 INFO - "product": "firefox", 02:07:20 INFO - "script_repo_revision": "production", 02:07:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:07:20 INFO - "repository": "", 02:07:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:07:20 INFO - "buildid": "20160610233028", 02:07:20 INFO - "pgo_build": "True", 02:07:20 INFO - "basedir": "/builds/slave/test", 02:07:20 INFO - "buildnumber": 799, 02:07:20 INFO - "slavename": "talos-linux64-ix-031", 02:07:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:07:20 INFO - "platform": "ubuntu64_hw", 02:07:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:07:20 INFO - "branch": "fx-team", 02:07:20 INFO - "repo_path": "integration/fx-team", 02:07:20 INFO - "revision": "2719065dd5a6045af640e32222b5d4359ae87000", 02:07:20 INFO - "stage_platform": "linux64-pgo", 02:07:20 INFO - "builduid": "25e66079de4d4b7a9a32ea2ecbdbdf6f", 02:07:20 INFO - "slavebuilddir": "test" 02:07:20 INFO - } 02:07:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:07:20 INFO - Running post-action listener: _resource_record_post_action 02:07:20 INFO - ##### 02:07:20 INFO - ##### Finished read-buildbot-config step (success) 02:07:20 INFO - ##### 02:07:20 INFO - ##### 02:07:20 INFO - ##### Running download-and-extract step. 02:07:20 INFO - ##### 02:07:20 INFO - Running pre-action listener: _resource_record_pre_action 02:07:20 INFO - Running main action method: download_and_extract 02:07:20 INFO - mkdir: /builds/slave/test/build/tests 02:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:20 INFO - https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:21 INFO - Downloaded 1361 bytes. 02:07:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:07:21 INFO - Using the following test package requirements: 02:07:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:07:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'jsshell-linux-x86_64.zip'], 02:07:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:07:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:07:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:21 INFO - https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:22 INFO - Downloaded 24463639 bytes. 02:07:22 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'] 02:07:22 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 02:07:23 INFO - Return code: 0 02:07:23 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 02:07:23 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')]} 02:07:23 INFO - https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:24 INFO - Downloaded 24463639 bytes. 02:07:24 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'] 02:07:24 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 02:07:26 INFO - Return code: 0 02:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:26 INFO - https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:27 INFO - Downloaded 10833377 bytes. 02:07:27 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'] 02:07:27 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 02:07:27 INFO - Return code: 0 02:07: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')]} 02:07:27 INFO - https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTPjtqBrTYeVvhg4wOAS-w/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 02:07:28 INFO - Downloaded 59349619 bytes. 02:07:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:07:28 INFO - mkdir: /builds/slave/test/properties 02:07:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:28 INFO - Contents: 02:07:28 INFO - build_url:https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:07:29 INFO - Running post-action listener: _resource_record_post_action 02:07:29 INFO - Running post-action listener: set_extra_try_arguments 02:07:29 INFO - ##### 02:07:29 INFO - ##### Finished download-and-extract step (success) 02:07:29 INFO - ##### 02:07:29 INFO - ##### 02:07:29 INFO - ##### Running populate-webroot step. 02:07:29 INFO - ##### 02:07:29 INFO - Running pre-action listener: _resource_record_pre_action 02:07:29 INFO - Running main action method: populate_webroot 02:07:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:29 INFO - '--tppagecycles', 02:07:29 INFO - '7'], 02:07:29 INFO - 'tests': ['tsvgm']}}, 02:07:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['damp', 'tps']}, 02:07:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'tests': ['damp', 'tps']}, 02:07:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['dromaeo_dom']}, 02:07:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['a11yr', 02:07:29 INFO - 'ts_paint', 02:07:29 INFO - 'tpaint', 02:07:29 INFO - 'sessionrestore', 02:07:29 INFO - 'sessionrestore_no_auto_restore', 02:07:29 INFO - 'tabpaint']}, 02:07:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['tsvgx', 02:07:29 INFO - 'tsvgr_opacity', 02:07:29 INFO - 'tart', 02:07:29 INFO - 'tscrollx', 02:07:29 INFO - 'cart']}, 02:07:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:29 INFO - 'tsvgr_opacity', 02:07:29 INFO - 'tart', 02:07:29 INFO - 'tscrollx', 02:07:29 INFO - 'cart']}, 02:07:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'talos_options': ['--disable-e10s'], 02:07:29 INFO - 'tests': ['tp5o']}, 02:07:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'tests': ['tp5o']}, 02:07:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'talos_options': ['--disable-e10s', 02:07:29 INFO - '--xperf_path', 02:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:29 INFO - 'tests': ['tp5n']}, 02:07:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:29 INFO - 'talos_options': ['--xperf_path', 02:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:29 INFO - 'tests': ['tp5n']}}, 02:07:29 INFO - 'talos.zip': {'path': '', 02:07:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:29 INFO - Running post-action listener: _resource_record_post_action 02:07:29 INFO - ##### 02:07:29 INFO - ##### Finished populate-webroot step (success) 02:07:29 INFO - ##### 02:07:29 INFO - ##### 02:07:29 INFO - ##### Running create-virtualenv step. 02:07:29 INFO - ##### 02:07:29 INFO - Running pre-action listener: _resource_record_pre_action 02:07:29 INFO - Running main action method: create_virtualenv 02:07:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:29 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 02:07:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:29 INFO - Using real prefix '/usr' 02:07:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:30 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:32 INFO - Installing pip.................done. 02:07:32 INFO - Return code: 0 02:07:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:32 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')]} 02:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:32 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')]} 02:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:32 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:32 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 02:07:32 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 02:07:32 INFO - Using env: {'DISPLAY': ':0', 02:07:32 INFO - 'HOME': '/home/cltbld', 02:07:32 INFO - 'LANG': 'en_US.UTF-8', 02:07:32 INFO - 'LANGUAGE': 'en_US:en', 02:07:32 INFO - 'LOGNAME': 'cltbld', 02:07:32 INFO - 'MAIL': '/var/mail/cltbld', 02:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:32 INFO - 'MOZ_NO_REMOTE': '1', 02:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:32 INFO - 'NO_EM_RESTART': '1', 02:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:32 INFO - 'PWD': '/builds/slave/test', 02:07:32 INFO - 'SHELL': '/bin/bash', 02:07:32 INFO - 'SHLVL': '1', 02:07:32 INFO - 'TERM': 'linux', 02:07:32 INFO - 'TMOUT': '86400', 02:07:32 INFO - 'USER': 'cltbld', 02:07:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:32 INFO - '_': '/tools/buildbot/bin/python'} 02:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:32 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 02:07:32 INFO - Cleaning up... 02:07:32 INFO - Return code: 0 02:07:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:07:32 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')]} 02:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:32 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')]} 02:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:32 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:32 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 02:07:32 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 02:07:32 INFO - Using env: {'DISPLAY': ':0', 02:07:32 INFO - 'HOME': '/home/cltbld', 02:07:32 INFO - 'LANG': 'en_US.UTF-8', 02:07:32 INFO - 'LANGUAGE': 'en_US:en', 02:07:32 INFO - 'LOGNAME': 'cltbld', 02:07:32 INFO - 'MAIL': '/var/mail/cltbld', 02:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:32 INFO - 'MOZ_NO_REMOTE': '1', 02:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:32 INFO - 'NO_EM_RESTART': '1', 02:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:32 INFO - 'PWD': '/builds/slave/test', 02:07:32 INFO - 'SHELL': '/bin/bash', 02:07:32 INFO - 'SHLVL': '1', 02:07:32 INFO - 'TERM': 'linux', 02:07:32 INFO - 'TMOUT': '86400', 02:07:32 INFO - 'USER': 'cltbld', 02:07:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:32 INFO - '_': '/tools/buildbot/bin/python'} 02:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:32 INFO - Downloading/unpacking psutil>=3.1.1 02:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:34 INFO - Installing collected packages: psutil 02:07:34 INFO - Running setup.py install for psutil 02:07:34 INFO - building 'psutil._psutil_linux' extension 02:07:34 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 02:07:34 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 02:07:34 INFO - building 'psutil._psutil_posix' extension 02:07:34 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 02:07:34 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 02:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:34 INFO - Successfully installed psutil 02:07:34 INFO - Cleaning up... 02:07:35 INFO - Return code: 0 02:07:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:07:35 INFO - Using env: {'DISPLAY': ':0', 02:07:35 INFO - 'HOME': '/home/cltbld', 02:07:35 INFO - 'LANG': 'en_US.UTF-8', 02:07:35 INFO - 'LANGUAGE': 'en_US:en', 02:07:35 INFO - 'LOGNAME': 'cltbld', 02:07:35 INFO - 'MAIL': '/var/mail/cltbld', 02:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:35 INFO - 'MOZ_NO_REMOTE': '1', 02:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:35 INFO - 'NO_EM_RESTART': '1', 02:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:35 INFO - 'PWD': '/builds/slave/test', 02:07:35 INFO - 'SHELL': '/bin/bash', 02:07:35 INFO - 'SHLVL': '1', 02:07:35 INFO - 'TERM': 'linux', 02:07:35 INFO - 'TMOUT': '86400', 02:07:35 INFO - 'USER': 'cltbld', 02:07:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:35 INFO - '_': '/tools/buildbot/bin/python'} 02:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:07:37 INFO - Installing collected packages: mozsystemmonitor 02:07:37 INFO - Running setup.py install for mozsystemmonitor 02:07:37 INFO - Successfully installed mozsystemmonitor 02:07:37 INFO - Cleaning up... 02:07:37 INFO - Return code: 0 02:07:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:37 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 02:07:37 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 02:07:37 INFO - Using env: {'DISPLAY': ':0', 02:07:37 INFO - 'HOME': '/home/cltbld', 02:07:37 INFO - 'LANG': 'en_US.UTF-8', 02:07:37 INFO - 'LANGUAGE': 'en_US:en', 02:07:37 INFO - 'LOGNAME': 'cltbld', 02:07:37 INFO - 'MAIL': '/var/mail/cltbld', 02:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:37 INFO - 'MOZ_NO_REMOTE': '1', 02:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:37 INFO - 'NO_EM_RESTART': '1', 02:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:37 INFO - 'PWD': '/builds/slave/test', 02:07:37 INFO - 'SHELL': '/bin/bash', 02:07:37 INFO - 'SHLVL': '1', 02:07:37 INFO - 'TERM': 'linux', 02:07:37 INFO - 'TMOUT': '86400', 02:07:37 INFO - 'USER': 'cltbld', 02:07:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:37 INFO - '_': '/tools/buildbot/bin/python'} 02:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:39 INFO - warning: no files found matching '*.txt' 02:07:39 INFO - no previously-included directories found matching 'build' 02:07:39 INFO - no previously-included directories found matching 'dist' 02:07:39 INFO - no previously-included directories found matching '.git*' 02:07:39 INFO - Installing collected packages: jsonschema, functools32 02:07:39 INFO - Running setup.py install for functools32 02:07:39 INFO - warning: no files found matching '*.txt' 02:07:39 INFO - no previously-included directories found matching 'build' 02:07:39 INFO - no previously-included directories found matching 'dist' 02:07:39 INFO - no previously-included directories found matching '.git*' 02:07:39 INFO - Successfully installed jsonschema functools32 02:07:39 INFO - Cleaning up... 02:07:39 INFO - Return code: 0 02:07:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:39 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 02:07:39 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 02:07:39 INFO - Using env: {'DISPLAY': ':0', 02:07:39 INFO - 'HOME': '/home/cltbld', 02:07:39 INFO - 'LANG': 'en_US.UTF-8', 02:07:39 INFO - 'LANGUAGE': 'en_US:en', 02:07:39 INFO - 'LOGNAME': 'cltbld', 02:07:39 INFO - 'MAIL': '/var/mail/cltbld', 02:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:39 INFO - 'MOZ_NO_REMOTE': '1', 02:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:39 INFO - 'NO_EM_RESTART': '1', 02:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:39 INFO - 'PWD': '/builds/slave/test', 02:07:39 INFO - 'SHELL': '/bin/bash', 02:07:39 INFO - 'SHLVL': '1', 02:07:39 INFO - 'TERM': 'linux', 02:07:39 INFO - 'TMOUT': '86400', 02:07:39 INFO - 'USER': 'cltbld', 02:07:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:39 INFO - '_': '/tools/buildbot/bin/python'} 02:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - Downloading docopt-0.6.1.tar.gz 02:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:42 INFO - Running setup.py install for blobuploader 02:07:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:42 INFO - Running setup.py install for requests 02:07:43 INFO - Running setup.py install for docopt 02:07:43 INFO - Successfully installed blobuploader requests docopt 02:07:43 INFO - Cleaning up... 02:07:43 INFO - Return code: 0 02:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:43 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:43 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 02:07:43 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 02:07:43 INFO - Using env: {'DISPLAY': ':0', 02:07:43 INFO - 'HOME': '/home/cltbld', 02:07:43 INFO - 'LANG': 'en_US.UTF-8', 02:07:43 INFO - 'LANGUAGE': 'en_US:en', 02:07:43 INFO - 'LOGNAME': 'cltbld', 02:07:43 INFO - 'MAIL': '/var/mail/cltbld', 02:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:43 INFO - 'MOZ_NO_REMOTE': '1', 02:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:43 INFO - 'NO_EM_RESTART': '1', 02:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:43 INFO - 'PWD': '/builds/slave/test', 02:07:43 INFO - 'SHELL': '/bin/bash', 02:07:43 INFO - 'SHLVL': '1', 02:07:43 INFO - 'TERM': 'linux', 02:07:43 INFO - 'TMOUT': '86400', 02:07:43 INFO - 'USER': 'cltbld', 02:07:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:43 INFO - '_': '/tools/buildbot/bin/python'} 02:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:43 INFO - Running setup.py (path:/tmp/pip-tUr9TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:43 INFO - Running setup.py (path:/tmp/pip-JYSyDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:43 INFO - Running setup.py (path:/tmp/pip-kRcRLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:43 INFO - Running setup.py (path:/tmp/pip-EGA1pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:43 INFO - Running setup.py (path:/tmp/pip-iXwfo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:43 INFO - Running setup.py (path:/tmp/pip-eChKhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:43 INFO - Running setup.py (path:/tmp/pip-GaPIwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:44 INFO - Running setup.py (path:/tmp/pip-RldC0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:44 INFO - Running setup.py (path:/tmp/pip-3ZbMWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:44 INFO - Running setup.py (path:/tmp/pip-ellYIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:44 INFO - Running setup.py (path:/tmp/pip-c15gun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:44 INFO - Running setup.py (path:/tmp/pip-YAtaqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:44 INFO - Running setup.py (path:/tmp/pip-L5oJkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:44 INFO - Running setup.py (path:/tmp/pip-nBrCTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:44 INFO - Running setup.py (path:/tmp/pip-Ub37nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:44 INFO - Running setup.py (path:/tmp/pip-Z73ff_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:44 INFO - Running setup.py (path:/tmp/pip-d8AZ3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:44 INFO - Running setup.py install for manifestparser 02:07:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:44 INFO - Running setup.py install for mozcrash 02:07:44 INFO - Running setup.py install for mozdebug 02:07:45 INFO - Running setup.py install for mozdevice 02:07:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for mozfile 02:07:45 INFO - Running setup.py install for mozhttpd 02:07:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for mozinfo 02:07:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for mozInstall 02:07:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for mozleak 02:07:45 INFO - Running setup.py install for mozlog 02:07:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for moznetwork 02:07:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Running setup.py install for mozprocess 02:07:46 INFO - Running setup.py install for mozprofile 02:07:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:46 INFO - Running setup.py install for mozrunner 02:07:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:46 INFO - Running setup.py install for mozscreenshot 02:07:46 INFO - Running setup.py install for moztest 02:07:46 INFO - Running setup.py install for mozversion 02:07:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:46 INFO - Cleaning up... 02:07:46 INFO - Return code: 0 02:07:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:46 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 02:07:46 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 02:07:46 INFO - Using env: {'DISPLAY': ':0', 02:07:46 INFO - 'HOME': '/home/cltbld', 02:07:46 INFO - 'LANG': 'en_US.UTF-8', 02:07:46 INFO - 'LANGUAGE': 'en_US:en', 02:07:46 INFO - 'LOGNAME': 'cltbld', 02:07:46 INFO - 'MAIL': '/var/mail/cltbld', 02:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:46 INFO - 'MOZ_NO_REMOTE': '1', 02:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:46 INFO - 'NO_EM_RESTART': '1', 02:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:46 INFO - 'PWD': '/builds/slave/test', 02:07:46 INFO - 'SHELL': '/bin/bash', 02:07:46 INFO - 'SHLVL': '1', 02:07:46 INFO - 'TERM': 'linux', 02:07:46 INFO - 'TMOUT': '86400', 02:07:46 INFO - 'USER': 'cltbld', 02:07:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:46 INFO - '_': '/tools/buildbot/bin/python'} 02:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:46 INFO - Running setup.py (path:/tmp/pip-RFhSuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:46 INFO - Running setup.py (path:/tmp/pip-9akD75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:46 INFO - Running setup.py (path:/tmp/pip-1RVqHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:47 INFO - Running setup.py (path:/tmp/pip-dBb8D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:47 INFO - Running setup.py (path:/tmp/pip-6vOnj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:47 INFO - Running setup.py (path:/tmp/pip-cfDWt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:47 INFO - Running setup.py (path:/tmp/pip-GWbmSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:47 INFO - Running setup.py (path:/tmp/pip-cxEafg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:47 INFO - Running setup.py (path:/tmp/pip-iWuMvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:47 INFO - Running setup.py (path:/tmp/pip-xWiVcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:47 INFO - Running setup.py (path:/tmp/pip-ixnt9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:47 INFO - Running setup.py (path:/tmp/pip-E5OMlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:47 INFO - Running setup.py (path:/tmp/pip-cqN1WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:47 INFO - Running setup.py (path:/tmp/pip-xKKJ0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:47 INFO - Running setup.py (path:/tmp/pip-j1tB9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:47 INFO - Running setup.py (path:/tmp/pip-bxu3vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:47 INFO - Running setup.py (path:/tmp/pip-OSUANr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:48 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)) 02:07:48 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)) 02:07:48 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)) 02:07:48 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)) 02:07:48 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)) 02:07:48 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)) 02:07:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:49 INFO - Downloading blessings-1.6.tar.gz 02:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:50 INFO - Installing collected packages: blessings 02:07:50 INFO - Running setup.py install for blessings 02:07:50 INFO - Successfully installed blessings 02:07:50 INFO - Cleaning up... 02:07:50 INFO - Return code: 0 02:07:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:50 INFO - Reading from file tmpfile_stdout 02:07:50 INFO - Current package versions: 02:07:50 INFO - argparse == 1.2.1 02:07:50 INFO - blessings == 1.6 02:07:50 INFO - blobuploader == 1.2.4 02:07:50 INFO - docopt == 0.6.1 02:07:50 INFO - functools32 == 3.2.3-2 02:07:50 INFO - jsonschema == 2.5.1 02:07:50 INFO - manifestparser == 1.1 02:07:50 INFO - mozInstall == 1.12 02:07:50 INFO - mozcrash == 0.17 02:07:50 INFO - mozdebug == 0.1 02:07:50 INFO - mozdevice == 0.48 02:07:50 INFO - mozfile == 1.2 02:07:50 INFO - mozhttpd == 0.7 02:07:50 INFO - mozinfo == 0.9 02:07:50 INFO - mozleak == 0.1 02:07:50 INFO - mozlog == 3.2 02:07:50 INFO - moznetwork == 0.27 02:07:50 INFO - mozprocess == 0.22 02:07:50 INFO - mozprofile == 0.28 02:07:50 INFO - mozrunner == 6.11 02:07:50 INFO - mozscreenshot == 0.1 02:07:50 INFO - mozsystemmonitor == 0.3 02:07:50 INFO - moztest == 0.7 02:07:50 INFO - mozversion == 1.4 02:07:50 INFO - psutil == 3.1.1 02:07:50 INFO - requests == 1.2.3 02:07:50 INFO - wsgiref == 0.1.2 02:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 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 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:50 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 02:07:50 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 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 INFO - Cleaning up... 02:07:50 INFO - Return code: 0 02:07:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:07:50 INFO - Cleaning up... 02:07:50 INFO - Return code: 0 02:07:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0088511f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, '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': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', '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 02:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:51 INFO - Downloading/unpacking flake8 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:53 INFO - no previously-included directories found matching 'docs/_build' 02:07:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:53 INFO - Running setup.py install for pep8 02:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:53 INFO - no previously-included directories found matching 'docs/_build' 02:07:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:53 INFO - Cleaning up... 02:07:53 INFO - Return code: 0 02:07:53 INFO - Running post-action listener: _resource_record_post_action 02:07:53 INFO - Running post-action listener: _start_resource_monitoring 02:07:53 INFO - Starting resource monitoring. 02:07:53 INFO - ##### 02:07:53 INFO - ##### Finished create-virtualenv step (success) 02:07:53 INFO - ##### 02:07:53 INFO - ##### 02:07:53 INFO - ##### Running install step. 02:07:53 INFO - ##### 02:07:53 INFO - Running pre-action listener: _resource_record_pre_action 02:07:53 INFO - Running main action method: install 02:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:54 INFO - Reading from file tmpfile_stdout 02:07:54 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:54 INFO - Reading from file tmpfile_stdout 02:07:54 INFO - Output received: 02:07:54 INFO - Usage: mozinstall [options] installer 02:07:54 INFO - Options: 02:07:54 INFO - -h, --help show this help message and exit 02:07:54 INFO - -d DEST, --destination=DEST 02:07:54 INFO - Directory to install application into. [default: 02:07:54 INFO - "/builds/slave/test"] 02:07:54 INFO - --app=APP Application being installed. [default: firefox] 02:07:54 INFO - mkdir: /builds/slave/test/build/application 02:07:54 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'] 02:07:54 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 02:08:11 INFO - Reading from file tmpfile_stdout 02:08:11 INFO - Output received: 02:08:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:08:11 INFO - Running post-action listener: _resource_record_post_action 02:08:11 INFO - ##### 02:08:11 INFO - ##### Finished install step (success) 02:08:11 INFO - ##### 02:08:11 INFO - ##### 02:08:11 INFO - ##### Running run-tests step. 02:08:11 INFO - ##### 02:08:11 INFO - Running pre-action listener: _resource_record_pre_action 02:08:11 INFO - Running main action method: run_tests 02:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:11 INFO - Python 2.7.3 02:08:11 INFO - Return code: 0 02:08:11 INFO - grabbing minidump binary from tooltool 02:08:11 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')]} 02:08:11 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 0x1878110>, '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 0x17e4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e46c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:11 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 02:08:11 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 02:08:11 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 02:08:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:11 INFO - Return code: 0 02:08:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:08:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:08:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:12 INFO - Return code: 0 02:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:08:12 INFO - Using env: {'DISPLAY': ':0', 02:08:12 INFO - 'HOME': '/home/cltbld', 02:08:12 INFO - 'LANG': 'en_US.UTF-8', 02:08:12 INFO - 'LANGUAGE': 'en_US:en', 02:08:12 INFO - 'LOGNAME': 'cltbld', 02:08:12 INFO - 'MAIL': '/var/mail/cltbld', 02:08:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:12 INFO - 'MOZ_NO_REMOTE': '1', 02:08:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:12 INFO - 'NO_EM_RESTART': '1', 02:08:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:12 INFO - 'PWD': '/builds/slave/test', 02:08:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:12 INFO - 'SHELL': '/bin/bash', 02:08:12 INFO - 'SHLVL': '1', 02:08:12 INFO - 'TERM': 'linux', 02:08:12 INFO - 'TMOUT': '86400', 02:08:12 INFO - 'USER': 'cltbld', 02:08:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278', 02:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:12 INFO - '_': '/tools/buildbot/bin/python'} 02:08:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:08:12 INFO - mozversion application_buildid: 20160610233028 02:08:12 INFO - mozversion application_changeset: 2719065dd5a6045af640e32222b5d4359ae87000 02:08:12 INFO - mozversion application_display_name: Nightly 02:08:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:12 INFO - mozversion application_name: Firefox 02:08:12 INFO - mozversion application_remotingname: firefox 02:08:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:08:12 INFO - mozversion application_vendor: Mozilla 02:08:12 INFO - mozversion application_version: 50.0a1 02:08:12 INFO - mozversion platform_buildid: 20160610233028 02:08:12 INFO - mozversion platform_changeset: 2719065dd5a6045af640e32222b5d4359ae87000 02:08:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:08:12 INFO - mozversion platform_version: 50.0a1 02:08:12 INFO - using testdate: 1465636092 02:08:12 INFO - actual date: 1465636092 02:08:12 INFO - starting webserver on 'localhost:37070' 02:08:12 INFO - SUITE-START | Running 2 tests 02:08:12 INFO - TEST-START | dromaeo_css 02:08:12 INFO - operating with platform_type : linux_ 02:08:12 INFO - Initialising browser for dromaeo_css test... 02:08:12 INFO - TEST-INFO | started process 17737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3MusO/profile http://localhost:37070/getInfo.html) 02:08:16 INFO - PROCESS | 17737 | __metrics Screen width/height:1600/1200 02:08:16 INFO - PROCESS | 17737 | colorDepth:24 02:08:16 INFO - PROCESS | 17737 | Browser inner width/height: 1024/697 02:08:16 INFO - PROCESS | 17737 | __metrics 02:08:17 INFO - PROCESS | 17737 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:18 INFO - PROCESS | 17737 | console.error: PushService: 02:08:18 INFO - PROCESS | 17737 | stateChangeProcessEnqueue: Error transitioning state 02:08:18 INFO - PROCESS | 17737 | UnknownError 02:08:18 INFO - TEST-INFO | 17737: exit 0 02:08:18 INFO - Browser initialized. 02:08:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:18 INFO - TEST-INFO | started process 17819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3MusO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:30 INFO - PROCESS | 17819 | RSS: Main: 174157824 02:08:30 INFO - PROCESS | 17819 | 02:09:22 INFO - PROCESS | 17819 | 1465636162327 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] 02:11:30 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37070/tests/dromaeo/cssquery-ext.html) 02:11:31 INFO - PROCESS | 17819 | RSS: Main: 275124224 02:11:31 INFO - PROCESS | 17819 | 02:14:33 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-ext.html (next: http://localhost:37070/tests/dromaeo/cssquery-jquery.html) 02:14:33 INFO - PROCESS | 17819 | RSS: Main: 254287872 02:14:33 INFO - PROCESS | 17819 | 02:17:36 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37070/tests/dromaeo/cssquery-mootools.html) 02:17:36 INFO - PROCESS | 17819 | RSS: Main: 262307840 02:17:36 INFO - PROCESS | 17819 | 02:20:38 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37070/tests/dromaeo/cssquery-prototype.html) 02:20:39 INFO - PROCESS | 17819 | RSS: Main: 253788160 02:20:39 INFO - PROCESS | 17819 | 02:23:42 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37070/tests/dromaeo/cssquery-yui.html) 02:23:42 INFO - PROCESS | 17819 | RSS: Main: 232771584 02:23:42 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-yui.html (next: http://localhost:37070/tests/dromaeo/cssquery-dojo.html) 02:26:45 INFO - PROCESS | 17819 | RSS: Main: 292933632 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | __start_tp_report 02:26:45 INFO - PROCESS | 17819 | _x_x_mozilla_page_load 02:26:45 INFO - PROCESS | 17819 | _x_x_mozilla_page_load_details 02:26:45 INFO - PROCESS | 17819 | |i|pagename|runs| 02:26:45 INFO - PROCESS | 17819 | |0;dojo.html;3095.9845200773993;3100.209446591119;3118.9220269493267;3140.513220450831;3161.304513007139;5212.2963399941;5292.947070529293;5358.115910874706;5385.946140538598;5428.375736790265;5336.493033161853;5346.064438723218;5357.651752636076;5400.270963419937;5451.373092094401;4810.254410566359;4895.290182923474;4898.044881248158;4907;5125.769340379673;5011.924821127686;5026.396832380119;5050.595952323823;5081.491850814908;5085.745712714368;4741.9525804742025;4798.688085274463;4878.780454879521;4909.337239472661;4935.851924442272;4905.779239934212;4977.402711674622;4981.028699403618;4983.700977941299;5031.924521132186;4920.926186107211;4924.704517728912;4962.131626965267;4966.379202599675;5017.824376146854;5178.093833579109;5271.683698978073;5358.115910874701;5368.973155134199;5403.756830942578;5759.913601295984;5760.193572899798;5771.422857714237;5771.480566749013;5787.1608616750755;5656.377798442168;5798.217240672498;5827.446392592697;5830.183774271605;5832.562557808182;5267.499587539178;5308.654937429054;5332.040232758102;5332.33345831771;5337.519623233928;5846.444587764156;5909.468147866713;5911.615744976562;5912.172295878494;5913.822585322448;5488.506034456838;5597.80407685729;5701.543876489871;5722.227499287626;5723.914141287884;5712.028955077563;5731.254936858265;5740.770369185269;5786.016377215883;5792.710364481759;5679.176519404663;5686.715664216773;5716.628419152742;5722.599418040697;5724.313082430135;5556.527695145877;5680.204771332017;5724.742386592613;5737.77048918047;5741.885162296814;4394.538573449806;4398.186335527937;4400.141972315368;4437.42313499243;4441.311596702516;3889.5138107736534;3891.747036442679;3894.7468414552964;3945.8027098645525;3946.565877753445;5255.211718242294;5402.756875940592;5429;5446.101393270066;5502.5597952163735;5842.5618078644275;5852.531797456193;5860;5861.5603829712945;5906.7637294508595;5526.723663816873;5530.5022547970875;5531.861703457445;5533.418991005967;5536.557075433956;4793.161196790617;4968;5011.84964451067;5019.347484826949;5043.899122017539;5972.552058595623;5988.970055149784;5990.940090599125;5993.130996005555;5996.940030599638;5606.607537472501;5824.475797178105;5859.765609375577;5865.237519122486;5870.5010074144175;5932.080527518242;5963.463288304073;5998.190244316961;6008;6028.758849645965;5694.288213973254;5698.857528561819;5709.058005429058;5723.399043100581;5728.484436400744;5592.524635406036;5724.255846739898;5832.94167058324;5842.328132264844;5844.649321040752;5567.220589117608;5633.267675202197;5635.802746903839;5653.943460565341;5692.032354499662;5611.270534830446;5658.830235092953;5662.348829884616;5663.915041274302;5665.065264231355;5381.946180538144;5467.043267428105;5512.6968016759465;5582.86042848932;5598.244237027949;5633.492985631313;5636.661800291996;5640.717964101696;5648.915266271091;5671.6597004179885;5448.291722076105;5452.291202143696;5452.345718513804;5461.617686761889;5463.071277882849 02:26:45 INFO - PROCESS | 17819 | |1;ext.html;575.7092668202557;604.9697515124243;608.0909040983727;619.8419403052222;626.6803929995704;32731.836340818292;36077.63922360776;41932;43213;43228.78385608076;44694.32958505625;45184.322235166495;45232;45263.54736452635;45299.547004529944;8787.912120878773;8958.32812539059;8966.820663586725;8967.417117887317;8967.730968070968;8811.691590794324;8883.51140687262;8911.420757650765;8915.910840891573;8919.464832110061;8938.240249578761;8995.775105622346;9001.819963600725;9003.414778039407;9003.95498022509;8877.689280875138;8897.555122243893;8900.777480562972;8958.999999999967;8962.103789621051;8746.387752857303;8805.867911981326;8808;8814.559272036437;8832.55837208137;42801.14397712059;43123.568764312266;43172;43173;43277;3464.1512829356716;3529.717622590212;3558.448440491728;3570.732195085353;3600.891973240807;32452.513212301834;32751.344973100404;32793;32876.835615821765;33402.49896251558;4204.348326009474;4233.894152646178;4239.8092085856215;4266.189424009428;4282.48610166782;348988;349281;349913;350332;351002;54947.175792362345;55093.173602396;55395.44604553984;55446.44553554413;55481.167782483295;34690.13274668103;35403.64596354055;35441.46837797435;37680;59744.40255597388;16140.43508477221;16280.918595406947;16289.59276018109;16291.266892989845;16296.022238665719;12223.1443798935;12339.6915077122;12347.876521234852;12348;12361.443735031946;19265.61468770645;19276;19279.493665823353;19403.708944365844;19455.12451939666;6730.966345168341;6829.760958366533;7001.404880585207;7110.288971102848;7231.783046508614;981.7054883535054;1022.7726727926517;1032.7245851373548;1109.2900543651908;1127.2053202492223;31513.8424307877;31667.36665266728;31774.523382149287;31810.522842157385;32644.819695179103;1095.3756358875523;1108.3460758152567;1152.809786385237;1176.9529218831321;1197.8862008109215;16694.58263543397;17084.40204592833;17107.828921710872;17144.828551714574;17236.569085772957;150394;150556.2472187632;151363;151959;151975;57071.71464142653;58585;58624.706876465345;58663.70668146632;58670.11994820081;1245.414655112114;1344.7243315120377;1361.4145917255676;1362.087401441037;1380.9447622095004;32190.67809321877;33463.83268083644;33605.66394336123;33905.38010235925;33988;48939.5106048935;49365.50634493609;49394.259086113016;49462.258066129754;49485;313444;314524;314543;314787;315406;26893.86553067222;27691.584626231026;27923.860380698778;28028.43943121167;28060;47834;48051.03897921952;48618.87258564118;48705.75647121741;48797.268040978706;40841.59158408378;41072.38391424191;41142;41440.79279603583;41796;39828.339855224076;40070.599294006686;40382.79808600938;40536.59463405446;41159.7942010288;40716.1856762869;40721;40872.59127408688;41262.79368603138;41452.79273603613;35521.64478355287;36625.81687091654;37191.814040929625;37232.627673724;37502.06244843901;27824.860875695493;28270.57594136131;28380.148595542167;28453.43093138167;28496.715032850236 02:26:45 INFO - PROCESS | 17819 | |2;jquery.html;386.75827607745157;392.2214404407252;393.6142580271336;399.3032158882749;408.86711818658927;14026.43894244229;15668.921655391736;17682.29270829167;19329.903350483244;19363.419097427082;15315.387384504607;17424.738628920575;18302.450926472226;18656.533586660305;18996.715049274273;5496.670199788015;5620.91568626471;5659.886802263953;5664.631798933056;5702.515286200657;4117;5621.409751976045;5655.915161272585;5920.4671579557835;6220.688965551727;6186.133941248228;6201.790650823092;6213.7514499420195;6224.564280500367;6248.718807653644;6083.148359229712;6127.908081378783;6272.341404152567;6282.780102696406;6288.088227207075;5366.060939335601;5527.834164975017;5546.473085056913;5547.944520554784;5552.694601796899;21957.451063723536;22100.025923784186;22256.666150007764;22426.102955881746;22491.887540562355;2361.161787565407;2676.9598456023177;2764.7649949754295;2793.972060279412;3083.3308363048127;13872.167669939836;13932.899110190378;14008.929955350159;14164.079334843305;14566.053206541646;1887.5186827359073;1941.3205378117686;1945.046927005771;1953.8925359105244;2009.1762377425332;80166;80784.59607701983;82329;82507.7623835649;82680.58659706723;10068.244881633907;10202.234832387601;10283.794324113476;10395.688129356131;10447.79850317208;14619.561413157622;14654.926725366306;14692.19192944377;14710.264486775619;14724.116553006854;7348.669309880961;7500.962495187489;7607.16321204667;7663.961680191564;7699.730509432143;6526.151600292027;7091.290870912868;7108.537945033556;7264.200937896827;7306.305900939402;5941.851453713605;6151.784687535915;6328.493720502349;6523;6525.967370163119;1835.8255965683506;1878.483417060292;1895.4408449507428;1913.8373238274903;1933.8285212251917;955.7515046087929;996.4220751963989;1045.1482042135635;1068.2041878800187;1110.972225694348;18765.343212987755;19086.713699294523;19143.90428047851;19216.61566768685;19580.902095489433;1027.9331843430152;1031.6595523477386;1037.455335948633;1040.5109598488698;1059.8516207730925;10609.575616975235;10893.83659245112;11060.391678457761;11104.278221915549;11115.444227788577;466031;467229;468735;469582;487462;75439.86840197402;79948.60025699834;82739.5863020693;84405;85006;1006.5319626373625;1024.283001898674;1036.3056751976194;1040.9635662751768;1045.132539991805;16512.587185320463;16631.667366652357;16678.49964501067;16696.916515417346;16852.1573921301;36248.456273155396;37825.62174378221;37840;38013.61986380101;39034.80482597569;51901.22148167856;52943;53363.4663653374;53704;53912.19131712949;8431.95784021076;8571.742847714579;8582.871256931276;8707.564621768759;8742.650293988168;12482.375881206084;12759.74480510366;12809.231446113263;12898.226106433644;13173;11362.772744544898;11460.53176468263;11493.080553555528;11672.416379181177;11772.587959421378;11117.444127793417;11214.327140371604;11306.378149201544;11498.310101393943;11581.363025033366;11578.76842463163;11676.824847627122;11683.88316116828;11884.227525210834;11947.462364193805;8474.449160804528;8475.364347673825;8548;8576.142385761374;8618.05201427855;11617.593384231512;11618.94190529042;11698.35659038727;11733.530658773894;11888.583899563473 02:26:45 INFO - PROCESS | 17819 | |3;mootools.html;1314.947402103916;1456.7960485532028;1496.1845794042247;1601.3514526616716;1793.7130059190524;8557.700480483185;8860.911390886089;8936.195742383185;9143.222826059793;9148.405353652024;8888.55557222138;9088.727338179866;9099.181073703365;9102.362834601565;9113.088691130884;2049.661805802041;2302.3553405046614;2373.216838443318;2399.2442380650127;2435.744246854081;2392.342105920868;2395.281415575329;2396.0176327705644;2400.84394514356;2401.7238017628024;2318.119114736398;2361.917332893349;2362.6692263083182;2379.6073647848084;2394.940126496834;1984.2360691133945;2241.350008497534;2308.1113771198043;2309.2956648222284;2316.9073237070497;2295.540891821626;2312.6993490846085;2329.056732023533;2329.7320808106947;2333.498297865967;9057.275417966614;9179.632814687404;9201;9209.493477858716;9220.8616870747;4993.7503124843615;5137.871553211162;5140.794368225266;5141.074606570815;5146.305248791403;3324.9501257481156;3480.269143479872;3506.2987402519598;3528.417811061172;3547.6984456320984;1146.157574182975;1191.8212268159846;1197.8023626101683;1208.7763763703742;1257.4027337014936;12979.67550811228;13009.154404963647;13045.86954130456;13053.282069486175;13057.738845223137;4563.269876819693;4633.791479383436;4701.506341834058;4702.15361234981;4708.976455117702;10751.569937202425;10810.405427701551;10855.891441085647;10867.619633312954;10875.075618572351;5289.9471005290225;5298.364196296392;5314.70769107695;5329.493698098674;5341.385740639798;4366.694331396771;4764.332993380929;4885.096257192431;4896.094222568836;4905.288733133676;4027.3470330631794;4057.634812866797;4111.691623128278;4133.090720041646;4133.318002529549;1264.367816091954;1270.4791035675328;1271.4786937355639;1280.9807852882213;1292.4184117147133;1032.5405194688442;1034.2294990232174;1036.6786296248188;1045.8012977534245;1049.4490392543823;6176.258848938156;6195.876082478325;6255.186825712719;6261.154744109578;6363.9802500597425;445.10533827007947;453.15260462934526;458.0198375476483;464.70723444230595;466.2795980210583;4028.576999415019;4180.979095104566;4249.235137675187;4268.743875367426;4271.9960809209815;11252.268602540973;11291.774164516664;11655.358955257372;11675.35785531804;11760.411979400995;10743.623973160902;11456.94271528637;11513.25163864363;11528;11558.94220528892;8249;8565.700200492953;8594.957025214959;8612.827743445096;8614.569271536398;6294.590851594632;6370.394812492806;6409.070684750592;6464.838379040561;6478.384553467413;9973.551190196313;10178.389296642225;10286.897131028893;10447.373157610567;10454.895451045697;10505.842412363974;10512.57949682004;10586.576536938435;10626.574937002742;10732.087772539422;7362.263773622595;7848.018997625297;8043.517388956681;8088.9595552021865;8167.469114507538;8623.353248506513;8658.56707164652;8679.91320086791;8737.91262087371;8739.21347078766;7598.620068996639;7792.922070779219;7835.177306382976;7844.294013538809;7873.881891771513;7710.498817577064;7714.729984450517;7851.803704907423;7869.134395216407;7891.84216315659;7362.042934418491;7392.704291828267;7422.960785490143;7433.070866141732;7488.775336739906;5299.761510731949;5331.813386531453;5446.482584154499;5511.145772405283;5716.171155182558;5418.214358918013;5557.749901254372;5572.693501857437;5583.610012127419;5653.971730141323 02:26:45 INFO - PROCESS | 17819 | |4;prototype.html;296.7952113042001;306.7377392329558;312.3238189320122;315.42435056022765;315.87207181091657;5050.419201791795;5208.140656791625;5279.498447647472;5319.388270348906;5360.785568577257;4914.189158788805;5258.869343091234;5277.656952298107;5278.498542638453;5295.602829787772;4172.207280616688;4173.979130104352;4178;4179.554960348185;4188.685848561355;3928.4892963914795;4017.738846974937;4042.6765858731233;4198.874033778991;4204.033072393351;4058.208649313385;4065.329220678599;4104.865469955621;4104.8973775655695;4112.3625837995005;4113.773742444165;4126.958730412717;4133.731307465006;4139.317012692902;4139.4204811326435;3663.5420572428447;3668.3030224257304;3676.1912379276782;3680.4663323818163;3687.9858039039477;5143.71407148213;5163.819266325698;5176.171812509981;5180.740962951875;5230.790768369298;4413.271810151321;4509.368688383629;4550.88622784433;4562.429696287964;4565.840195593139;5339.279197308391;5475.917861232085;5475.945240547583;5498.367687715924;5505.201745746885;3948.861789837342;3949.526056873165;3953.6639385652256;3953.98023009886;3958.2677204716933;5468.644538105011;5677.716114194273;5695.572832037572;5724.456176663252;5754.510866576346;3993.840246390112;3994.6604538614542;3996.320625493673;4014.9397759033636;4055.1889622075705;4075.0627355708352;4080.8573599392216;4094.877153685394;4122.237386083584;4147.668186545069;4601.815927362935;4608.884777880513;4657.928676404446;4683.2038553446;4700.459447163552;5503.3395992481155;5509.090999984957;5514.531264842533;5555.805546805843;5556.971960187298;1403.8666326698947;1409;1417.922014289224;1419.6025112968384;1425.8645428684258;886.6926364659855;902.278177458031;910.5310764956052;920.2239677422505;923.9282432378409;4788.808447662054;4796.928046079312;4800.255960326155;4814.277858321209;4826.300186472942;5006.52438018395;5041.193409054534;5080.314157588752;5084.339035925306;5092.388913330424;4682.618662151396;4683.15703173432;4751.216049351819;4811.49479304675;4825.662203645711;2696.4067905060856;2697.7706894914154;2699.487097451478;2709.0112109080437;2720.428709970928;5175.327207463006;5175.378954525406;5223.895522089537;5229.660072095302;5237.319148510669;5049;5160.7419629018395;5172.405173405106;5307.548858347083;5471.562275018068;5865.8854817586225;5889.705514724246;5900.20347253124;5902.1146827976145;5917.6389430431245;5662.971685141548;5683.715814209356;5689.857753556194;5702.857428564319;5722.341930677859;5453.809116680897;5653.886922261449;5663.773449061991;5667.914981275367;5696.658200507983;5848.420926349947;5855.502282306052;5862.530997520274;5878.706064696663;5908.316129903129;4022;4031.8387264510266;4049.838006479708;4083.8361067095734;4092.9795351023054;5735.598508104393;5762.761006383647;5769.413411311923;5772.249607550992;5782.45066718661;5345.545628621455;5466.835994920159;5474.6587086164145;5594.804181853616;5617.915731264116;5320.973395133155;5441.7279136043835;5478.369987451494;5537.141743029837;5554.166874968787;5379.273798037215;5458.4814442627885;5472.863178420572;5474.863128421821;5496.780128794803;5486.972565137149;5540.224368588481;5610.635308704921;5611.372701916562;5628.831135065954;5420.701861397661;5488.326060551411;5489.972550137224;5490.133354659435;5495.395506494362 02:26:45 INFO - PROCESS | 17819 | |5;yui.html;736.4550232827705;745.2547452547452;773.6905237904838;779.2207792207793;781.6209138567796;13547.525836595722;14051.859481405183;14238.359273832677;14272.571822845319;14802.629934251649;13355.53255636053;13365.866341336583;13367.598972030855;13375.063745537816;13387.59837204883;694.4756708684961;800.7517669522466;803.7789607857857;814.2102160903913;829.4608504472111;820.0446479850966;823.7117009046846;827.8054657155564;828.2173346187855;828.45736042892;848.3382961290173;851.3274513134617;853.9829203415928;856.6659002988839;856.8072183758636;712.3659942651045;819.2094628683319;843.6245870587529;844.6494704697543;847.0216899481109;619.3125630550086;619.4239357397663;619.6529943231805;619.6932518403374;620.751699320271;12652.240865548096;12765.425555849915;12770.48918043277;12772.808407873888;12782.488700451971;13711.588652340446;14095.71808563823;14154.221517816515;14168.291585420688;14395.856041439662;12448.128630995834;12466;12466.563670271496;12724.236545807282;12766.36168191596;4417.337399390085;4464.419625448703;4521.208788462039;4526.909461810746;4589.885252868671;70827.29172708259;70880.6455967722;72894.27105728928;74845.99999999946;76029;10417.374957502574;10563.894361056446;10588.941105889504;11250.437478126061;11670.824937625943;18846.340378086974;19429;19458.70811937822;19485.707714384294;19495.512612184808;8247.95876020628;8465.068842427328;8523.445976011539;8713.433626814236;8877.689280875138;4639.8144074237325;4720.173969555314;4720.834770783006;4773.618110551148;4891.853244402673;3465.151037995707;3587.94618080729;3613.728970327236;3613.728970327236;3618.3667858124722;542.8371488553419;552.3068548971015;604.41673784797;611.547454883392;613.4908026338218;651.8728847874619;691.816668582826;702.8488874891923;732.9706811727472;744.9664765085585;10182.287239893285;10451.68644940653;10654.200934929757;10864.674059778219;10904.78190436187;604.1572007050228;643.5141468191486;660.0528241972785;673.7237732529737;726.5168662839153;4618.907621847544;4890.657653964259;4946.579540739078;5013.5989120870245;5259.789608415621;110390;115944;117159;121759;124283;71358.64320678468;101172.98827011783;101956;102643;105440.47279763552;91871;91973;92052.53973730089;92446.53776731208;93183.5340823278;9346.345755797029;9364.672236471692;9371.156595906128;9401.905980940377;9477.620895164391;52649.736751316;53437.19844202418;53501.464985349645;53693.73153134209;54350.728246358514;49135.26297105475;75084;78906;79804;81274.18725812902;12871.22772633645;13158.342082896008;13272.601821945356;13327.600171994856;13589.116707413987;13333.267338494223;13850.238236897067;13857.514986975408;14028;14095.436182552994;13088.541901033419;13125.803112953505;13175.507439794465;13211.735765284833;13311.733765324832;13426.12237969966;13512.527061552799;13560.11859229147;13645.79531307051;13877.097988630707;11490.94254528722;11610.477528511068;11893.226940248856;11910.464029118884;12282.38588070575;10950.507227174638;11016.339019658846;11183.832242516206;11358.338841702096;11545;10679.57281708723;11041.227114101936;11428.142889283503;11460.770784584094;11564.826527602261 02:26:45 INFO - PROCESS | 17819 | __end_tp_report 02:26:45 INFO - PROCESS | 17819 | __start_cc_report 02:26:45 INFO - PROCESS | 17819 | _x_x_mozilla_cycle_collect,891 02:26:45 INFO - PROCESS | 17819 | __end_cc_report 02:26:45 INFO - PROCESS | 17819 | __startTimestamp1465637205563__endTimestamp 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | ------- Summary: start ------- 02:26:45 INFO - PROCESS | 17819 | Number of tests: 6 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#0] dojo.html Cycles:165 Average:5355.82 Median:5533.42 stddev:605.85 (10.9%) stddev-sans-first:581.19 02:26:45 INFO - PROCESS | 17819 | Values: 3096.0 3100.2 3118.9 3140.5 3161.3 5212.3 5292.9 5358.1 5385.9 5428.4 5336.5 5346.1 5357.7 5400.3 5451.4 4810.3 4895.3 4898.0 4907.0 5125.8 5011.9 5026.4 5050.6 5081.5 5085.7 4742.0 4798.7 4878.8 4909.3 4935.9 4905.8 4977.4 4981.0 4983.7 5031.9 4920.9 4924.7 4962.1 4966.4 5017.8 5178.1 5271.7 5358.1 5369.0 5403.8 5759.9 5760.2 5771.4 5771.5 5787.2 5656.4 5798.2 5827.4 5830.2 5832.6 5267.5 5308.7 5332.0 5332.3 5337.5 5846.4 5909.5 5911.6 5912.2 5913.8 5488.5 5597.8 5701.5 5722.2 5723.9 5712.0 5731.3 5740.8 5786.0 5792.7 5679.2 5686.7 5716.6 5722.6 5724.3 5556.5 5680.2 5724.7 5737.8 5741.9 4394.5 4398.2 4400.1 4437.4 4441.3 3889.5 3891.7 3894.7 3945.8 3946.6 5255.2 5402.8 5429.0 5446.1 5502.6 5842.6 5852.5 5860.0 5861.6 5906.8 5526.7 5530.5 5531.9 5533.4 5536.6 4793.2 4968.0 5011.8 5019.3 5043.9 5972.6 5989.0 5990.9 5993.1 5996.9 5606.6 5824.5 5859.8 5865.2 5870.5 5932.1 5963.5 5998.2 6008.0 6028.8 5694.3 5698.9 5709.1 5723.4 5728.5 5592.5 5724.3 5832.9 5842.3 5844.6 5567.2 5633.3 5635.8 5653.9 5692.0 5611.3 5658.8 5662.3 5663.9 5665.1 5381.9 5467.0 5512.7 5582.9 5598.2 5633.5 5636.7 5640.7 5648.9 5671.7 5448.3 5452.3 5452.3 5461.6 5463.1 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#1] ext.html Cycles:180 Average:45482.18 Median:39949.47 stddev:74917.90 (187.5%) stddev-sans-first:75052.19 02:26:45 INFO - PROCESS | 17819 | Values: 575.7 605.0 608.1 619.8 626.7 32731.8 36077.6 41932.0 43213.0 43228.8 44694.3 45184.3 45232.0 45263.5 45299.5 8787.9 8958.3 8966.8 8967.4 8967.7 8811.7 8883.5 8911.4 8915.9 8919.5 8938.2 8995.8 9001.8 9003.4 9004.0 8877.7 8897.6 8900.8 8959.0 8962.1 8746.4 8805.9 8808.0 8814.6 8832.6 42801.1 43123.6 43172.0 43173.0 43277.0 3464.2 3529.7 3558.4 3570.7 3600.9 32452.5 32751.3 32793.0 32876.8 33402.5 4204.3 4233.9 4239.8 4266.2 4282.5 348988.0 349281.0 349913.0 350332.0 351002.0 54947.2 55093.2 55395.4 55446.4 55481.2 34690.1 35403.6 35441.5 37680.0 59744.4 16140.4 16280.9 16289.6 16291.3 16296.0 12223.1 12339.7 12347.9 12348.0 12361.4 19265.6 19276.0 19279.5 19403.7 19455.1 6731.0 6829.8 7001.4 7110.3 7231.8 981.7 1022.8 1032.7 1109.3 1127.2 31513.8 31667.4 31774.5 31810.5 32644.8 1095.4 1108.3 1152.8 1177.0 1197.9 16694.6 17084.4 17107.8 17144.8 17236.6 150394.0 150556.2 151363.0 151959.0 151975.0 57071.7 58585.0 58624.7 58663.7 58670.1 1245.4 1344.7 1361.4 1362.1 1380.9 32190.7 33463.8 33605.7 33905.4 33988.0 48939.5 49365.5 49394.3 49462.3 49485.0 313444.0 314524.0 314543.0 314787.0 315406.0 26893.9 27691.6 27923.9 28028.4 28060.0 47834.0 48051.0 48618.9 48705.8 48797.3 40841.6 41072.4 41142.0 41440.8 41796.0 39828.3 40070.6 40382.8 40536.6 41159.8 40716.2 40721.0 40872.6 41262.8 41452.8 35521.6 36625.8 37191.8 37232.6 37502.1 27824.9 28270.6 28380.1 28453.4 28496.7 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#2] jquery.html Cycles:180 Average:27928.35 Median:22341.38 stddev:77631.54 (347.5%) stddev-sans-first:77821.77 02:26:45 INFO - PROCESS | 17819 | Values: 386.8 392.2 393.6 399.3 408.9 14026.4 15668.9 17682.3 19329.9 19363.4 15315.4 17424.7 18302.5 18656.5 18996.7 5496.7 5620.9 5659.9 5664.6 5702.5 4117.0 5621.4 5655.9 5920.5 6220.7 6186.1 6201.8 6213.8 6224.6 6248.7 6083.1 6127.9 6272.3 6282.8 6288.1 5366.1 5527.8 5546.5 5547.9 5552.7 21957.5 22100.0 22256.7 22426.1 22491.9 2361.2 2677.0 2764.8 2794.0 3083.3 13872.2 13932.9 14008.9 14164.1 14566.1 1887.5 1941.3 1945.0 1953.9 2009.2 80166.0 80784.6 82329.0 82507.8 82680.6 10068.2 10202.2 10283.8 10395.7 10447.8 14619.6 14654.9 14692.2 14710.3 14724.1 7348.7 7501.0 7607.2 7664.0 7699.7 6526.2 7091.3 7108.5 7264.2 7306.3 5941.9 6151.8 6328.5 6523.0 6526.0 1835.8 1878.5 1895.4 1913.8 1933.8 955.8 996.4 1045.1 1068.2 1111.0 18765.3 19086.7 19143.9 19216.6 19580.9 1027.9 1031.7 1037.5 1040.5 1059.9 10609.6 10893.8 11060.4 11104.3 11115.4 466031.0 467229.0 468735.0 469582.0 487462.0 75439.9 79948.6 82739.6 84405.0 85006.0 1006.5 1024.3 1036.3 1041.0 1045.1 16512.6 16631.7 16678.5 16696.9 16852.2 36248.5 37825.6 37840.0 38013.6 39034.8 51901.2 52943.0 53363.5 53704.0 53912.2 8432.0 8571.7 8582.9 8707.6 8742.7 12482.4 12759.7 12809.2 12898.2 13173.0 11362.8 11460.5 11493.1 11672.4 11772.6 11117.4 11214.3 11306.4 11498.3 11581.4 11578.8 11676.8 11683.9 11884.2 11947.5 8474.4 8475.4 8548.0 8576.1 8618.1 11617.6 11618.9 11698.4 11733.5 11888.6 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#3] mootools.html Cycles:180 Average:5981.39 Median:449.13 stddev:3474.96 (773.7%) stddev-sans-first:3467.01 02:26:45 INFO - PROCESS | 17819 | Values: 1314.9 1456.8 1496.2 1601.4 1793.7 8557.7 8860.9 8936.2 9143.2 9148.4 8888.6 9088.7 9099.2 9102.4 9113.1 2049.7 2302.4 2373.2 2399.2 2435.7 2392.3 2395.3 2396.0 2400.8 2401.7 2318.1 2361.9 2362.7 2379.6 2394.9 1984.2 2241.4 2308.1 2309.3 2316.9 2295.5 2312.7 2329.1 2329.7 2333.5 9057.3 9179.6 9201.0 9209.5 9220.9 4993.8 5137.9 5140.8 5141.1 5146.3 3325.0 3480.3 3506.3 3528.4 3547.7 1146.2 1191.8 1197.8 1208.8 1257.4 12979.7 13009.2 13045.9 13053.3 13057.7 4563.3 4633.8 4701.5 4702.2 4709.0 10751.6 10810.4 10855.9 10867.6 10875.1 5289.9 5298.4 5314.7 5329.5 5341.4 4366.7 4764.3 4885.1 4896.1 4905.3 4027.3 4057.6 4111.7 4133.1 4133.3 1264.4 1270.5 1271.5 1281.0 1292.4 1032.5 1034.2 1036.7 1045.8 1049.4 6176.3 6195.9 6255.2 6261.2 6364.0 445.1 453.2 458.0 464.7 466.3 4028.6 4181.0 4249.2 4268.7 4272.0 11252.3 11291.8 11655.4 11675.4 11760.4 10743.6 11456.9 11513.3 11528.0 11558.9 8249.0 8565.7 8595.0 8612.8 8614.6 6294.6 6370.4 6409.1 6464.8 6478.4 9973.6 10178.4 10286.9 10447.4 10454.9 10505.8 10512.6 10586.6 10626.6 10732.1 7362.3 7848.0 8043.5 8089.0 8167.5 8623.4 8658.6 8679.9 8737.9 8739.2 7598.6 7792.9 7835.2 7844.3 7873.9 7710.5 7714.7 7851.8 7869.1 7891.8 7362.0 7392.7 7423.0 7433.1 7488.8 5299.8 5331.8 5446.5 5511.1 5716.2 5418.2 5557.7 5572.7 5583.6 5654.0 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#4] prototype.html Cycles:180 Average:4567.96 Median:5168.11 stddev:1345.03 (26.0%) stddev-sans-first:1310.04 02:26:45 INFO - PROCESS | 17819 | Values: 296.8 306.7 312.3 315.4 315.9 5050.4 5208.1 5279.5 5319.4 5360.8 4914.2 5258.9 5277.7 5278.5 5295.6 4172.2 4174.0 4178.0 4179.6 4188.7 3928.5 4017.7 4042.7 4198.9 4204.0 4058.2 4065.3 4104.9 4104.9 4112.4 4113.8 4127.0 4133.7 4139.3 4139.4 3663.5 3668.3 3676.2 3680.5 3688.0 5143.7 5163.8 5176.2 5180.7 5230.8 4413.3 4509.4 4550.9 4562.4 4565.8 5339.3 5475.9 5475.9 5498.4 5505.2 3948.9 3949.5 3953.7 3954.0 3958.3 5468.6 5677.7 5695.6 5724.5 5754.5 3993.8 3994.7 3996.3 4014.9 4055.2 4075.1 4080.9 4094.9 4122.2 4147.7 4601.8 4608.9 4657.9 4683.2 4700.5 5503.3 5509.1 5514.5 5555.8 5557.0 1403.9 1409.0 1417.9 1419.6 1425.9 886.7 902.3 910.5 920.2 923.9 4788.8 4796.9 4800.3 4814.3 4826.3 5006.5 5041.2 5080.3 5084.3 5092.4 4682.6 4683.2 4751.2 4811.5 4825.7 2696.4 2697.8 2699.5 2709.0 2720.4 5175.3 5175.4 5223.9 5229.7 5237.3 5049.0 5160.7 5172.4 5307.5 5471.6 5865.9 5889.7 5900.2 5902.1 5917.6 5663.0 5683.7 5689.9 5702.9 5722.3 5453.8 5653.9 5663.8 5667.9 5696.7 5848.4 5855.5 5862.5 5878.7 5908.3 4022.0 4031.8 4049.8 4083.8 4093.0 5735.6 5762.8 5769.4 5772.2 5782.5 5345.5 5466.8 5474.7 5594.8 5617.9 5321.0 5441.7 5478.4 5537.1 5554.2 5379.3 5458.5 5472.9 5474.9 5496.8 5487.0 5540.2 5610.6 5611.4 5628.8 5420.7 5488.3 5490.0 5490.1 5495.4 02:26:45 INFO - PROCESS | 17819 | 02:26:45 INFO - PROCESS | 17819 | [#5] yui.html Cycles:180 Average:20681.17 Median:4492.81 stddev:30387.20 (676.4%) stddev-sans-first:30435.54 02:26:45 INFO - PROCESS | 17819 | Values: 736.5 745.3 773.7 779.2 781.6 13547.5 14051.9 14238.4 14272.6 14802.6 13355.5 13365.9 13367.6 13375.1 13387.6 694.5 800.8 803.8 814.2 829.5 820.0 823.7 827.8 828.2 828.5 848.3 851.3 854.0 856.7 856.8 712.4 819.2 843.6 844.6 847.0 619.3 619.4 619.7 619.7 620.8 12652.2 12765.4 12770.5 12772.8 12782.5 13711.6 14095.7 14154.2 14168.3 14395.9 12448.1 12466.0 12466.6 12724.2 12766.4 4417.3 4464.4 4521.2 4526.9 4589.9 70827.3 70880.6 72894.3 74846.0 76029.0 10417.4 10563.9 10588.9 11250.4 11670.8 18846.3 19429.0 19458.7 19485.7 19495.5 8248.0 8465.1 8523.4 8713.4 8877.7 4639.8 4720.2 4720.8 4773.6 4891.9 3465.2 3587.9 3613.7 3613.7 3618.4 542.8 552.3 604.4 611.5 613.5 651.9 691.8 702.8 733.0 745.0 10182.3 10451.7 10654.2 10864.7 10904.8 604.2 643.5 660.1 673.7 726.5 4618.9 4890.7 4946.6 5013.6 5259.8 110390.0 115944.0 117159.0 121759.0 124283.0 71358.6 101173.0 101956.0 102643.0 105440.5 91871.0 91973.0 92052.5 92446.5 93183.5 9346.3 9364.7 9371.2 9401.9 9477.6 52649.7 53437.2 53501.5 53693.7 54350.7 49135.3 75084.0 78906.0 79804.0 81274.2 12871.2 13158.3 13272.6 13327.6 13589.1 13333.3 13850.2 13857.5 14028.0 14095.4 13088.5 13125.8 13175.5 13211.7 13311.7 13426.1 13512.5 13560.1 13645.8 13877.1 11490.9 11610.5 11893.2 11910.5 12282.4 10950.5 11016.3 11183.8 11358.3 11545.0 10679.6 11041.2 11428.1 11460.8 11564.8 02:26:45 INFO - PROCESS | 17819 | -------- Summary: end -------- 02:26:45 INFO - PROCESS | 17819 | 02:26:46 INFO - TEST-INFO | 17819: exit 0 02:26:46 INFO - TEST-OK | dromaeo_css | took 1114059ms 02:26:46 INFO - TEST-START | kraken 02:26:46 INFO - operating with platform_type : linux_ 02:26:46 INFO - Initialising browser for kraken test... 02:26:46 INFO - TEST-INFO | started process 18003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOMQii6/profile http://localhost:37070/getInfo.html) 02:26:50 INFO - PROCESS | 18003 | __metrics Screen width/height:1600/1200 02:26:50 INFO - PROCESS | 18003 | colorDepth:24 02:26:50 INFO - PROCESS | 18003 | Browser inner width/height: 1024/697 02:26:50 INFO - PROCESS | 18003 | __metrics 02:26:51 INFO - PROCESS | 18003 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:51 INFO - PROCESS | 18003 | console.error: PushService: 02:26:51 INFO - PROCESS | 18003 | stateChangeProcessEnqueue: Error transitioning state 02:26:51 INFO - PROCESS | 18003 | UnknownError 02:26:52 INFO - TEST-INFO | 18003: exit 0 02:26:52 INFO - Browser initialized. 02:26:52 INFO - Running cycle 1/1 for kraken test... 02:26:52 INFO - TEST-INFO | started process 18083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOMQii6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:04 INFO - PROCESS | 18083 | RSS: Main: 174354432 02:27:04 INFO - PROCESS | 18083 | 02:27:06 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:07 INFO - PROCESS | 18083 | RSS: Main: 233205760 02:27:07 INFO - PROCESS | 18083 | 02:27:10 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-dft) 02:27:10 INFO - PROCESS | 18083 | RSS: Main: 220028928 02:27:10 INFO - PROCESS | 18083 | 02:27:14 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-fft) 02:27:14 INFO - PROCESS | 18083 | RSS: Main: 287154176 02:27:14 INFO - PROCESS | 18083 | 02:27:16 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-oscillator) 02:27:17 INFO - PROCESS | 18083 | RSS: Main: 197718016 02:27:17 INFO - PROCESS | 18083 | 02:27:19 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:20 INFO - PROCESS | 18083 | RSS: Main: 201539584 02:27:20 INFO - PROCESS | 18083 | 02:27:23 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:23 INFO - PROCESS | 18083 | RSS: Main: 237649920 02:27:23 INFO - PROCESS | 18083 | 02:27:27 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:27 INFO - PROCESS | 18083 | RSS: Main: 239194112 02:27:27 INFO - PROCESS | 18083 | 02:27:30 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37070/tests/kraken/driver.html?testName=json-parse-financial) 02:27:31 INFO - PROCESS | 18083 | RSS: Main: 238473216 02:27:31 INFO - PROCESS | 18083 | 02:27:32 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:33 INFO - PROCESS | 18083 | RSS: Main: 226451456 02:27:33 INFO - PROCESS | 18083 | 02:27:35 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:35 INFO - PROCESS | 18083 | RSS: Main: 229601280 02:27:35 INFO - PROCESS | 18083 | 02:27:37 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:38 INFO - PROCESS | 18083 | RSS: Main: 236769280 02:27:38 INFO - PROCESS | 18083 | 02:27:40 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:41 INFO - PROCESS | 18083 | RSS: Main: 241590272 02:27:41 INFO - PROCESS | 18083 | 02:27:44 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:44 INFO - PROCESS | 18083 | RSS: Main: 240246784 02:27:44 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37070/tests/kraken/driver.html?testName=ai-astar) 02:27:46 INFO - PROCESS | 18083 | RSS: Main: 282804224 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | __start_tp_report 02:27:46 INFO - PROCESS | 18083 | _x_x_mozilla_page_load 02:27:46 INFO - PROCESS | 18083 | _x_x_mozilla_page_load_details 02:27:46 INFO - PROCESS | 18083 | |i|pagename|runs| 02:27:46 INFO - PROCESS | 18083 | |0;ai-astar;111;106;111;112;110;111;110;110;109;110 02:27:46 INFO - PROCESS | 18083 | |1;audio-beat-detection;151;128;126;171;132;132;156;133;166;124 02:27:46 INFO - PROCESS | 18083 | |2;audio-dft;162;162;161;160;161;161;161;161;160;161 02:27:46 INFO - PROCESS | 18083 | |3;audio-fft;74;75;74;114;76;75;77;75;97;75 02:27:46 INFO - PROCESS | 18083 | |4;audio-oscillator;83;85;119;85;85;86;116;85;87;133 02:27:46 INFO - PROCESS | 18083 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 02:27:46 INFO - PROCESS | 18083 | |6;imaging-darkroom;145;147;146;146;145;147;146;145;145;145 02:27:46 INFO - PROCESS | 18083 | |7;imaging-desaturate;95;94;95;95;94;94;94;95;94;95 02:27:46 INFO - PROCESS | 18083 | |8;json-parse-financial;53;53;54;54;55;53;53;54;53;53 02:27:46 INFO - PROCESS | 18083 | |9;json-stringify-tinderbox;61;61;61;60;61;60;60;60;60;61 02:27:46 INFO - PROCESS | 18083 | |10;stanford-crypto-aes;79;85;79;80;79;80;85;87;111;82 02:27:46 INFO - PROCESS | 18083 | |11;stanford-crypto-ccm;130;132;128;119;132;131;123;123;137;132 02:27:46 INFO - PROCESS | 18083 | |12;stanford-crypto-pbkdf2;161;160;159;157;161;163;162;158;161;164 02:27:46 INFO - PROCESS | 18083 | |13;stanford-crypto-sha256-iterative;63;65;64;63;64;64;63;62;73;61 02:27:46 INFO - PROCESS | 18083 | __end_tp_report 02:27:46 INFO - PROCESS | 18083 | __start_cc_report 02:27:46 INFO - PROCESS | 18083 | _x_x_mozilla_cycle_collect,1635 02:27:46 INFO - PROCESS | 18083 | __end_cc_report 02:27:46 INFO - PROCESS | 18083 | __startTimestamp1465637266814__endTimestamp 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | ------- Summary: start ------- 02:27:46 INFO - PROCESS | 18083 | Number of tests: 14 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.63 (1.5%) stddev-sans-first:1.69 02:27:46 INFO - PROCESS | 18083 | Values: 111.0 106.0 111.0 112.0 110.0 111.0 110.0 110.0 109.0 110.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:142.00 stddev:17.48 (12.3%) stddev-sans-first:18.23 02:27:46 INFO - PROCESS | 18083 | Values: 151.0 128.0 126.0 171.0 132.0 132.0 156.0 133.0 166.0 124.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 02:27:46 INFO - PROCESS | 18083 | Values: 162.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.45 (17.9%) stddev-sans-first:14.01 02:27:46 INFO - PROCESS | 18083 | Values: 74.0 75.0 74.0 114.0 76.0 75.0 77.0 75.0 97.0 75.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:18.65 (21.9%) stddev-sans-first:19.14 02:27:46 INFO - PROCESS | 18083 | Values: 83.0 85.0 119.0 85.0 85.0 86.0 116.0 85.0 87.0 133.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:27:46 INFO - PROCESS | 18083 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 02:27:46 INFO - PROCESS | 18083 | Values: 145.0 147.0 146.0 146.0 145.0 147.0 146.0 145.0 145.0 145.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:27:46 INFO - PROCESS | 18083 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 02:27:46 INFO - PROCESS | 18083 | Values: 53.0 53.0 54.0 54.0 55.0 53.0 53.0 54.0 53.0 53.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 02:27:46 INFO - PROCESS | 18083 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.00 stddev:9.70 (12.0%) stddev-sans-first:10.06 02:27:46 INFO - PROCESS | 18083 | Values: 79.0 85.0 79.0 80.0 79.0 80.0 85.0 87.0 111.0 82.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:131.50 stddev:5.46 (4.2%) stddev-sans-first:5.77 02:27:46 INFO - PROCESS | 18083 | Values: 130.0 132.0 128.0 119.0 132.0 131.0 123.0 123.0 137.0 132.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 02:27:46 INFO - PROCESS | 18083 | Values: 161.0 160.0 159.0 157.0 161.0 163.0 162.0 158.0 161.0 164.0 02:27:46 INFO - PROCESS | 18083 | 02:27:46 INFO - PROCESS | 18083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:3.29 (5.1%) stddev-sans-first:3.46 02:27:46 INFO - PROCESS | 18083 | Values: 63.0 65.0 64.0 63.0 64.0 64.0 63.0 62.0 73.0 61.0 02:27:46 INFO - PROCESS | 18083 | -------- Summary: end -------- 02:27:46 INFO - PROCESS | 18083 | 02:27:47 INFO - TEST-INFO | 18083: exit 0 02:27:47 INFO - TEST-OK | kraken | took 61510ms 02:27:47 INFO - SUITE-END | took 1175s 02:27:47 INFO - Completed test suite (00:19:35) 02:27:47 INFO - javascript benchmark 02:27:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.9845200773993, 3100.209446591119, 3118.9220269493267, 3140.513220450831, 3161.304513007139, 5212.2963399941, 5292.947070529293, 5358.115910874706, 5385.946140538598, 5428.375736790265, 5336.493033161853, 5346.064438723218, 5357.651752636076, 5400.270963419937, 5451.373092094401, 4810.254410566359, 4895.290182923474, 4898.044881248158, 4907.0, 5125.769340379673, 5011.924821127686, 5026.396832380119, 5050.595952323823, 5081.491850814908, 5085.745712714368, 4741.9525804742025, 4798.688085274463, 4878.780454879521, 4909.337239472661, 4935.851924442272, 4905.779239934212, 4977.402711674622, 4981.028699403618, 4983.700977941299, 5031.924521132186, 4920.926186107211, 4924.704517728912, 4962.131626965267, 4966.379202599675, 5017.824376146854, 5178.093833579109, 5271.683698978073, 5358.115910874701, 5368.973155134199, 5403.756830942578, 5759.913601295984, 5760.193572899798, 5771.422857714237, 5771.480566749013, 5787.1608616750755, 5656.377798442168, 5798.217240672498, 5827.446392592697, 5830.183774271605, 5832.562557808182, 5267.499587539178, 5308.654937429054, 5332.040232758102, 5332.33345831771, 5337.519623233928, 5846.444587764156, 5909.468147866713, 5911.615744976562, 5912.172295878494, 5913.822585322448, 5488.506034456838, 5597.80407685729, 5701.543876489871, 5722.227499287626, 5723.914141287884, 5712.028955077563, 5731.254936858265, 5740.770369185269, 5786.016377215883, 5792.710364481759, 5679.176519404663, 5686.715664216773, 5716.628419152742, 5722.599418040697, 5724.313082430135, 5556.527695145877, 5680.204771332017, 5724.742386592613, 5737.77048918047, 5741.885162296814, 4394.538573449806, 4398.186335527937, 4400.141972315368, 4437.42313499243, 4441.311596702516, 3889.5138107736534, 3891.747036442679, 3894.7468414552964, 3945.8027098645525, 3946.565877753445, 5255.211718242294, 5402.756875940592, 5429.0, 5446.101393270066, 5502.5597952163735, 5842.5618078644275, 5852.531797456193, 5860.0, 5861.5603829712945, 5906.7637294508595, 5526.723663816873, 5530.5022547970875, 5531.861703457445, 5533.418991005967, 5536.557075433956, 4793.161196790617, 4968.0, 5011.84964451067, 5019.347484826949, 5043.899122017539, 5972.552058595623, 5988.970055149784, 5990.940090599125, 5993.130996005555, 5996.940030599638, 5606.607537472501, 5824.475797178105, 5859.765609375577, 5865.237519122486, 5870.5010074144175, 5932.080527518242, 5963.463288304073, 5998.190244316961, 6008.0, 6028.758849645965, 5694.288213973254, 5698.857528561819, 5709.058005429058, 5723.399043100581, 5728.484436400744, 5592.524635406036, 5724.255846739898, 5832.94167058324, 5842.328132264844, 5844.649321040752, 5567.220589117608, 5633.267675202197, 5635.802746903839, 5653.943460565341, 5692.032354499662, 5611.270534830446, 5658.830235092953, 5662.348829884616, 5663.915041274302, 5665.065264231355, 5381.946180538144, 5467.043267428105, 5512.6968016759465, 5582.86042848932, 5598.244237027949, 5633.492985631313, 5636.661800291996, 5640.717964101696, 5648.915266271091, 5671.6597004179885, 5448.291722076105, 5452.291202143696, 5452.345718513804, 5461.617686761889, 5463.071277882849], "value": 5315.080741242106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7092668202557, 604.9697515124243, 608.0909040983727, 619.8419403052222, 626.6803929995704, 32731.836340818292, 36077.63922360776, 41932.0, 43213.0, 43228.78385608076, 44694.32958505625, 45184.322235166495, 45232.0, 45263.54736452635, 45299.547004529944, 8787.912120878773, 8958.32812539059, 8966.820663586725, 8967.417117887317, 8967.730968070968, 8811.691590794324, 8883.51140687262, 8911.420757650765, 8915.910840891573, 8919.464832110061, 8938.240249578761, 8995.775105622346, 9001.819963600725, 9003.414778039407, 9003.95498022509, 8877.689280875138, 8897.555122243893, 8900.777480562972, 8958.999999999967, 8962.103789621051, 8746.387752857303, 8805.867911981326, 8808.0, 8814.559272036437, 8832.55837208137, 42801.14397712059, 43123.568764312266, 43172.0, 43173.0, 43277.0, 3464.1512829356716, 3529.717622590212, 3558.448440491728, 3570.732195085353, 3600.891973240807, 32452.513212301834, 32751.344973100404, 32793.0, 32876.835615821765, 33402.49896251558, 4204.348326009474, 4233.894152646178, 4239.8092085856215, 4266.189424009428, 4282.48610166782, 348988.0, 349281.0, 349913.0, 350332.0, 351002.0, 54947.175792362345, 55093.173602396, 55395.44604553984, 55446.44553554413, 55481.167782483295, 34690.13274668103, 35403.64596354055, 35441.46837797435, 37680.0, 59744.40255597388, 16140.43508477221, 16280.918595406947, 16289.59276018109, 16291.266892989845, 16296.022238665719, 12223.1443798935, 12339.6915077122, 12347.876521234852, 12348.0, 12361.443735031946, 19265.61468770645, 19276.0, 19279.493665823353, 19403.708944365844, 19455.12451939666, 6730.966345168341, 6829.760958366533, 7001.404880585207, 7110.288971102848, 7231.783046508614, 981.7054883535054, 1022.7726727926517, 1032.7245851373548, 1109.2900543651908, 1127.2053202492223, 31513.8424307877, 31667.36665266728, 31774.523382149287, 31810.522842157385, 32644.819695179103, 1095.3756358875523, 1108.3460758152567, 1152.809786385237, 1176.9529218831321, 1197.8862008109215, 16694.58263543397, 17084.40204592833, 17107.828921710872, 17144.828551714574, 17236.569085772957, 150394.0, 150556.2472187632, 151363.0, 151959.0, 151975.0, 57071.71464142653, 58585.0, 58624.706876465345, 58663.70668146632, 58670.11994820081, 1245.414655112114, 1344.7243315120377, 1361.4145917255676, 1362.087401441037, 1380.9447622095004, 32190.67809321877, 33463.83268083644, 33605.66394336123, 33905.38010235925, 33988.0, 48939.5106048935, 49365.50634493609, 49394.259086113016, 49462.258066129754, 49485.0, 313444.0, 314524.0, 314543.0, 314787.0, 315406.0, 26893.86553067222, 27691.584626231026, 27923.860380698778, 28028.43943121167, 28060.0, 47834.0, 48051.03897921952, 48618.87258564118, 48705.75647121741, 48797.268040978706, 40841.59158408378, 41072.38391424191, 41142.0, 41440.79279603583, 41796.0, 39828.339855224076, 40070.599294006686, 40382.79808600938, 40536.59463405446, 41159.7942010288, 40716.1856762869, 40721.0, 40872.59127408688, 41262.79368603138, 41452.79273603613, 35521.64478355287, 36625.81687091654, 37191.814040929625, 37232.627673724, 37502.06244843901, 27824.860875695493, 28270.57594136131, 28380.148595542167, 28453.43093138167, 28496.715032850236], "value": 18986.925919834906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.75827607745157, 392.2214404407252, 393.6142580271336, 399.3032158882749, 408.86711818658927, 14026.43894244229, 15668.921655391736, 17682.29270829167, 19329.903350483244, 19363.419097427082, 15315.387384504607, 17424.738628920575, 18302.450926472226, 18656.533586660305, 18996.715049274273, 5496.670199788015, 5620.91568626471, 5659.886802263953, 5664.631798933056, 5702.515286200657, 4117.0, 5621.409751976045, 5655.915161272585, 5920.4671579557835, 6220.688965551727, 6186.133941248228, 6201.790650823092, 6213.7514499420195, 6224.564280500367, 6248.718807653644, 6083.148359229712, 6127.908081378783, 6272.341404152567, 6282.780102696406, 6288.088227207075, 5366.060939335601, 5527.834164975017, 5546.473085056913, 5547.944520554784, 5552.694601796899, 21957.451063723536, 22100.025923784186, 22256.666150007764, 22426.102955881746, 22491.887540562355, 2361.161787565407, 2676.9598456023177, 2764.7649949754295, 2793.972060279412, 3083.3308363048127, 13872.167669939836, 13932.899110190378, 14008.929955350159, 14164.079334843305, 14566.053206541646, 1887.5186827359073, 1941.3205378117686, 1945.046927005771, 1953.8925359105244, 2009.1762377425332, 80166.0, 80784.59607701983, 82329.0, 82507.7623835649, 82680.58659706723, 10068.244881633907, 10202.234832387601, 10283.794324113476, 10395.688129356131, 10447.79850317208, 14619.561413157622, 14654.926725366306, 14692.19192944377, 14710.264486775619, 14724.116553006854, 7348.669309880961, 7500.962495187489, 7607.16321204667, 7663.961680191564, 7699.730509432143, 6526.151600292027, 7091.290870912868, 7108.537945033556, 7264.200937896827, 7306.305900939402, 5941.851453713605, 6151.784687535915, 6328.493720502349, 6523.0, 6525.967370163119, 1835.8255965683506, 1878.483417060292, 1895.4408449507428, 1913.8373238274903, 1933.8285212251917, 955.7515046087929, 996.4220751963989, 1045.1482042135635, 1068.2041878800187, 1110.972225694348, 18765.343212987755, 19086.713699294523, 19143.90428047851, 19216.61566768685, 19580.902095489433, 1027.9331843430152, 1031.6595523477386, 1037.455335948633, 1040.5109598488698, 1059.8516207730925, 10609.575616975235, 10893.83659245112, 11060.391678457761, 11104.278221915549, 11115.444227788577, 466031.0, 467229.0, 468735.0, 469582.0, 487462.0, 75439.86840197402, 79948.60025699834, 82739.5863020693, 84405.0, 85006.0, 1006.5319626373625, 1024.283001898674, 1036.3056751976194, 1040.9635662751768, 1045.132539991805, 16512.587185320463, 16631.667366652357, 16678.49964501067, 16696.916515417346, 16852.1573921301, 36248.456273155396, 37825.62174378221, 37840.0, 38013.61986380101, 39034.80482597569, 51901.22148167856, 52943.0, 53363.4663653374, 53704.0, 53912.19131712949, 8431.95784021076, 8571.742847714579, 8582.871256931276, 8707.564621768759, 8742.650293988168, 12482.375881206084, 12759.74480510366, 12809.231446113263, 12898.226106433644, 13173.0, 11362.772744544898, 11460.53176468263, 11493.080553555528, 11672.416379181177, 11772.587959421378, 11117.444127793417, 11214.327140371604, 11306.378149201544, 11498.310101393943, 11581.363025033366, 11578.76842463163, 11676.824847627122, 11683.88316116828, 11884.227525210834, 11947.462364193805, 8474.449160804528, 8475.364347673825, 8548.0, 8576.142385761374, 8618.05201427855, 11617.593384231512, 11618.94190529042, 11698.35659038727, 11733.530658773894, 11888.583899563473], "value": 9219.291746475286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.947402103916, 1456.7960485532028, 1496.1845794042247, 1601.3514526616716, 1793.7130059190524, 8557.700480483185, 8860.911390886089, 8936.195742383185, 9143.222826059793, 9148.405353652024, 8888.55557222138, 9088.727338179866, 9099.181073703365, 9102.362834601565, 9113.088691130884, 2049.661805802041, 2302.3553405046614, 2373.216838443318, 2399.2442380650127, 2435.744246854081, 2392.342105920868, 2395.281415575329, 2396.0176327705644, 2400.84394514356, 2401.7238017628024, 2318.119114736398, 2361.917332893349, 2362.6692263083182, 2379.6073647848084, 2394.940126496834, 1984.2360691133945, 2241.350008497534, 2308.1113771198043, 2309.2956648222284, 2316.9073237070497, 2295.540891821626, 2312.6993490846085, 2329.056732023533, 2329.7320808106947, 2333.498297865967, 9057.275417966614, 9179.632814687404, 9201.0, 9209.493477858716, 9220.8616870747, 4993.7503124843615, 5137.871553211162, 5140.794368225266, 5141.074606570815, 5146.305248791403, 3324.9501257481156, 3480.269143479872, 3506.2987402519598, 3528.417811061172, 3547.6984456320984, 1146.157574182975, 1191.8212268159846, 1197.8023626101683, 1208.7763763703742, 1257.4027337014936, 12979.67550811228, 13009.154404963647, 13045.86954130456, 13053.282069486175, 13057.738845223137, 4563.269876819693, 4633.791479383436, 4701.506341834058, 4702.15361234981, 4708.976455117702, 10751.569937202425, 10810.405427701551, 10855.891441085647, 10867.619633312954, 10875.075618572351, 5289.9471005290225, 5298.364196296392, 5314.70769107695, 5329.493698098674, 5341.385740639798, 4366.694331396771, 4764.332993380929, 4885.096257192431, 4896.094222568836, 4905.288733133676, 4027.3470330631794, 4057.634812866797, 4111.691623128278, 4133.090720041646, 4133.318002529549, 1264.367816091954, 1270.4791035675328, 1271.4786937355639, 1280.9807852882213, 1292.4184117147133, 1032.5405194688442, 1034.2294990232174, 1036.6786296248188, 1045.8012977534245, 1049.4490392543823, 6176.258848938156, 6195.876082478325, 6255.186825712719, 6261.154744109578, 6363.9802500597425, 445.10533827007947, 453.15260462934526, 458.0198375476483, 464.70723444230595, 466.2795980210583, 4028.576999415019, 4180.979095104566, 4249.235137675187, 4268.743875367426, 4271.9960809209815, 11252.268602540973, 11291.774164516664, 11655.358955257372, 11675.35785531804, 11760.411979400995, 10743.623973160902, 11456.94271528637, 11513.25163864363, 11528.0, 11558.94220528892, 8249.0, 8565.700200492953, 8594.957025214959, 8612.827743445096, 8614.569271536398, 6294.590851594632, 6370.394812492806, 6409.070684750592, 6464.838379040561, 6478.384553467413, 9973.551190196313, 10178.389296642225, 10286.897131028893, 10447.373157610567, 10454.895451045697, 10505.842412363974, 10512.57949682004, 10586.576536938435, 10626.574937002742, 10732.087772539422, 7362.263773622595, 7848.018997625297, 8043.517388956681, 8088.9595552021865, 8167.469114507538, 8623.353248506513, 8658.56707164652, 8679.91320086791, 8737.91262087371, 8739.21347078766, 7598.620068996639, 7792.922070779219, 7835.177306382976, 7844.294013538809, 7873.881891771513, 7710.498817577064, 7714.729984450517, 7851.803704907423, 7869.134395216407, 7891.84216315659, 7362.042934418491, 7392.704291828267, 7422.960785490143, 7433.070866141732, 7488.775336739906, 5299.761510731949, 5331.813386531453, 5446.482584154499, 5511.145772405283, 5716.171155182558, 5418.214358918013, 5557.749901254372, 5572.693501857437, 5583.610012127419, 5653.971730141323], "value": 4676.747822102973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.7952113042001, 306.7377392329558, 312.3238189320122, 315.42435056022765, 315.87207181091657, 5050.419201791795, 5208.140656791625, 5279.498447647472, 5319.388270348906, 5360.785568577257, 4914.189158788805, 5258.869343091234, 5277.656952298107, 5278.498542638453, 5295.602829787772, 4172.207280616688, 4173.979130104352, 4178.0, 4179.554960348185, 4188.685848561355, 3928.4892963914795, 4017.738846974937, 4042.6765858731233, 4198.874033778991, 4204.033072393351, 4058.208649313385, 4065.329220678599, 4104.865469955621, 4104.8973775655695, 4112.3625837995005, 4113.773742444165, 4126.958730412717, 4133.731307465006, 4139.317012692902, 4139.4204811326435, 3663.5420572428447, 3668.3030224257304, 3676.1912379276782, 3680.4663323818163, 3687.9858039039477, 5143.71407148213, 5163.819266325698, 5176.171812509981, 5180.740962951875, 5230.790768369298, 4413.271810151321, 4509.368688383629, 4550.88622784433, 4562.429696287964, 4565.840195593139, 5339.279197308391, 5475.917861232085, 5475.945240547583, 5498.367687715924, 5505.201745746885, 3948.861789837342, 3949.526056873165, 3953.6639385652256, 3953.98023009886, 3958.2677204716933, 5468.644538105011, 5677.716114194273, 5695.572832037572, 5724.456176663252, 5754.510866576346, 3993.840246390112, 3994.6604538614542, 3996.320625493673, 4014.9397759033636, 4055.1889622075705, 4075.0627355708352, 4080.8573599392216, 4094.877153685394, 4122.237386083584, 4147.668186545069, 4601.815927362935, 4608.884777880513, 4657.928676404446, 4683.2038553446, 4700.459447163552, 5503.3395992481155, 5509.090999984957, 5514.531264842533, 5555.805546805843, 5556.971960187298, 1403.8666326698947, 1409.0, 1417.922014289224, 1419.6025112968384, 1425.8645428684258, 886.6926364659855, 902.278177458031, 910.5310764956052, 920.2239677422505, 923.9282432378409, 4788.808447662054, 4796.928046079312, 4800.255960326155, 4814.277858321209, 4826.300186472942, 5006.52438018395, 5041.193409054534, 5080.314157588752, 5084.339035925306, 5092.388913330424, 4682.618662151396, 4683.15703173432, 4751.216049351819, 4811.49479304675, 4825.662203645711, 2696.4067905060856, 2697.7706894914154, 2699.487097451478, 2709.0112109080437, 2720.428709970928, 5175.327207463006, 5175.378954525406, 5223.895522089537, 5229.660072095302, 5237.319148510669, 5049.0, 5160.7419629018395, 5172.405173405106, 5307.548858347083, 5471.562275018068, 5865.8854817586225, 5889.705514724246, 5900.20347253124, 5902.1146827976145, 5917.6389430431245, 5662.971685141548, 5683.715814209356, 5689.857753556194, 5702.857428564319, 5722.341930677859, 5453.809116680897, 5653.886922261449, 5663.773449061991, 5667.914981275367, 5696.658200507983, 5848.420926349947, 5855.502282306052, 5862.530997520274, 5878.706064696663, 5908.316129903129, 4022.0, 4031.8387264510266, 4049.838006479708, 4083.8361067095734, 4092.9795351023054, 5735.598508104393, 5762.761006383647, 5769.413411311923, 5772.249607550992, 5782.45066718661, 5345.545628621455, 5466.835994920159, 5474.6587086164145, 5594.804181853616, 5617.915731264116, 5320.973395133155, 5441.7279136043835, 5478.369987451494, 5537.141743029837, 5554.166874968787, 5379.273798037215, 5458.4814442627885, 5472.863178420572, 5474.863128421821, 5496.780128794803, 5486.972565137149, 5540.224368588481, 5610.635308704921, 5611.372701916562, 5628.831135065954, 5420.701861397661, 5488.326060551411, 5489.972550137224, 5490.133354659435, 5495.395506494362], "value": 4133.782179719708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.4550232827705, 745.2547452547452, 773.6905237904838, 779.2207792207793, 781.6209138567796, 13547.525836595722, 14051.859481405183, 14238.359273832677, 14272.571822845319, 14802.629934251649, 13355.53255636053, 13365.866341336583, 13367.598972030855, 13375.063745537816, 13387.59837204883, 694.4756708684961, 800.7517669522466, 803.7789607857857, 814.2102160903913, 829.4608504472111, 820.0446479850966, 823.7117009046846, 827.8054657155564, 828.2173346187855, 828.45736042892, 848.3382961290173, 851.3274513134617, 853.9829203415928, 856.6659002988839, 856.8072183758636, 712.3659942651045, 819.2094628683319, 843.6245870587529, 844.6494704697543, 847.0216899481109, 619.3125630550086, 619.4239357397663, 619.6529943231805, 619.6932518403374, 620.751699320271, 12652.240865548096, 12765.425555849915, 12770.48918043277, 12772.808407873888, 12782.488700451971, 13711.588652340446, 14095.71808563823, 14154.221517816515, 14168.291585420688, 14395.856041439662, 12448.128630995834, 12466.0, 12466.563670271496, 12724.236545807282, 12766.36168191596, 4417.337399390085, 4464.419625448703, 4521.208788462039, 4526.909461810746, 4589.885252868671, 70827.29172708259, 70880.6455967722, 72894.27105728928, 74845.99999999946, 76029.0, 10417.374957502574, 10563.894361056446, 10588.941105889504, 11250.437478126061, 11670.824937625943, 18846.340378086974, 19429.0, 19458.70811937822, 19485.707714384294, 19495.512612184808, 8247.95876020628, 8465.068842427328, 8523.445976011539, 8713.433626814236, 8877.689280875138, 4639.8144074237325, 4720.173969555314, 4720.834770783006, 4773.618110551148, 4891.853244402673, 3465.151037995707, 3587.94618080729, 3613.728970327236, 3613.728970327236, 3618.3667858124722, 542.8371488553419, 552.3068548971015, 604.41673784797, 611.547454883392, 613.4908026338218, 651.8728847874619, 691.816668582826, 702.8488874891923, 732.9706811727472, 744.9664765085585, 10182.287239893285, 10451.68644940653, 10654.200934929757, 10864.674059778219, 10904.78190436187, 604.1572007050228, 643.5141468191486, 660.0528241972785, 673.7237732529737, 726.5168662839153, 4618.907621847544, 4890.657653964259, 4946.579540739078, 5013.5989120870245, 5259.789608415621, 110390.0, 115944.0, 117159.0, 121759.0, 124283.0, 71358.64320678468, 101172.98827011783, 101956.0, 102643.0, 105440.47279763552, 91871.0, 91973.0, 92052.53973730089, 92446.53776731208, 93183.5340823278, 9346.345755797029, 9364.672236471692, 9371.156595906128, 9401.905980940377, 9477.620895164391, 52649.736751316, 53437.19844202418, 53501.464985349645, 53693.73153134209, 54350.728246358514, 49135.26297105475, 75084.0, 78906.0, 79804.0, 81274.18725812902, 12871.22772633645, 13158.342082896008, 13272.601821945356, 13327.600171994856, 13589.116707413987, 13333.267338494223, 13850.238236897067, 13857.514986975408, 14028.0, 14095.436182552994, 13088.541901033419, 13125.803112953505, 13175.507439794465, 13211.735765284833, 13311.733765324832, 13426.12237969966, 13512.527061552799, 13560.11859229147, 13645.79531307051, 13877.097988630707, 11490.94254528722, 11610.477528511068, 11893.226940248856, 11910.464029118884, 12282.38588070575, 10950.507227174638, 11016.339019658846, 11183.832242516206, 11358.338841702096, 11545.0, 10679.57281708723, 11041.227114101936, 11428.142889283503, 11460.770784584094, 11564.826527602261], "value": 7452.138372230865, "unit": "score"}], "name": "dromaeo_css", "value": 7153.957596290815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 126.0, 171.0, 132.0, 132.0, 156.0, 133.0, 166.0, 124.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 114.0, 76.0, 75.0, 77.0, 75.0, 97.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 119.0, 85.0, 85.0, 86.0, 116.0, 85.0, 87.0, 133.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 55.0, 53.0, 53.0, 54.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 79.0, 80.0, 79.0, 80.0, 85.0, 87.0, 111.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 128.0, 119.0, 132.0, 131.0, 123.0, 123.0, 137.0, 132.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 157.0, 161.0, 163.0, 162.0, 158.0, 161.0, 164.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 73.0, 61.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1499.9, "alertThreshold": 2.0}]} 02:27:48 INFO - Return code: 0 02:27:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:27:48 INFO - # TBPL SUCCESS # 02:27:48 INFO - Running post-action listener: _resource_record_post_action 02:27:48 INFO - ##### 02:27:48 INFO - ##### Finished run-tests step (success) 02:27:48 INFO - ##### 02:27:48 INFO - Running post-run listener: _resource_record_post_run 02:27:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543043584; Read time: 240; Write time: 594576 02:27:48 INFO - TinderboxPrint: CPU usage
13.2% 02:27:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 240 02:27:48 INFO - TinderboxPrint: I/O write bytes / time
543,043,584 / 594,576 02:27:48 INFO - TinderboxPrint: CPU idle
8,270.0 (86.8%) 02:27:48 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 02:27:48 INFO - TinderboxPrint: Swap in / out
0 / 0 02:27:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 228683776; Read time: 0; Write time: 308992 02:27:48 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292986880; Read time: 240; Write time: 281116 02:27:48 INFO - Running post-run listener: _upload_blobber_files 02:27:48 INFO - Blob upload gear active. 02:27:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:48 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 02:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:27:49 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:53 INFO - (blobuploader) - INFO - Done attempting. 02:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:53 INFO - (blobuploader) - INFO - Done attempting. 02:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:54 INFO - (blobuploader) - INFO - Done attempting. 02:27:54 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:54 INFO - Return code: 0 02:27:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f317d43e6caae43d01b8105532980ee3b92df248292d6724af86f28b1aa3e781efbc8d6e07588157f0a172b5ed035abb654b4de8defa8600cf9b6010109d6fde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb4de2d6783e18ddab5073a9896d128d1c9c4c17ae29c63eec1a25ee720c6722fc8b66126dc2ad670ececb3bae96569a286a863e6add7e81be24445b3c6eada", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4da5fefa40068a72d45f809bf9f57170ff0017884e0799bf512c8df28a82909d4563b59d55d74b651142ac01c791eef3850d13c30cfec337d917cd0d773b917f"} 02:27:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:54 INFO - Contents: 02:27:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f317d43e6caae43d01b8105532980ee3b92df248292d6724af86f28b1aa3e781efbc8d6e07588157f0a172b5ed035abb654b4de8defa8600cf9b6010109d6fde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb4de2d6783e18ddab5073a9896d128d1c9c4c17ae29c63eec1a25ee720c6722fc8b66126dc2ad670ececb3bae96569a286a863e6add7e81be24445b3c6eada", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4da5fefa40068a72d45f809bf9f57170ff0017884e0799bf512c8df28a82909d4563b59d55d74b651142ac01c791eef3850d13c30cfec337d917cd0d773b917f"} 02:27:54 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:54 INFO - Copying logs to upload dir... 02:27:54 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.783739 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-11 02:27:54.604779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:27:54.608916) ========= 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=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f317d43e6caae43d01b8105532980ee3b92df248292d6724af86f28b1aa3e781efbc8d6e07588157f0a172b5ed035abb654b4de8defa8600cf9b6010109d6fde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb4de2d6783e18ddab5073a9896d128d1c9c4c17ae29c63eec1a25ee720c6722fc8b66126dc2ad670ececb3bae96569a286a863e6add7e81be24445b3c6eada", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4da5fefa40068a72d45f809bf9f57170ff0017884e0799bf512c8df28a82909d4563b59d55d74b651142ac01c791eef3850d13c30cfec337d917cd0d773b917f"} build_url:https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/HTPjtqBrTYeVvhg4wOAS-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f317d43e6caae43d01b8105532980ee3b92df248292d6724af86f28b1aa3e781efbc8d6e07588157f0a172b5ed035abb654b4de8defa8600cf9b6010109d6fde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb4de2d6783e18ddab5073a9896d128d1c9c4c17ae29c63eec1a25ee720c6722fc8b66126dc2ad670ececb3bae96569a286a863e6add7e81be24445b3c6eada", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4da5fefa40068a72d45f809bf9f57170ff0017884e0799bf512c8df28a82909d4563b59d55d74b651142ac01c791eef3850d13c30cfec337d917cd0d773b917f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 02:27:54.635475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:27:54.635801) ========= 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=db0483c52d987ecb441a263b000001ad-1465636038.321306-1481900278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 02:27:54.685225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:27:54.685553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 02:27:54.685849) ========= ========= Total master_lag: 0.56 =========