builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466596719.03 results: success (0) buildid: 20160622023033 builduid: e2a0309dcb61499e8896316cbf6a664b revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.033510) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.035208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.035491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.050149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.050489) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 04:58:39-- 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% 45.9M=0s 2016-06-22 04:58:39 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158604 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.222638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.222924) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017074 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.273663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:39.273983) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1746be133dff55de7588c846aaafbc30534b8bd --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 a1746be133dff55de7588c846aaafbc30534b8bd --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=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 04:58:39,626 truncating revision to first 12 chars 2016-06-22 04:58:39,626 Setting DEBUG logging. 2016-06-22 04:58:39,626 attempt 1/10 2016-06-22 04:58:39,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1746be133df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 04:58:40,022 unpacking tar archive at: fx-team-a1746be133df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.769735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:40.057561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:40.057868) ========= script_repo_revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:40.058267) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:40.058588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:58:40.069119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-22 04:58:40.069411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:58:40 INFO - MultiFileLogger online at 20160622 04:58:40 in /builds/slave/test 04:58:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:58:40 INFO - {'append_to_log': False, 04:58:40 INFO - 'base_work_dir': '/builds/slave/test', 04:58:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:58:40 INFO - 'branch': 'Fx-Team', 04:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:58:40 INFO - 'config_files': ('talos/linux_config.py',), 04:58:40 INFO - 'default_actions': ('clobber', 04:58:40 INFO - 'read-buildbot-config', 04:58:40 INFO - 'download-and-extract', 04:58:40 INFO - 'populate-webroot', 04:58:40 INFO - 'create-virtualenv', 04:58:40 INFO - 'install', 04:58:40 INFO - 'run-tests'), 04:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:58:40 INFO - 'download_minidump_stackwalk': True, 04:58:40 INFO - 'download_symbols': 'ondemand', 04:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:58:40 INFO - 'installer_path': 'installer.exe', 04:58:40 INFO - 'log_level': 'info', 04:58:40 INFO - 'log_name': 'talos', 04:58:40 INFO - 'log_to_console': True, 04:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:58:40 INFO - 'opt_config_files': (), 04:58:40 INFO - 'pip_index': False, 04:58:40 INFO - 'sps_profile': False, 04:58:40 INFO - 'sps_profile_interval': 0, 04:58:40 INFO - 'suite': 'dromaeojs-e10s', 04:58:40 INFO - 'system_bits': '32', 04:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:58:40 INFO - 'title': 'talos-linux64-ix-001', 04:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:58:40 INFO - 'use_talos_json': True, 04:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:58:40 INFO - 'work_dir': 'build'} 04:58:40 INFO - ##### 04:58:40 INFO - ##### Running clobber step. 04:58:40 INFO - ##### 04:58:40 INFO - Running pre-action listener: _resource_record_pre_action 04:58:40 INFO - Running main action method: clobber 04:58:40 INFO - rmtree: /builds/slave/test/build 04:58:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:58:41 INFO - Running post-action listener: _resource_record_post_action 04:58:41 INFO - ##### 04:58:41 INFO - ##### Finished clobber step (success) 04:58:41 INFO - ##### 04:58:41 INFO - ##### 04:58:41 INFO - ##### Running read-buildbot-config step. 04:58:41 INFO - ##### 04:58:41 INFO - Running pre-action listener: _resource_record_pre_action 04:58:41 INFO - Running main action method: read_buildbot_config 04:58:41 INFO - Using buildbot properties: 04:58:41 INFO - { 04:58:41 INFO - "project": "", 04:58:41 INFO - "product": "firefox", 04:58:41 INFO - "script_repo_revision": "production", 04:58:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:58:41 INFO - "repository": "", 04:58:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:58:41 INFO - "buildid": "20160622023033", 04:58:41 INFO - "pgo_build": "True", 04:58:41 INFO - "basedir": "/builds/slave/test", 04:58:41 INFO - "buildnumber": 854, 04:58:41 INFO - "slavename": "talos-linux64-ix-001", 04:58:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:58:41 INFO - "platform": "ubuntu64_hw", 04:58:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:58:41 INFO - "branch": "fx-team", 04:58:41 INFO - "repo_path": "integration/fx-team", 04:58:41 INFO - "revision": "a1746be133dff55de7588c846aaafbc30534b8bd", 04:58:41 INFO - "stage_platform": "linux64-pgo", 04:58:41 INFO - "builduid": "e2a0309dcb61499e8896316cbf6a664b", 04:58:41 INFO - "slavebuilddir": "test" 04:58:41 INFO - } 04:58:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:58:41 INFO - Running post-action listener: _resource_record_post_action 04:58:41 INFO - ##### 04:58:41 INFO - ##### Finished read-buildbot-config step (success) 04:58:41 INFO - ##### 04:58:41 INFO - ##### 04:58:41 INFO - ##### Running download-and-extract step. 04:58:41 INFO - ##### 04:58:41 INFO - Running pre-action listener: _resource_record_pre_action 04:58:41 INFO - Running main action method: download_and_extract 04:58:41 INFO - mkdir: /builds/slave/test/build/tests 04:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:41 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:43 INFO - Downloaded 1361 bytes. 04:58:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:58:43 INFO - Using the following test package requirements: 04:58:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:58:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'jsshell-linux-x86_64.zip'], 04:58:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:58:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:58:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58: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')]} 04:58:43 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:46 INFO - Downloaded 24268127 bytes. 04:58:46 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'] 04:58:46 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 04:58:47 INFO - Return code: 0 04:58:47 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 04:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:47 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:48 INFO - Downloaded 24268127 bytes. 04:58:48 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'] 04:58:48 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 04:58:50 INFO - Return code: 0 04:58: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')]} 04:58:50 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:51 INFO - Downloaded 14405384 bytes. 04:58:51 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'] 04:58:51 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 04:58:51 INFO - Return code: 0 04:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:51 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/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 04:58:53 INFO - Downloaded 60133052 bytes. 04:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:53 INFO - mkdir: /builds/slave/test/properties 04:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:53 INFO - Contents: 04:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:58:53 INFO - Running post-action listener: _resource_record_post_action 04:58:53 INFO - Running post-action listener: set_extra_try_arguments 04:58:53 INFO - ##### 04:58:53 INFO - ##### Finished download-and-extract step (success) 04:58:53 INFO - ##### 04:58:53 INFO - ##### 04:58:53 INFO - ##### Running populate-webroot step. 04:58:53 INFO - ##### 04:58:53 INFO - Running pre-action listener: _resource_record_pre_action 04:58:53 INFO - Running main action method: populate_webroot 04:58:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:53 INFO - '--tppagecycles', 04:58:53 INFO - '7'], 04:58:53 INFO - 'tests': ['tsvgm']}}, 04:58:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:58:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:58:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['damp', 'tps']}, 04:58:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'tests': ['damp', 'tps']}, 04:58:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['dromaeo_dom']}, 04:58:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['basic_compositor_video']}, 04:58:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:58:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['a11yr', 04:58:53 INFO - 'ts_paint', 04:58:53 INFO - 'tpaint', 04:58:53 INFO - 'sessionrestore', 04:58:53 INFO - 'sessionrestore_no_auto_restore', 04:58:53 INFO - 'tabpaint']}, 04:58:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['tsvgx', 04:58:53 INFO - 'tsvgr_opacity', 04:58:53 INFO - 'tart', 04:58:53 INFO - 'tscrollx', 04:58:53 INFO - 'cart']}, 04:58:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:58:53 INFO - 'tsvgr_opacity', 04:58:53 INFO - 'tart', 04:58:53 INFO - 'tscrollx', 04:58:53 INFO - 'cart']}, 04:58:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'talos_options': ['--disable-e10s'], 04:58:53 INFO - 'tests': ['tp5o']}, 04:58:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'tests': ['tp5o']}, 04:58:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'talos_options': ['--disable-e10s', 04:58:53 INFO - '--xperf_path', 04:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:53 INFO - 'tests': ['tp5n']}, 04:58:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:53 INFO - 'talos_options': ['--xperf_path', 04:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:53 INFO - 'tests': ['tp5n']}}, 04:58:53 INFO - 'talos.zip': {'path': '', 04:58:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:53 INFO - Running post-action listener: _resource_record_post_action 04:58:53 INFO - ##### 04:58:53 INFO - ##### Finished populate-webroot step (success) 04:58:53 INFO - ##### 04:58:53 INFO - ##### 04:58:53 INFO - ##### Running create-virtualenv step. 04:58:53 INFO - ##### 04:58:53 INFO - Running pre-action listener: _resource_record_pre_action 04:58:53 INFO - Running main action method: create_virtualenv 04:58:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:53 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 04:58:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:53 INFO - Using real prefix '/usr' 04:58:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:56 INFO - Installing pip.................done. 04:58:56 INFO - Return code: 0 04:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:58:56 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 04:58:56 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 04:58:56 INFO - Using env: {'DISPLAY': ':0', 04:58:56 INFO - 'HOME': '/home/cltbld', 04:58:56 INFO - 'LANG': 'en_US.UTF-8', 04:58:56 INFO - 'LANGUAGE': 'en_US:en', 04:58:56 INFO - 'LOGNAME': 'cltbld', 04:58:56 INFO - 'MAIL': '/var/mail/cltbld', 04:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:56 INFO - 'MOZ_NO_REMOTE': '1', 04:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:56 INFO - 'NO_EM_RESTART': '1', 04:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:56 INFO - 'PWD': '/builds/slave/test', 04:58:56 INFO - 'SHELL': '/bin/bash', 04:58:56 INFO - 'SHLVL': '1', 04:58:56 INFO - 'TERM': 'linux', 04:58:56 INFO - 'TMOUT': '86400', 04:58:56 INFO - 'USER': 'cltbld', 04:58:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:56 INFO - '_': '/tools/buildbot/bin/python'} 04:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:56 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 04:58:56 INFO - Cleaning up... 04:58:56 INFO - Return code: 0 04:58:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:58:56 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 04:58:56 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 04:58:56 INFO - Using env: {'DISPLAY': ':0', 04:58:56 INFO - 'HOME': '/home/cltbld', 04:58:56 INFO - 'LANG': 'en_US.UTF-8', 04:58:56 INFO - 'LANGUAGE': 'en_US:en', 04:58:56 INFO - 'LOGNAME': 'cltbld', 04:58:56 INFO - 'MAIL': '/var/mail/cltbld', 04:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:56 INFO - 'MOZ_NO_REMOTE': '1', 04:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:56 INFO - 'NO_EM_RESTART': '1', 04:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:56 INFO - 'PWD': '/builds/slave/test', 04:58:56 INFO - 'SHELL': '/bin/bash', 04:58:56 INFO - 'SHLVL': '1', 04:58:56 INFO - 'TERM': 'linux', 04:58:56 INFO - 'TMOUT': '86400', 04:58:56 INFO - 'USER': 'cltbld', 04:58:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:56 INFO - '_': '/tools/buildbot/bin/python'} 04:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:56 INFO - Downloading/unpacking psutil>=3.1.1 04:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:58 INFO - Installing collected packages: psutil 04:58:58 INFO - Running setup.py install for psutil 04:58:58 INFO - building 'psutil._psutil_linux' extension 04:58:58 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 04:58:59 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 04:58:59 INFO - building 'psutil._psutil_posix' extension 04:58:59 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 04:58:59 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 04:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:59 INFO - Successfully installed psutil 04:58:59 INFO - Cleaning up... 04:58:59 INFO - Return code: 0 04:58:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:59 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:58:59 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 04:58:59 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 04:58:59 INFO - Using env: {'DISPLAY': ':0', 04:58:59 INFO - 'HOME': '/home/cltbld', 04:58:59 INFO - 'LANG': 'en_US.UTF-8', 04:58:59 INFO - 'LANGUAGE': 'en_US:en', 04:58:59 INFO - 'LOGNAME': 'cltbld', 04:58:59 INFO - 'MAIL': '/var/mail/cltbld', 04:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:59 INFO - 'MOZ_NO_REMOTE': '1', 04:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:59 INFO - 'NO_EM_RESTART': '1', 04:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:59 INFO - 'PWD': '/builds/slave/test', 04:58:59 INFO - 'SHELL': '/bin/bash', 04:58:59 INFO - 'SHLVL': '1', 04:58:59 INFO - 'TERM': 'linux', 04:58:59 INFO - 'TMOUT': '86400', 04:58:59 INFO - 'USER': 'cltbld', 04:58:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:59 INFO - '_': '/tools/buildbot/bin/python'} 04:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:58:59 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 04:58:59 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 04:58:59 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 04:58:59 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 04:58:59 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 04:58:59 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 04:59:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:59:01 INFO - Installing collected packages: mozsystemmonitor 04:59:01 INFO - Running setup.py install for mozsystemmonitor 04:59:01 INFO - Successfully installed mozsystemmonitor 04:59:01 INFO - Cleaning up... 04:59:01 INFO - Return code: 0 04:59:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:59:01 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')]} 04:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:01 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')]} 04:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:01 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:01 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 04:59:01 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 04:59:01 INFO - Using env: {'DISPLAY': ':0', 04:59:01 INFO - 'HOME': '/home/cltbld', 04:59:01 INFO - 'LANG': 'en_US.UTF-8', 04:59:01 INFO - 'LANGUAGE': 'en_US:en', 04:59:01 INFO - 'LOGNAME': 'cltbld', 04:59:01 INFO - 'MAIL': '/var/mail/cltbld', 04:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:01 INFO - 'MOZ_NO_REMOTE': '1', 04:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:01 INFO - 'NO_EM_RESTART': '1', 04:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:01 INFO - 'PWD': '/builds/slave/test', 04:59:01 INFO - 'SHELL': '/bin/bash', 04:59:01 INFO - 'SHLVL': '1', 04:59:01 INFO - 'TERM': 'linux', 04:59:01 INFO - 'TMOUT': '86400', 04:59:01 INFO - 'USER': 'cltbld', 04:59:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:01 INFO - '_': '/tools/buildbot/bin/python'} 04:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:59:01 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 04:59:01 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 04:59:01 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 04:59:01 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 04:59:01 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 04:59:01 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 04:59:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:04 INFO - warning: no files found matching '*.txt' 04:59:04 INFO - no previously-included directories found matching 'build' 04:59:04 INFO - no previously-included directories found matching 'dist' 04:59:04 INFO - no previously-included directories found matching '.git*' 04:59:04 INFO - Installing collected packages: jsonschema, functools32 04:59:04 INFO - Running setup.py install for functools32 04:59:04 INFO - warning: no files found matching '*.txt' 04:59:04 INFO - no previously-included directories found matching 'build' 04:59:04 INFO - no previously-included directories found matching 'dist' 04:59:04 INFO - no previously-included directories found matching '.git*' 04:59:04 INFO - Successfully installed jsonschema functools32 04:59:04 INFO - Cleaning up... 04:59:04 INFO - Return code: 0 04:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:59:04 INFO - Using env: {'DISPLAY': ':0', 04:59:04 INFO - 'HOME': '/home/cltbld', 04:59:04 INFO - 'LANG': 'en_US.UTF-8', 04:59:04 INFO - 'LANGUAGE': 'en_US:en', 04:59:04 INFO - 'LOGNAME': 'cltbld', 04:59:04 INFO - 'MAIL': '/var/mail/cltbld', 04:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:04 INFO - 'MOZ_NO_REMOTE': '1', 04:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:04 INFO - 'NO_EM_RESTART': '1', 04:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:04 INFO - 'PWD': '/builds/slave/test', 04:59:04 INFO - 'SHELL': '/bin/bash', 04:59:04 INFO - 'SHLVL': '1', 04:59:04 INFO - 'TERM': 'linux', 04:59:04 INFO - 'TMOUT': '86400', 04:59:04 INFO - 'USER': 'cltbld', 04:59:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:04 INFO - '_': '/tools/buildbot/bin/python'} 04:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:06 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 04:59:07 INFO - Downloading docopt-0.6.1.tar.gz 04:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:07 INFO - Running setup.py install for blobuploader 04:59:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:07 INFO - Running setup.py install for requests 04:59:07 INFO - Running setup.py install for docopt 04:59:07 INFO - Successfully installed blobuploader requests docopt 04:59:07 INFO - Cleaning up... 04:59:07 INFO - Return code: 0 04:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:07 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 04:59:07 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 04:59:07 INFO - Using env: {'DISPLAY': ':0', 04:59:07 INFO - 'HOME': '/home/cltbld', 04:59:07 INFO - 'LANG': 'en_US.UTF-8', 04:59:07 INFO - 'LANGUAGE': 'en_US:en', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MAIL': '/var/mail/cltbld', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SHLVL': '1', 04:59:07 INFO - 'TERM': 'linux', 04:59:07 INFO - 'TMOUT': '86400', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - '_': '/tools/buildbot/bin/python'} 04:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:07 INFO - Running setup.py (path:/tmp/pip-tlZksW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:08 INFO - Running setup.py (path:/tmp/pip-rG3ven-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:08 INFO - Running setup.py (path:/tmp/pip-13pX6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:08 INFO - Running setup.py (path:/tmp/pip-91EMRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:08 INFO - Running setup.py (path:/tmp/pip-QZhxC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:08 INFO - Running setup.py (path:/tmp/pip-7I5Odm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:08 INFO - Running setup.py (path:/tmp/pip-ubPt_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:08 INFO - Running setup.py (path:/tmp/pip-61httP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:08 INFO - Running setup.py (path:/tmp/pip-92BGM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:08 INFO - Running setup.py (path:/tmp/pip-ddNMj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:08 INFO - Running setup.py (path:/tmp/pip-dMOgbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:08 INFO - Running setup.py (path:/tmp/pip-9nuJf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:08 INFO - Running setup.py (path:/tmp/pip-LcDNOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:08 INFO - Running setup.py (path:/tmp/pip-DLiLQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:08 INFO - Running setup.py (path:/tmp/pip-S_0Q8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:09 INFO - Running setup.py (path:/tmp/pip-yr7ZFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:09 INFO - Running setup.py (path:/tmp/pip-ZmVAVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:09 INFO - Running setup.py install for manifestparser 04:59:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozcrash 04:59:09 INFO - Running setup.py install for mozdebug 04:59:09 INFO - Running setup.py install for mozdevice 04:59:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozfile 04:59:09 INFO - Running setup.py install for mozhttpd 04:59:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozinfo 04:59:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozInstall 04:59:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:59:09 INFO - Running setup.py install for mozleak 04:59:10 INFO - Running setup.py install for mozlog 04:59:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for moznetwork 04:59:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozprocess 04:59:10 INFO - Running setup.py install for mozprofile 04:59:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozrunner 04:59:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Running setup.py install for mozscreenshot 04:59:10 INFO - Running setup.py install for moztest 04:59:10 INFO - Running setup.py install for mozversion 04:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:59:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:10 INFO - Cleaning up... 04:59:10 INFO - Return code: 0 04:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:10 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:10 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 04:59:10 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 04:59:10 INFO - Using env: {'DISPLAY': ':0', 04:59:10 INFO - 'HOME': '/home/cltbld', 04:59:10 INFO - 'LANG': 'en_US.UTF-8', 04:59:10 INFO - 'LANGUAGE': 'en_US:en', 04:59:10 INFO - 'LOGNAME': 'cltbld', 04:59:10 INFO - 'MAIL': '/var/mail/cltbld', 04:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:10 INFO - 'MOZ_NO_REMOTE': '1', 04:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:10 INFO - 'NO_EM_RESTART': '1', 04:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:10 INFO - 'PWD': '/builds/slave/test', 04:59:10 INFO - 'SHELL': '/bin/bash', 04:59:10 INFO - 'SHLVL': '1', 04:59:10 INFO - 'TERM': 'linux', 04:59:10 INFO - 'TMOUT': '86400', 04:59:10 INFO - 'USER': 'cltbld', 04:59:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:10 INFO - '_': '/tools/buildbot/bin/python'} 04:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:11 INFO - Running setup.py (path:/tmp/pip-CODXiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:11 INFO - Running setup.py (path:/tmp/pip-Tf78gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:11 INFO - Running setup.py (path:/tmp/pip-P176H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:11 INFO - Running setup.py (path:/tmp/pip-Dfh7Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:11 INFO - Running setup.py (path:/tmp/pip-3uXPXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:11 INFO - Running setup.py (path:/tmp/pip-Zfcd5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:11 INFO - Running setup.py (path:/tmp/pip-OYnpkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:11 INFO - Running setup.py (path:/tmp/pip-XnEgiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:11 INFO - Running setup.py (path:/tmp/pip-vDzOvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:11 INFO - Running setup.py (path:/tmp/pip-91b_jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:11 INFO - Running setup.py (path:/tmp/pip-Ampt1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:11 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)) 04:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:11 INFO - Running setup.py (path:/tmp/pip-Oormq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:12 INFO - Running setup.py (path:/tmp/pip-kKsBxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:12 INFO - Running setup.py (path:/tmp/pip-jo_rQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:12 INFO - Running setup.py (path:/tmp/pip-QtDYxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:12 INFO - Running setup.py (path:/tmp/pip-DRx87H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:12 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)) 04:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:12 INFO - Running setup.py (path:/tmp/pip-FrhwWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:12 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)) 04:59:12 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)) 04:59:12 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)) 04:59:12 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)) 04:59:12 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)) 04:59:12 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)) 04:59:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:12 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 04:59:12 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 04:59:12 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 04:59:12 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 04:59:12 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 04:59:12 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 04:59:14 INFO - Downloading blessings-1.6.tar.gz 04:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:14 INFO - Installing collected packages: blessings 04:59:14 INFO - Running setup.py install for blessings 04:59:14 INFO - Successfully installed blessings 04:59:14 INFO - Cleaning up... 04:59:14 INFO - Return code: 0 04:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:14 INFO - Reading from file tmpfile_stdout 04:59:14 INFO - Current package versions: 04:59:14 INFO - argparse == 1.2.1 04:59:14 INFO - blessings == 1.6 04:59:14 INFO - blobuploader == 1.2.4 04:59:14 INFO - docopt == 0.6.1 04:59:14 INFO - functools32 == 3.2.3-2 04:59:14 INFO - jsonschema == 2.5.1 04:59:14 INFO - manifestparser == 1.1 04:59:14 INFO - mozInstall == 1.12 04:59:14 INFO - mozcrash == 0.17 04:59:14 INFO - mozdebug == 0.1 04:59:14 INFO - mozdevice == 0.48 04:59:14 INFO - mozfile == 1.2 04:59:14 INFO - mozhttpd == 0.7 04:59:14 INFO - mozinfo == 0.9 04:59:14 INFO - mozleak == 0.1 04:59:14 INFO - mozlog == 3.2 04:59:14 INFO - moznetwork == 0.27 04:59:14 INFO - mozprocess == 0.22 04:59:14 INFO - mozprofile == 0.28 04:59:14 INFO - mozrunner == 6.11 04:59:14 INFO - mozscreenshot == 0.1 04:59:14 INFO - mozsystemmonitor == 0.3 04:59:14 INFO - moztest == 0.7 04:59:14 INFO - mozversion == 1.4 04:59:14 INFO - psutil == 3.1.1 04:59:14 INFO - requests == 1.2.3 04:59:14 INFO - wsgiref == 0.1.2 04:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:14 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 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:14 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 04:59:14 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 04:59:14 INFO - Using env: {'DISPLAY': ':0', 04:59:14 INFO - 'HOME': '/home/cltbld', 04:59:14 INFO - 'LANG': 'en_US.UTF-8', 04:59:14 INFO - 'LANGUAGE': 'en_US:en', 04:59:14 INFO - 'LOGNAME': 'cltbld', 04:59:14 INFO - 'MAIL': '/var/mail/cltbld', 04:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:14 INFO - 'MOZ_NO_REMOTE': '1', 04:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:14 INFO - 'NO_EM_RESTART': '1', 04:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:14 INFO - 'PWD': '/builds/slave/test', 04:59:14 INFO - 'SHELL': '/bin/bash', 04:59:14 INFO - 'SHLVL': '1', 04:59:14 INFO - 'TERM': 'linux', 04:59:14 INFO - 'TMOUT': '86400', 04:59:14 INFO - 'USER': 'cltbld', 04:59:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:14 INFO - '_': '/tools/buildbot/bin/python'} 04:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 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)) 04:59:14 INFO - Cleaning up... 04:59:14 INFO - Return code: 0 04:59:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:59:14 INFO - Using env: {'DISPLAY': ':0', 04:59:14 INFO - 'HOME': '/home/cltbld', 04:59:14 INFO - 'LANG': 'en_US.UTF-8', 04:59:14 INFO - 'LANGUAGE': 'en_US:en', 04:59:14 INFO - 'LOGNAME': 'cltbld', 04:59:14 INFO - 'MAIL': '/var/mail/cltbld', 04:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:14 INFO - 'MOZ_NO_REMOTE': '1', 04:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:14 INFO - 'NO_EM_RESTART': '1', 04:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:14 INFO - 'PWD': '/builds/slave/test', 04:59:14 INFO - 'SHELL': '/bin/bash', 04:59:14 INFO - 'SHLVL': '1', 04:59:14 INFO - 'TERM': 'linux', 04:59:14 INFO - 'TMOUT': '86400', 04:59:14 INFO - 'USER': 'cltbld', 04:59:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:14 INFO - '_': '/tools/buildbot/bin/python'} 04:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:59:15 INFO - Cleaning up... 04:59:15 INFO - Return code: 0 04:59:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b24f44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', '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 04:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:59:15 INFO - Using env: {'DISPLAY': ':0', 04:59:15 INFO - 'HOME': '/home/cltbld', 04:59:15 INFO - 'LANG': 'en_US.UTF-8', 04:59:15 INFO - 'LANGUAGE': 'en_US:en', 04:59:15 INFO - 'LOGNAME': 'cltbld', 04:59:15 INFO - 'MAIL': '/var/mail/cltbld', 04:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:15 INFO - 'MOZ_NO_REMOTE': '1', 04:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:15 INFO - 'NO_EM_RESTART': '1', 04:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:15 INFO - 'PWD': '/builds/slave/test', 04:59:15 INFO - 'SHELL': '/bin/bash', 04:59:15 INFO - 'SHLVL': '1', 04:59:15 INFO - 'TERM': 'linux', 04:59:15 INFO - 'TMOUT': '86400', 04:59:15 INFO - 'USER': 'cltbld', 04:59:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:15 INFO - '_': '/tools/buildbot/bin/python'} 04:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:15 INFO - Downloading/unpacking flake8 04:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:59:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:59:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 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 04:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:17 INFO - no previously-included directories found matching 'docs/_build' 04:59:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:59:18 INFO - Running setup.py install for pep8 04:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:18 INFO - no previously-included directories found matching 'docs/_build' 04:59:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:59:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:59:18 INFO - Cleaning up... 04:59:18 INFO - Return code: 0 04:59:18 INFO - Running post-action listener: _resource_record_post_action 04:59:18 INFO - Running post-action listener: _start_resource_monitoring 04:59:18 INFO - Starting resource monitoring. 04:59:18 INFO - ##### 04:59:18 INFO - ##### Finished create-virtualenv step (success) 04:59:18 INFO - ##### 04:59:18 INFO - ##### 04:59:18 INFO - ##### Running install step. 04:59:18 INFO - ##### 04:59:18 INFO - Running pre-action listener: _resource_record_pre_action 04:59:18 INFO - Running main action method: install 04:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:18 INFO - Reading from file tmpfile_stdout 04:59:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:59:18 INFO - Reading from file tmpfile_stdout 04:59:18 INFO - Output received: 04:59:18 INFO - Usage: mozinstall [options] installer 04:59:18 INFO - Options: 04:59:18 INFO - -h, --help show this help message and exit 04:59:18 INFO - -d DEST, --destination=DEST 04:59:18 INFO - Directory to install application into. [default: 04:59:18 INFO - "/builds/slave/test"] 04:59:18 INFO - --app=APP Application being installed. [default: firefox] 04:59:18 INFO - mkdir: /builds/slave/test/build/application 04:59:18 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'] 04:59:18 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 04:59:35 INFO - Reading from file tmpfile_stdout 04:59:35 INFO - Output received: 04:59:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:59:35 INFO - Running post-action listener: _resource_record_post_action 04:59:35 INFO - ##### 04:59:35 INFO - ##### Finished install step (success) 04:59:35 INFO - ##### 04:59:35 INFO - ##### 04:59:35 INFO - ##### Running run-tests step. 04:59:35 INFO - ##### 04:59:35 INFO - Running pre-action listener: _resource_record_pre_action 04:59:35 INFO - Running main action method: run_tests 04:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:35 INFO - Python 2.7.3 04:59:35 INFO - Return code: 0 04:59:35 INFO - grabbing minidump binary from tooltool 04:59: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')]} 04:59:35 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 0x252c1c0>, '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 0x252d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:35 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 04:59:35 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 04:59:35 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 04:59:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:35 INFO - Return code: 0 04:59:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:59:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:59:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:59:36 INFO - Return code: 0 04:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:59:36 INFO - Using env: {'DISPLAY': ':0', 04:59:36 INFO - 'HOME': '/home/cltbld', 04:59:36 INFO - 'LANG': 'en_US.UTF-8', 04:59:36 INFO - 'LANGUAGE': 'en_US:en', 04:59:36 INFO - 'LOGNAME': 'cltbld', 04:59:36 INFO - 'MAIL': '/var/mail/cltbld', 04:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:36 INFO - 'MOZ_NO_REMOTE': '1', 04:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:36 INFO - 'NO_EM_RESTART': '1', 04:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:36 INFO - 'PWD': '/builds/slave/test', 04:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:36 INFO - 'SHELL': '/bin/bash', 04:59:36 INFO - 'SHLVL': '1', 04:59:36 INFO - 'TERM': 'linux', 04:59:36 INFO - 'TMOUT': '86400', 04:59:36 INFO - 'USER': 'cltbld', 04:59:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722', 04:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:36 INFO - '_': '/tools/buildbot/bin/python'} 04:59:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:59:36 INFO - mozversion application_buildid: 20160622023033 04:59:36 INFO - mozversion application_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 04:59:36 INFO - mozversion application_display_name: Nightly 04:59:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:36 INFO - mozversion application_name: Firefox 04:59:36 INFO - mozversion application_remotingname: firefox 04:59:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:59:36 INFO - mozversion application_vendor: Mozilla 04:59:36 INFO - mozversion application_version: 50.0a1 04:59:36 INFO - mozversion platform_buildid: 20160622023033 04:59:36 INFO - mozversion platform_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 04:59:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:59:36 INFO - mozversion platform_version: 50.0a1 04:59:36 INFO - using testdate: 1466596776 04:59:36 INFO - actual date: 1466596776 04:59:36 INFO - starting webserver on 'localhost:46082' 04:59:36 INFO - SUITE-START | Running 2 tests 04:59:36 INFO - TEST-START | dromaeo_css 04:59:36 INFO - operating with platform_type : linux_ 04:59:36 INFO - Initialising browser for dromaeo_css test... 04:59:36 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGtvg2/profile http://localhost:46082/getInfo.html) 04:59:41 INFO - PROCESS | 2250 | __metrics Screen width/height:1600/1200 04:59:41 INFO - PROCESS | 2250 | colorDepth:24 04:59:41 INFO - PROCESS | 2250 | Browser inner width/height: 1024/697 04:59:41 INFO - PROCESS | 2250 | __metrics 04:59:42 ERROR - PROCESS | 2250 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:59:43 INFO - TEST-INFO | 2250: exit 0 04:59:43 INFO - Browser initialized. 04:59:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:43 INFO - TEST-INFO | started process 2443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGtvg2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:55 INFO - PROCESS | 2443 | RSS: Main: 185126912 04:59:55 INFO - PROCESS | 2443 | 05:00:44 INFO - PROCESS | 2443 | 1466596844798 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:02:52 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46082/tests/dromaeo/cssquery-ext.html) 05:02:53 INFO - PROCESS | 2443 | RSS: Main: 188301312 05:02:53 INFO - PROCESS | 2443 | 05:05:55 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-ext.html (next: http://localhost:46082/tests/dromaeo/cssquery-jquery.html) 05:05:56 INFO - PROCESS | 2443 | RSS: Main: 187629568 05:05:56 INFO - PROCESS | 2443 | 05:08:58 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46082/tests/dromaeo/cssquery-mootools.html) 05:08:58 INFO - PROCESS | 2443 | RSS: Main: 188813312 05:08:58 INFO - PROCESS | 2443 | 05:12:00 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46082/tests/dromaeo/cssquery-prototype.html) 05:12:01 INFO - PROCESS | 2443 | RSS: Main: 186396672 05:12:01 INFO - PROCESS | 2443 | 05:15:03 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46082/tests/dromaeo/cssquery-yui.html) 05:15:04 INFO - PROCESS | 2443 | RSS: Main: 188698624 05:15:04 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | Cycle 1(1): loaded http://localhost:46082/tests/dromaeo/cssquery-yui.html (next: http://localhost:46082/tests/dromaeo/cssquery-dojo.html) 05:18:06 INFO - PROCESS | 2443 | RSS: Main: 189693952 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | __start_tp_report 05:18:06 INFO - PROCESS | 2443 | _x_x_mozilla_page_load 05:18:06 INFO - PROCESS | 2443 | _x_x_mozilla_page_load_details 05:18:06 INFO - PROCESS | 2443 | |i|pagename|runs| 05:18:06 INFO - PROCESS | 2443 | |0;dojo.html;3036.5748795168674;3084.0747775667296;3123.4377811993845;3127.171299605605;3129.6713845046256;5280.894382112356;5296.708681022542;5348.171033489811;5410.890767392685;5429.158480435529;5250.343707036621;5326.147816349385;5337.359516857973;5364.141737322029;5415.187721841716;4801.6878902871285;4818.25317075852;4898.951010489885;4935.728534930596;4975.701457912537;685.6963513676399;4863.975680121594;4880.9755951220195;4905.730184839832;4944.159492886218;4800.807967681289;4833.419989601235;4836.105320515699;4848.636352273558;4883.487233840449;4770.260609605482;4815.22956326986;4877.585405240523;4883.584895283905;4910.361652985089;4826.22780355145;4864.100141473803;4898.681585696954;4908.4846091160625;4917;5405.135178371442;5431.321084864392;5450.291462109901;5453.836384908459;5454.53636440903;5618.0449323615085;5728;5775.566832487538;5783.756492354164;5804.187413762077;5808.4191580842;5840.328362238354;5857.326407463153;5858.384869588717;5906.763729450817;5424.891502169974;5425.9186112208345;5428.0500912340185;5431.429699881534;5435.0488664483555;5744.937186620405;5749.1663708762835;5761.308642962871;5912.290525136925;5940.168376427304;5623.634463759842;5628.887422251532;5629.605927585029;5630.268065151504;5657.51911087554;5732.512736417451;5745.511631511368;5746.195532625436;5747.568932330092;5761.85595360111;5601.719914004283;5720.1991721159075;5724.427557244326;5742.684152371659;5799.130130480377;5539.9169012464845;5657.773689052392;5662.037453632893;5704.686242256633;5728.598998070179;4351.499577548622;4354.521002689701;4392.516823149451;4399.098184872094;4418.270985287456;3868.2650296443585;3880.359740642819;3917.216556688674;3922.0783115967724;3937.468441760383;5531.0873705838085;5541.445855414427;5553.361363443175;5572.275604171432;5572.777088916479;5818.738156782955;5841.007028805113;5851.561132915049;5871.882562348815;5926.466618004314;5379.865503362369;5395.81114660985;5397.325334333208;5420.864478388072;5475.370332411744;4767.427908650915;4768.380110585602;4773.9761301193275;4785.138675038526;4829.492903245179;5806;5948.196993405835;5955.196048533393;5955.851103722355;5966.343702192756;5805.361410244954;5805.82582522525;5824.15549745293;5830.591858569859;5865.3254875689845;6007.8197654070445;6048.848778780566;6052.061930400795;6067.089936509559;6074.453299203093;5525.585581081355;5604.467575580314;5714.02861513552;5714.599978001666;5737.56968227393;5740.339860916049;5809.419058094157;5816.94183058164;5818;5877.206577112206;5590.636608620427;5637;5641.492265696107;5642.322921249476;5644.379118296902;5441.83674489766;5606.523445507178;5615.382307946041;5620.044592419216;5658.660480371191;5364.892702146013;5553.972230138824;5557.41647127062;5604.8318550443555;5608.719564021864;5629;5656.37779844225;5691.060974939089;5717.514011309086;5725.341585717696;5397.298351214474;5451.291332126798;5502.0921547945745;5568.554515638658;5585.720713964204 05:18:06 INFO - PROCESS | 2443 | |1;ext.html;587.7560812262911;618.8081694674651;627.8179327994882;646.3633321178638;653.4772182254198;42041.789791051044;43394.34908476375;43437;46970.76514617422;47024.76487617566;45055.32417013747;45385.0922981541;45492.77253613735;45496.54503454964;45604.77197614015;8828.293736501064;8988.77528061797;8989;9008.189262966333;9008.819823603524;8816.515091669955;8834.602442890053;8845.4250473719;8845.469271843678;8895.466272023667;8941.329400295004;8964.282857371427;8975.326850486239;8992.23565996891;9011;8877.911220887838;8903.688370907019;8929.46423214606;8966.103389661015;8984.640614375417;8669.869951950726;8755.124487551258;8756.518391488466;8759.343049271267;8769.605367758402;41570.37644435336;41985.58014419878;42128.578714212774;42140.57859421397;42185.36721949173;3589.3898037333715;3628.9455658164884;3735.5517337919623;3770.7360484766077;4037.394390841368;31621.841890790627;31702.207444813834;31930.680693193004;32266.35467290641;33000;4338.175746608134;4400.273954797454;4419.801108950105;4481.9103617927785;4515.119551687422;365157;371099;372401.96593119384;372527;372974;35407.29185416277;56189.71905140448;56406;56411;56658;35624;35648.108797279754;35951.64048359535;36043.279134417164;36088.45867311992;13987.930060349836;14173.220472873885;14184.574462766133;14194.432222710975;14260.42958281657;11425.200235983568;11452.198346115692;11472;11494.310341379543;11499.942500287445;8197.46716463428;8208.794780130425;8294.460860044077;8369.62336694838;8382.706605268786;3245.140037889914;3274.4773680238804;3281.9005633113175;3283.8029718216985;3313.204830840581;952.6570434643522;958.1328897347911;1029.3823705776624;1038.3510306058713;1130.745582244005;30480;33114.33771324608;33195.83402082974;33317;33368.49947250793;1126.5493802479075;1169.1990986174499;1187.3469591724518;1188.7814989635692;1249.3066348176667;16662.58343541421;16906;17074.146292685316;17157.75879197288;17315.826841731672;583048;587085;587907;590500;593363;58103.70948145317;58121.41878581245;58385;58621.413785862445;58829.70585147047;1258.5154715434442;1304.2435387475432;1372.6362513933816;1374.5257886029303;1377.5591810620506;30520;31305.8434707825;31407;32148.357032858745;32503.837480812446;51713.741431292605;52389;52438.737806310724;52495.21257181222;52691.20963185632;498314;506845;511793;512407;512606;43544.782276088416;43616;44297.77851110724;44661.10677786491;44802;47893;48618;48746.5125348742;49372.50627493679;49435;40370.59629403786;40677.389839151845;40764;41570.58429415788;42077.78961105175;40089.799551002056;40218.9945251371;40337.39493907653;40595.59404405918;41163.794181028905;39866.60133398629;41061.38407923824;42667.5733242676;42689.359659605754;45146.54853451424;33143.17142071467;36486;36594;38912;39397;27878;28522.42955140927;28591.14226573206;28655;28728.856355718923 05:18:06 INFO - PROCESS | 2443 | |2;jquery.html;375.90226541099304;377.4847333389924;383.130294232093;385.6163117697891;391.49301654357606;17555;18922.14850331735;18924;19511.609767804654;19552.217911283533;17476.475705728848;18170.727439088423;19149.329773457932;19412.611747765073;19482.220711171572;5158.7936482540745;5280.841574752763;5314.123169676998;5353.518183363496;5360.65155764876;5269.367675878881;5309.097453432906;5322.600804939626;5336.653117547347;5345.599080068991;5182.274481572583;5280.841574752763;5305.973470132644;5306.044911915854;5425.213344065108;5665;5738.42615738427;5769.913451298234;5793;5806.854828629276;5165.405978312505;5175.120229560984;5179.249008893689;5181.35233095863;5215.035218484554;21708;21798.455038624004;22457.43856403603;22602.20892268779;22749.658755118686;2315.444293369596;2353.8587684738973;2377.5720370333333;2409.3013026222375;2433.5376278507206;10181.236407269484;10197.694069177936;10379.636712715019;10391.324563903398;10600.310979786367;1957.148640341456;2023.5649335392814;2024.3724445421967;2041.193728477258;2083.4687154775434;82952.17047829565;83948;83985;84813;85180.99999999937;10711.83932241017;10872.61945831892;10975.615853445252;10982.104232033234;11216.270942388719;14861.777073343908;15136.621584460476;15158;15198.544043678707;15255.542333730005;7383.741569045165;7483.13943896448;7827.765167044998;7902;7931.167227441151;7157.1769246537315;7244.710211591478;7270.527415717961;7400.333969942731;7470.514416562906;4656.906861862812;4678.064387122589;4721.4570324413135;4733.384659994179;4771.33201351811;1902.4482899959135;1944.1834429539344;1992.9302474413325;2002.909869055896;2021.5047313408015;877.2630192219314;914.8856392950881;1014.700663304327;1038.2939601071344;1062.516554967488;18538.629227415648;18575.81424185741;18873.339433119774;19121.52196195106;19501.414957551297;908.2143945487106;981.0630847540582;983.8130755156498;985.4629227071264;1026.820306446369;10328.225383096147;10728.89271107279;10749.462526873625;10765.192610554239;10792.273236282157;496681;519757;522851;526858;536772;81931;93890;95636;95685.71870586544;100068;983.9065288797552;1013.1793247469574;1027.8766548014287;1032.896710328961;1045.508610952866;17209.106998229934;17516;17588.29646814164;17632.118394080502;17745.29018839232;30632.387352253278;31151.68848311488;40951.18097637971;42295;44731.776341118086;54795.726021371236;56801.431985681265;59294.70352648209;60013.09980350211;60213;7641.961790191013;8670.436421632827;8871.467711937305;8938.37431379797;8968.05835387275;12430.875691242973;13748.518801842287;14035.157890526601;14054.367553460323;14344.713105737617;11756.882431175922;11927;11968.521259149536;12355.382230888239;12696.492140314283;12357.32034738098;12399.13206075566;12439.880410763075;12633.747325053631;12678.429470673658;12171.391430428266;12310.630681079581;12337.198082124632;12586.622401327975;12685.746285074063;7493.100827900686;7903.525788452711;7960;8014.519128852287;8073.919260807317;8873.866891996497;10524.842127367943;10939.398333091756;11167.329960202414;12300.200486968319 05:18:06 INFO - PROCESS | 2443 | |3;mootools.html;1450.9709805803884;1482.5774654223544;1597.976030359545;1747.1177055586927;1750.7986581543119;8066.4353495255355;8461.703840365588;8626.309895208384;9161.358704890652;9190.586423610928;8577.957110214456;8744.300455963523;8755.343349248817;8803.867941980876;8888.777780555489;2220.5336879255374;2253.143805353963;2261.2989973108306;2283.474800795818;2284.7258329000542;2211.7124773779387;2244.136007637055;2286.6798648189265;2288.187693368855;2302.792748652621;2251.9887400563057;2252.7859853313907;2267.8887345200815;2293.0827668932475;2295.173737454515;2238.541099074686;2257.16484900587;2258.67249248858;2259.7966183043604;2259.807916327114;2243.1588154442084;2247.505548779266;2252.2004688335733;2263.6265016272296;2269.909203631853;8704.173103555153;8864.335174861912;8900.065493123258;8900.465972041633;8924.55377231136;4980.676256043345;5152.484751524855;5152.613553983466;5163.173892177271;5175.663581867204;3247.6102867655795;3251.886183983549;3361.46216605342;3426.468897320919;3446.293509830504;1116.2242241641982;1127.3912087472836;1132.399828091113;1154.591398493836;1154.7113221694576;12249.755004899942;12422.130450868442;12464.189827661174;12498.687532811662;12530.874691253062;4548.272276435754;4549.363089167519;4631.305304204397;4654.767261636973;4659.207934651117;10693.625723099654;10700.197485188643;10701.946490267499;10703.518341674644;10703.946480267548;5127.66670166438;5189.818356357509;5193.2989046479;5204.21936709489;5208.348956380452;4106.815193316308;4556.65825063115;4695.929561056587;4727.57451829337;4757.833475828399;4016.256992456405;4039.3537034074407;4096.5903409659395;4112.938305925413;4140.648044916215;1208.7159517513378;1223.0887988448485;1249.8375211222483;1253.4547471849774;1255.7927941889668;944.367273926471;1019.8215312320315;1026.3328836256494;1031.6698656429871;1043.7703705185;6021.397860213943;6156.6921653917125;6201.224846894138;6239.688015599202;6343.283582089508;421.90085329947436;432.9307310830315;434.2552522424058;438.0844035964785;442.8095918754966;4075.3479443289525;4081.9795901020307;4114.629683328515;4127.422160897477;4134.37984302357;10811.35131892089;11077.003069723763;11182.776344473064;11186.993170614684;11276.210665253517;11028.2280240384;11046.502907369188;11080.722981925517;11084.612038578773;11107.38909359993;8137.104918458965;8351.29014033814;8360.289375403037;8378.748637540763;8398.748037558884;5993.400659933972;6113.113598528277;6134.355892631388;6154.507639388928;6162.753489860355;10440.791184176425;10469.895301046892;10472.162227021667;10538.947305263424;10617.362958222531;10356.792864142524;10508.527116279938;10590.364578125336;10679.839802402816;10728.034476897117;7232.168300645493;7548.358389536951;7815.452918295665;7937.444378893422;7968.2031796822175;8799.780005499657;8823.558822059;8837.91162088371;8866.822663546563;8903.421277616933;7334.596597187206;7404.370628496638;7525.435592330707;7764.4953078052;8032.558209298545;7669.1947345527915;7779.7666070017995;7799.766007019798;7900.920990790249;8038.67845286182;7068;7069.858602828018;7107.82230444243;7125.35871771543;7129.643517824192;5075.7969681212335;5154;5267.947320526746;5327.733613319396;5377.435369286325;5225.843224703265;5248.212768084665;5278.9472105278455;5297.125974214211;5346.518813306821 05:18:06 INFO - PROCESS | 2443 | |4;prototype.html;320.77064898597496;322.30864795014696;328.59090432411654;329.4794225124304;333.6096766782864;5401.405845357008;5448;5523.281973343464;5538.363088244853;5619;5498.615096943216;5549.278593782813;5557.249771280876;5564.527015203713;5575.721213939297;4294.205571969195;4318.157959197958;4340;4340.262155433568;4346.239408103585;4072.839240816368;4268.615824575788;4276.647843685976;4338.891527711817;4352.7605981670995;4208.831646734127;4217.975371821528;4229.661627069842;4249.702520823544;4252.829886804524;4263.424437700902;4268.914621707564;4271.188474189925;4306.5262821089655;4311.568843115695;3543.5747710274672;3721.6650501455;3748.100455890594;3761.2101458693705;3761.774293542396;5419.83740487786;5435.701036442994;5444.210589464506;5450.345958484968;5451.781928722847;4861.225652636797;4898.338724272213;4904.485029071931;4905.2887331337115;4926.901461970776;5519.254900588449;5760.683162426065;5813.314138899714;5825.679587622679;5839.708014599253;4051.2910240707756;4055.7363771354767;4062.8577999770164;4067;4076.32740597801;5937.584369094208;5945.613535120204;6000.699965001776;6038.63768173911;6066.666333351708;4087.51839932142;4095.91808163841;4155.480564929384;4164.646005089541;4182.372644103409;4188.895277618023;4215.494140703136;4220.810063547147;4222.662187025031;4246.596573325529;4854.757262136879;4873.586659868598;4875.829345972874;4881.316615673809;4885.291632713308;5205.7917683293;5842.532597392198;5857.355690874;5869.325027621793;5888.499477544371;1437.1951707044088;1440.7118576284786;1455.6142622205125;1456.6504039030556;1458.358322338168;904.1184844776291;915.9129882661136;929.4469790474657;929.8837645294338;931.1386967055447;4998.925016124761;5042.629963916953;5080.74596270185;5119.8720031998755;5142.537171654569;5212.4266330703595;5246.376811594203;5290.603204759658;5366.543843773245;5369.3556773187465;5010.847505073853;5035.985605757653;5060.544550990355;5216.713080780593;5698.17376480408;3192.170035790711;3246.805191688506;3259.739220862373;3264.9347013059605;3268.624108227537;5957.523398128139;6244.781432649836;6324.272708638566;6328.7468501260355;6340.841478963062;6131.202943617302;6151.108089327023;6176.629402235881;6179.3202747697715;6218.160548326008;6196.194494715748;6227.96886015567;6262.373762623702;6266.905996410058;6283.59156654816;5734.340550836707;5963.671998040149;5989.431004054608;5990;6068.4841788448475;5886.852828679317;5939.4357536034;5943.524518038633;5970.910436343372;6001.719346648246;5957.463828255478;6014.248218972629;6171.413715697002;6179.3820617937845;6288.050704281687;4210.59999300066;4212.304969679968;4223.93664095045;4236.894077648083;4242.787860606895;5750.971245143747;5877.529797616266;6050.818475445743;6085.208922840003;6093;5748;5833.649981001154;5844.678542680023;5859.882802343844;5862.765489380377;5740.827775166752;5781.913271300849;5785.56608254391;5797.797077102281;5823.505002074871;5620.241267428844;5686.260786097946;5703.20155178267;5712.800051998326;5735.799247026334;5845.941540584539;5916.55625828056;5921.792737254175;5932.288125424977;5961.8807623846415;5599.60802743804;5692.715364231854;5756.338021127456;5802.390748971297;5820.330661973927 05:18:06 INFO - PROCESS | 2443 | |5;yui.html;730.7040648537344;747.1221314954927;750.2572453271262;785.8153333966517;841.1126261793809;15037.699246015072;15171.669962250582;15703.450379236729;16623.584410389733;16747.33010679573;13963.860361396382;13997.160170389783;14019;14080.71838563228;14135.71728565428;796.6176235407008;799.9920000800005;803.9839203215961;810.720301495983;813.2680587471293;814.5479259011246;823.4647479138548;824.7608193623842;824.9340052795792;825.8430898129366;850.4514588090677;856.6530555125184;859.1365677494109;861.5218553702692;862.5730263519566;853.6116067189445;856.1481326080527;856.4989481153501;856.8671855862351;856.9400141990063;619.5322531488742;620.4725982914487;621.9689015549204;626.6709977261928;627.3475585391234;16332.836671633251;16429;16554.751678724708;16610.83389166105;16643.91678041614;14859.554213373616;15286.566940538965;15380.692386152326;15441.613959651098;15551.844481555152;12401;12496.270215432289;12576.37118144089;12613.243205407613;12724.936375318157;3805.1058001369656;3821.2166505866508;3836.1521359377325;3877.2245550889934;3927;62844;62966.37033629697;63202.36797632011;67340.3265967339;84741;11754.529818807152;11917.106217033584;11993.940030299793;12123.636290911287;12256.080793940311;21640.783592164193;21679.566408672054;21729.130834766747;21829;22228.666570001464;8233;8481;8531.360147988926;8706.39055266138;9105.681301154427;4734.0058587696285;4794.808207671724;4843.4430040545785;4959.330490383824;5062.594992400599;3461.44616861301;3559.305935342635;3584.874529391511;3603.3694103531775;3604.9639503605154;629.4586655476287;637.6365471681097;643.1960049937578;655.0665301944709;658.8484648530865;642.4795915308615;685.7874059041714;695.4957655699577;727.912650481935;728.7449392712614;8544.273736732323;9167.358284920125;9274.536273186448;9312.767180820534;9375.34372593912;688.7761477519726;689.2005273882372;690.2200513419804;694.7776711452286;704.503325155764;4429.911401771947;4467.195904737178;4467.30756732707;4535.795889184995;4621.560951709582;110288;114522.42738786252;130611;134615.32692336474;135265;63958;105324;105611;105634.47182764037;105814.47092764487;93540;95794.52102739441;96633.51683241679;97595.51202243943;97704;9744.951275243862;9794.00432103054;9862.9561879629;9863.082026086855;9896.554655040396;53250.4674953261;53393.19910201428;53944;54957.72521137369;55607;75913.62043189749;86625.02863859465;87063.56468217618;87349;87785;12888.48446062147;13083.41124649374;13303.334833258492;13331.933340333237;14155.292235388395;14706.218763209332;14837.703245934805;14860.702785944437;14949.25253737287;15228.162451065298;14283.500077497238;14463.78304325457;14673.633159171106;14687.339069741674;15142.697146056797;14052.929735351257;14329.355179017179;14451.92774036123;14503.1298122113;14539.200343981183;13378.197308161542;13746.381412836246;13746.862531374558;13938.431042468621;14333.56999290023;10829.783404332027;10857.457127143769;11145.777084458428;11189.608363707232;11661.533538658698;11277.661670149908;11620;11791.646250612495;11801;12118.636440906786 05:18:06 INFO - PROCESS | 2443 | __end_tp_report 05:18:06 INFO - PROCESS | 2443 | __start_cc_report 05:18:06 INFO - PROCESS | 2443 | _x_x_mozilla_cycle_collect,340 05:18:06 INFO - PROCESS | 2443 | __end_cc_report 05:18:06 INFO - PROCESS | 2443 | __startTimestamp1466597886941__endTimestamp 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | ------- Summary: start ------- 05:18:06 INFO - PROCESS | 2443 | Number of tests: 6 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#0] dojo.html Cycles:165 Average:5317.32 Median:5572.28 stddev:719.64 (12.9%) stddev-sans-first:699.25 05:18:06 INFO - PROCESS | 2443 | Values: 3036.6 3084.1 3123.4 3127.2 3129.7 5280.9 5296.7 5348.2 5410.9 5429.2 5250.3 5326.1 5337.4 5364.1 5415.2 4801.7 4818.3 4899.0 4935.7 4975.7 685.7 4864.0 4881.0 4905.7 4944.2 4800.8 4833.4 4836.1 4848.6 4883.5 4770.3 4815.2 4877.6 4883.6 4910.4 4826.2 4864.1 4898.7 4908.5 4917.0 5405.1 5431.3 5450.3 5453.8 5454.5 5618.0 5728.0 5775.6 5783.8 5804.2 5808.4 5840.3 5857.3 5858.4 5906.8 5424.9 5425.9 5428.1 5431.4 5435.0 5744.9 5749.2 5761.3 5912.3 5940.2 5623.6 5628.9 5629.6 5630.3 5657.5 5732.5 5745.5 5746.2 5747.6 5761.9 5601.7 5720.2 5724.4 5742.7 5799.1 5539.9 5657.8 5662.0 5704.7 5728.6 4351.5 4354.5 4392.5 4399.1 4418.3 3868.3 3880.4 3917.2 3922.1 3937.5 5531.1 5541.4 5553.4 5572.3 5572.8 5818.7 5841.0 5851.6 5871.9 5926.5 5379.9 5395.8 5397.3 5420.9 5475.4 4767.4 4768.4 4774.0 4785.1 4829.5 5806.0 5948.2 5955.2 5955.9 5966.3 5805.4 5805.8 5824.2 5830.6 5865.3 6007.8 6048.8 6052.1 6067.1 6074.5 5525.6 5604.5 5714.0 5714.6 5737.6 5740.3 5809.4 5816.9 5818.0 5877.2 5590.6 5637.0 5641.5 5642.3 5644.4 5441.8 5606.5 5615.4 5620.0 5658.7 5364.9 5554.0 5557.4 5604.8 5608.7 5629.0 5656.4 5691.1 5717.5 5725.3 5397.3 5451.3 5502.1 5568.6 5585.7 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#1] ext.html Cycles:180 Average:63557.94 Median:42162.97 stddev:132521.23 (314.3%) stddev-sans-first:132808.65 05:18:06 INFO - PROCESS | 2443 | Values: 587.8 618.8 627.8 646.4 653.5 42041.8 43394.3 43437.0 46970.8 47024.8 45055.3 45385.1 45492.8 45496.5 45604.8 8828.3 8988.8 8989.0 9008.2 9008.8 8816.5 8834.6 8845.4 8845.5 8895.5 8941.3 8964.3 8975.3 8992.2 9011.0 8877.9 8903.7 8929.5 8966.1 8984.6 8669.9 8755.1 8756.5 8759.3 8769.6 41570.4 41985.6 42128.6 42140.6 42185.4 3589.4 3628.9 3735.6 3770.7 4037.4 31621.8 31702.2 31930.7 32266.4 33000.0 4338.2 4400.3 4419.8 4481.9 4515.1 365157.0 371099.0 372402.0 372527.0 372974.0 35407.3 56189.7 56406.0 56411.0 56658.0 35624.0 35648.1 35951.6 36043.3 36088.5 13987.9 14173.2 14184.6 14194.4 14260.4 11425.2 11452.2 11472.0 11494.3 11499.9 8197.5 8208.8 8294.5 8369.6 8382.7 3245.1 3274.5 3281.9 3283.8 3313.2 952.7 958.1 1029.4 1038.4 1130.7 30480.0 33114.3 33195.8 33317.0 33368.5 1126.5 1169.2 1187.3 1188.8 1249.3 16662.6 16906.0 17074.1 17157.8 17315.8 583048.0 587085.0 587907.0 590500.0 593363.0 58103.7 58121.4 58385.0 58621.4 58829.7 1258.5 1304.2 1372.6 1374.5 1377.6 30520.0 31305.8 31407.0 32148.4 32503.8 51713.7 52389.0 52438.7 52495.2 52691.2 498314.0 506845.0 511793.0 512407.0 512606.0 43544.8 43616.0 44297.8 44661.1 44802.0 47893.0 48618.0 48746.5 49372.5 49435.0 40370.6 40677.4 40764.0 41570.6 42077.8 40089.8 40219.0 40337.4 40595.6 41163.8 39866.6 41061.4 42667.6 42689.4 45146.5 33143.2 36486.0 36594.0 38912.0 39397.0 27878.0 28522.4 28591.1 28655.0 28728.9 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#2] jquery.html Cycles:180 Average:29783.17 Median:2393.44 stddev:85810.59 (3585.2%) stddev-sans-first:86022.90 05:18:06 INFO - PROCESS | 2443 | Values: 375.9 377.5 383.1 385.6 391.5 17555.0 18922.1 18924.0 19511.6 19552.2 17476.5 18170.7 19149.3 19412.6 19482.2 5158.8 5280.8 5314.1 5353.5 5360.7 5269.4 5309.1 5322.6 5336.7 5345.6 5182.3 5280.8 5306.0 5306.0 5425.2 5665.0 5738.4 5769.9 5793.0 5806.9 5165.4 5175.1 5179.2 5181.4 5215.0 21708.0 21798.5 22457.4 22602.2 22749.7 2315.4 2353.9 2377.6 2409.3 2433.5 10181.2 10197.7 10379.6 10391.3 10600.3 1957.1 2023.6 2024.4 2041.2 2083.5 82952.2 83948.0 83985.0 84813.0 85181.0 10711.8 10872.6 10975.6 10982.1 11216.3 14861.8 15136.6 15158.0 15198.5 15255.5 7383.7 7483.1 7827.8 7902.0 7931.2 7157.2 7244.7 7270.5 7400.3 7470.5 4656.9 4678.1 4721.5 4733.4 4771.3 1902.4 1944.2 1992.9 2002.9 2021.5 877.3 914.9 1014.7 1038.3 1062.5 18538.6 18575.8 18873.3 19121.5 19501.4 908.2 981.1 983.8 985.5 1026.8 10328.2 10728.9 10749.5 10765.2 10792.3 496681.0 519757.0 522851.0 526858.0 536772.0 81931.0 93890.0 95636.0 95685.7 100068.0 983.9 1013.2 1027.9 1032.9 1045.5 17209.1 17516.0 17588.3 17632.1 17745.3 30632.4 31151.7 40951.2 42295.0 44731.8 54795.7 56801.4 59294.7 60013.1 60213.0 7642.0 8670.4 8871.5 8938.4 8968.1 12430.9 13748.5 14035.2 14054.4 14344.7 11756.9 11927.0 11968.5 12355.4 12696.5 12357.3 12399.1 12439.9 12633.7 12678.4 12171.4 12310.6 12337.2 12586.6 12685.7 7493.1 7903.5 7960.0 8014.5 8073.9 8873.9 10524.8 10939.4 11167.3 12300.2 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#3] mootools.html Cycles:180 Average:5853.07 Median:427.42 stddev:3405.22 (796.7%) stddev-sans-first:3398.70 05:18:06 INFO - PROCESS | 2443 | Values: 1451.0 1482.6 1598.0 1747.1 1750.8 8066.4 8461.7 8626.3 9161.4 9190.6 8578.0 8744.3 8755.3 8803.9 8888.8 2220.5 2253.1 2261.3 2283.5 2284.7 2211.7 2244.1 2286.7 2288.2 2302.8 2252.0 2252.8 2267.9 2293.1 2295.2 2238.5 2257.2 2258.7 2259.8 2259.8 2243.2 2247.5 2252.2 2263.6 2269.9 8704.2 8864.3 8900.1 8900.5 8924.6 4980.7 5152.5 5152.6 5163.2 5175.7 3247.6 3251.9 3361.5 3426.5 3446.3 1116.2 1127.4 1132.4 1154.6 1154.7 12249.8 12422.1 12464.2 12498.7 12530.9 4548.3 4549.4 4631.3 4654.8 4659.2 10693.6 10700.2 10701.9 10703.5 10703.9 5127.7 5189.8 5193.3 5204.2 5208.3 4106.8 4556.7 4695.9 4727.6 4757.8 4016.3 4039.4 4096.6 4112.9 4140.6 1208.7 1223.1 1249.8 1253.5 1255.8 944.4 1019.8 1026.3 1031.7 1043.8 6021.4 6156.7 6201.2 6239.7 6343.3 421.9 432.9 434.3 438.1 442.8 4075.3 4082.0 4114.6 4127.4 4134.4 10811.4 11077.0 11182.8 11187.0 11276.2 11028.2 11046.5 11080.7 11084.6 11107.4 8137.1 8351.3 8360.3 8378.7 8398.7 5993.4 6113.1 6134.4 6154.5 6162.8 10440.8 10469.9 10472.2 10538.9 10617.4 10356.8 10508.5 10590.4 10679.8 10728.0 7232.2 7548.4 7815.5 7937.4 7968.2 8799.8 8823.6 8837.9 8866.8 8903.4 7334.6 7404.4 7525.4 7764.5 8032.6 7669.2 7779.8 7799.8 7900.9 8038.7 7068.0 7069.9 7107.8 7125.4 7129.6 5075.8 5154.0 5267.9 5327.7 5377.4 5225.8 5248.2 5278.9 5297.1 5346.5 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#4] prototype.html Cycles:180 Average:4842.74 Median:5451.06 stddev:1445.17 (26.5%) stddev-sans-first:1408.80 05:18:06 INFO - PROCESS | 2443 | Values: 320.8 322.3 328.6 329.5 333.6 5401.4 5448.0 5523.3 5538.4 5619.0 5498.6 5549.3 5557.2 5564.5 5575.7 4294.2 4318.2 4340.0 4340.3 4346.2 4072.8 4268.6 4276.6 4338.9 4352.8 4208.8 4218.0 4229.7 4249.7 4252.8 4263.4 4268.9 4271.2 4306.5 4311.6 3543.6 3721.7 3748.1 3761.2 3761.8 5419.8 5435.7 5444.2 5450.3 5451.8 4861.2 4898.3 4904.5 4905.3 4926.9 5519.3 5760.7 5813.3 5825.7 5839.7 4051.3 4055.7 4062.9 4067.0 4076.3 5937.6 5945.6 6000.7 6038.6 6066.7 4087.5 4095.9 4155.5 4164.6 4182.4 4188.9 4215.5 4220.8 4222.7 4246.6 4854.8 4873.6 4875.8 4881.3 4885.3 5205.8 5842.5 5857.4 5869.3 5888.5 1437.2 1440.7 1455.6 1456.7 1458.4 904.1 915.9 929.4 929.9 931.1 4998.9 5042.6 5080.7 5119.9 5142.5 5212.4 5246.4 5290.6 5366.5 5369.4 5010.8 5036.0 5060.5 5216.7 5698.2 3192.2 3246.8 3259.7 3264.9 3268.6 5957.5 6244.8 6324.3 6328.7 6340.8 6131.2 6151.1 6176.6 6179.3 6218.2 6196.2 6228.0 6262.4 6266.9 6283.6 5734.3 5963.7 5989.4 5990.0 6068.5 5886.9 5939.4 5943.5 5970.9 6001.7 5957.5 6014.2 6171.4 6179.4 6288.1 4210.6 4212.3 4223.9 4236.9 4242.8 5751.0 5877.5 6050.8 6085.2 6093.0 5748.0 5833.6 5844.7 5859.9 5862.8 5740.8 5781.9 5785.6 5797.8 5823.5 5620.2 5686.3 5703.2 5712.8 5735.8 5845.9 5916.6 5921.8 5932.3 5961.9 5599.6 5692.7 5756.3 5802.4 5820.3 05:18:06 INFO - PROCESS | 2443 | 05:18:06 INFO - PROCESS | 2443 | [#5] yui.html Cycles:180 Average:21644.89 Median:4467.25 stddev:31770.37 (711.2%) stddev-sans-first:31820.68 05:18:06 INFO - PROCESS | 2443 | Values: 730.7 747.1 750.3 785.8 841.1 15037.7 15171.7 15703.5 16623.6 16747.3 13963.9 13997.2 14019.0 14080.7 14135.7 796.6 800.0 804.0 810.7 813.3 814.5 823.5 824.8 824.9 825.8 850.5 856.7 859.1 861.5 862.6 853.6 856.1 856.5 856.9 856.9 619.5 620.5 622.0 626.7 627.3 16332.8 16429.0 16554.8 16610.8 16643.9 14859.6 15286.6 15380.7 15441.6 15551.8 12401.0 12496.3 12576.4 12613.2 12724.9 3805.1 3821.2 3836.2 3877.2 3927.0 62844.0 62966.4 63202.4 67340.3 84741.0 11754.5 11917.1 11993.9 12123.6 12256.1 21640.8 21679.6 21729.1 21829.0 22228.7 8233.0 8481.0 8531.4 8706.4 9105.7 4734.0 4794.8 4843.4 4959.3 5062.6 3461.4 3559.3 3584.9 3603.4 3605.0 629.5 637.6 643.2 655.1 658.8 642.5 685.8 695.5 727.9 728.7 8544.3 9167.4 9274.5 9312.8 9375.3 688.8 689.2 690.2 694.8 704.5 4429.9 4467.2 4467.3 4535.8 4621.6 110288.0 114522.4 130611.0 134615.3 135265.0 63958.0 105324.0 105611.0 105634.5 105814.5 93540.0 95794.5 96633.5 97595.5 97704.0 9745.0 9794.0 9863.0 9863.1 9896.6 53250.5 53393.2 53944.0 54957.7 55607.0 75913.6 86625.0 87063.6 87349.0 87785.0 12888.5 13083.4 13303.3 13331.9 14155.3 14706.2 14837.7 14860.7 14949.3 15228.2 14283.5 14463.8 14673.6 14687.3 15142.7 14052.9 14329.4 14451.9 14503.1 14539.2 13378.2 13746.4 13746.9 13938.4 14333.6 10829.8 10857.5 11145.8 11189.6 11661.5 11277.7 11620.0 11791.6 11801.0 12118.6 05:18:06 INFO - PROCESS | 2443 | -------- Summary: end -------- 05:18:06 INFO - PROCESS | 2443 | 05:18:07 INFO - TEST-INFO | 2443: exit 0 05:18:07 INFO - TEST-OK | dromaeo_css | took 1110894ms 05:18:07 INFO - TEST-START | kraken 05:18:07 INFO - operating with platform_type : linux_ 05:18:07 INFO - Initialising browser for kraken test... 05:18:07 INFO - TEST-INFO | started process 2737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSm41wh/profile http://localhost:46082/getInfo.html) 05:18:12 INFO - PROCESS | 2737 | __metrics Screen width/height:1600/1200 05:18:12 INFO - PROCESS | 2737 | colorDepth:24 05:18:12 INFO - PROCESS | 2737 | Browser inner width/height: 1024/697 05:18:12 INFO - PROCESS | 2737 | __metrics 05:18:13 ERROR - PROCESS | 2737 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:18:14 INFO - TEST-INFO | 2737: exit 0 05:18:14 INFO - Browser initialized. 05:18:14 INFO - Running cycle 1/1 for kraken test... 05:18:14 INFO - TEST-INFO | started process 2930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSm41wh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:26 INFO - PROCESS | 2930 | RSS: Main: 184766464 05:18:26 INFO - PROCESS | 2930 | 05:18:28 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46082/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:29 INFO - PROCESS | 2930 | RSS: Main: 190791680 05:18:29 INFO - PROCESS | 2930 | 05:18:32 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46082/tests/kraken/driver.html?testName=audio-dft) 05:18:32 INFO - PROCESS | 2930 | RSS: Main: 189661184 05:18:32 INFO - PROCESS | 2930 | 05:18:35 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46082/tests/kraken/driver.html?testName=audio-fft) 05:18:36 INFO - PROCESS | 2930 | RSS: Main: 184590336 05:18:36 INFO - PROCESS | 2930 | 05:18:38 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46082/tests/kraken/driver.html?testName=audio-oscillator) 05:18:38 INFO - PROCESS | 2930 | RSS: Main: 185262080 05:18:38 INFO - PROCESS | 2930 | 05:18:41 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:41 INFO - PROCESS | 2930 | RSS: Main: 185909248 05:18:41 INFO - PROCESS | 2930 | 05:18:44 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46082/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:45 INFO - PROCESS | 2930 | RSS: Main: 186486784 05:18:45 INFO - PROCESS | 2930 | 05:18:49 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46082/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:49 INFO - PROCESS | 2930 | RSS: Main: 183734272 05:18:49 INFO - PROCESS | 2930 | 05:18:52 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46082/tests/kraken/driver.html?testName=json-parse-financial) 05:18:53 INFO - PROCESS | 2930 | RSS: Main: 184963072 05:18:53 INFO - PROCESS | 2930 | 05:18:54 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:55 INFO - PROCESS | 2930 | RSS: Main: 185610240 05:18:55 INFO - PROCESS | 2930 | 05:18:57 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:57 INFO - PROCESS | 2930 | RSS: Main: 185536512 05:18:57 INFO - PROCESS | 2930 | 05:18:59 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:00 INFO - PROCESS | 2930 | RSS: Main: 186261504 05:19:00 INFO - PROCESS | 2930 | 05:19:03 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:03 INFO - PROCESS | 2930 | RSS: Main: 186159104 05:19:03 INFO - PROCESS | 2930 | 05:19:06 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:07 INFO - PROCESS | 2930 | RSS: Main: 186253312 05:19:07 INFO - PROCESS | 2930 | 05:19:08 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:46082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46082/tests/kraken/driver.html?testName=ai-astar) 05:19:09 INFO - PROCESS | 2930 | RSS: Main: 187232256 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | __start_tp_report 05:19:09 INFO - PROCESS | 2930 | _x_x_mozilla_page_load 05:19:09 INFO - PROCESS | 2930 | _x_x_mozilla_page_load_details 05:19:09 INFO - PROCESS | 2930 | |i|pagename|runs| 05:19:09 INFO - PROCESS | 2930 | |0;ai-astar;112;107;111;111;111;112;111;111;110;111 05:19:09 INFO - PROCESS | 2930 | |1;audio-beat-detection;157;128;161;192;132;154;153;127;196;138 05:19:09 INFO - PROCESS | 2930 | |2;audio-dft;163;161;161;162;165;174;166;162;164;163 05:19:09 INFO - PROCESS | 2930 | |3;audio-fft;76;75;76;161;76;76;76;75;160;75 05:19:09 INFO - PROCESS | 2930 | |4;audio-oscillator;85;84;155;85;83;84;141;86;85;149 05:19:09 INFO - PROCESS | 2930 | |5;imaging-gaussian-blur;117;117;118;118;118;117;118;118;118;118 05:19:09 INFO - PROCESS | 2930 | |6;imaging-darkroom;148;150;149;148;148;148;148;148;148;147 05:19:09 INFO - PROCESS | 2930 | |7;imaging-desaturate;97;95;96;95;96;96;95;96;97;95 05:19:09 INFO - PROCESS | 2930 | |8;json-parse-financial;57;54;55;56;54;57;55;56;54;54 05:19:09 INFO - PROCESS | 2930 | |9;json-stringify-tinderbox;62;62;62;63;64;63;64;64;63;63 05:19:09 INFO - PROCESS | 2930 | |10;stanford-crypto-aes;81;85;80;81;81;87;80;81;107;81 05:19:09 INFO - PROCESS | 2930 | |11;stanford-crypto-ccm;131;122;124;129;128;140;133;127;141;131 05:19:09 INFO - PROCESS | 2930 | |12;stanford-crypto-pbkdf2;160;161;161;165;158;161;173;160;163;159 05:19:09 INFO - PROCESS | 2930 | |13;stanford-crypto-sha256-iterative;64;65;63;72;68;63;62;64;64;65 05:19:09 INFO - PROCESS | 2930 | __end_tp_report 05:19:09 INFO - PROCESS | 2930 | __start_cc_report 05:19:09 INFO - PROCESS | 2930 | _x_x_mozilla_cycle_collect,900 05:19:09 INFO - PROCESS | 2930 | __end_cc_report 05:19:09 INFO - PROCESS | 2930 | __startTimestamp1466597949089__endTimestamp 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | ------- Summary: start ------- 05:19:09 INFO - PROCESS | 2930 | Number of tests: 14 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.42 (1.3%) stddev-sans-first:1.42 05:19:09 INFO - PROCESS | 2930 | Values: 112.0 107.0 111.0 111.0 111.0 112.0 111.0 111.0 110.0 111.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:155.50 stddev:24.52 (15.8%) stddev-sans-first:25.98 05:19:09 INFO - PROCESS | 2930 | Values: 157.0 128.0 161.0 192.0 132.0 154.0 153.0 127.0 196.0 138.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.84 (2.4%) stddev-sans-first:4.06 05:19:09 INFO - PROCESS | 2930 | Values: 163.0 161.0 161.0 162.0 165.0 174.0 166.0 162.0 164.0 163.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.79 (47.1%) stddev-sans-first:37.45 05:19:09 INFO - PROCESS | 2930 | Values: 76.0 75.0 76.0 161.0 76.0 76.0 76.0 75.0 160.0 75.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:84.50 stddev:30.99 (36.7%) stddev-sans-first:32.12 05:19:09 INFO - PROCESS | 2930 | Values: 85.0 84.0 155.0 85.0 83.0 84.0 141.0 86.0 85.0 149.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:19:09 INFO - PROCESS | 2930 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:19:09 INFO - PROCESS | 2930 | Values: 148.0 150.0 149.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 05:19:09 INFO - PROCESS | 2930 | Values: 97.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 97.0 95.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.23 (2.2%) stddev-sans-first:1.12 05:19:09 INFO - PROCESS | 2930 | Values: 57.0 54.0 55.0 56.0 54.0 57.0 55.0 56.0 54.0 54.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 05:19:09 INFO - PROCESS | 2930 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 64.0 64.0 63.0 63.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.00 stddev:8.26 (10.2%) stddev-sans-first:8.67 05:19:09 INFO - PROCESS | 2930 | Values: 81.0 85.0 80.0 81.0 81.0 87.0 80.0 81.0 107.0 81.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:131.00 stddev:6.17 (4.7%) stddev-sans-first:6.54 05:19:09 INFO - PROCESS | 2930 | Values: 131.0 122.0 124.0 129.0 128.0 140.0 133.0 127.0 141.0 131.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:161.00 stddev:4.31 (2.7%) stddev-sans-first:4.50 05:19:09 INFO - PROCESS | 2930 | Values: 160.0 161.0 161.0 165.0 158.0 161.0 173.0 160.0 163.0 159.0 05:19:09 INFO - PROCESS | 2930 | 05:19:09 INFO - PROCESS | 2930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:2.94 (4.6%) stddev-sans-first:3.10 05:19:09 INFO - PROCESS | 2930 | Values: 64.0 65.0 63.0 72.0 68.0 63.0 62.0 64.0 64.0 65.0 05:19:09 INFO - PROCESS | 2930 | -------- Summary: end -------- 05:19:09 INFO - PROCESS | 2930 | 05:19:10 INFO - TEST-INFO | 2930: exit 0 05:19:10 INFO - TEST-OK | kraken | took 62435ms 05:19:10 INFO - SUITE-END | took 1173s 05:19:10 INFO - Completed test suite (00:19:33) 05:19:10 INFO - javascript benchmark 05:19:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7232.477548116289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.5748795168674, 3084.0747775667296, 3123.4377811993845, 3127.171299605605, 3129.6713845046256, 5280.894382112356, 5296.708681022542, 5348.171033489811, 5410.890767392685, 5429.158480435529, 5250.343707036621, 5326.147816349385, 5337.359516857973, 5364.141737322029, 5415.187721841716, 4801.6878902871285, 4818.25317075852, 4898.951010489885, 4935.728534930596, 4975.701457912537, 685.6963513676399, 4863.975680121594, 4880.9755951220195, 4905.730184839832, 4944.159492886218, 4800.807967681289, 4833.419989601235, 4836.105320515699, 4848.636352273558, 4883.487233840449, 4770.260609605482, 4815.22956326986, 4877.585405240523, 4883.584895283905, 4910.361652985089, 4826.22780355145, 4864.100141473803, 4898.681585696954, 4908.4846091160625, 4917.0, 5405.135178371442, 5431.321084864392, 5450.291462109901, 5453.836384908459, 5454.53636440903, 5618.0449323615085, 5728.0, 5775.566832487538, 5783.756492354164, 5804.187413762077, 5808.4191580842, 5840.328362238354, 5857.326407463153, 5858.384869588717, 5906.763729450817, 5424.891502169974, 5425.9186112208345, 5428.0500912340185, 5431.429699881534, 5435.0488664483555, 5744.937186620405, 5749.1663708762835, 5761.308642962871, 5912.290525136925, 5940.168376427304, 5623.634463759842, 5628.887422251532, 5629.605927585029, 5630.268065151504, 5657.51911087554, 5732.512736417451, 5745.511631511368, 5746.195532625436, 5747.568932330092, 5761.85595360111, 5601.719914004283, 5720.1991721159075, 5724.427557244326, 5742.684152371659, 5799.130130480377, 5539.9169012464845, 5657.773689052392, 5662.037453632893, 5704.686242256633, 5728.598998070179, 4351.499577548622, 4354.521002689701, 4392.516823149451, 4399.098184872094, 4418.270985287456, 3868.2650296443585, 3880.359740642819, 3917.216556688674, 3922.0783115967724, 3937.468441760383, 5531.0873705838085, 5541.445855414427, 5553.361363443175, 5572.275604171432, 5572.777088916479, 5818.738156782955, 5841.007028805113, 5851.561132915049, 5871.882562348815, 5926.466618004314, 5379.865503362369, 5395.81114660985, 5397.325334333208, 5420.864478388072, 5475.370332411744, 4767.427908650915, 4768.380110585602, 4773.9761301193275, 4785.138675038526, 4829.492903245179, 5806.0, 5948.196993405835, 5955.196048533393, 5955.851103722355, 5966.343702192756, 5805.361410244954, 5805.82582522525, 5824.15549745293, 5830.591858569859, 5865.3254875689845, 6007.8197654070445, 6048.848778780566, 6052.061930400795, 6067.089936509559, 6074.453299203093, 5525.585581081355, 5604.467575580314, 5714.02861513552, 5714.599978001666, 5737.56968227393, 5740.339860916049, 5809.419058094157, 5816.94183058164, 5818.0, 5877.206577112206, 5590.636608620427, 5637.0, 5641.492265696107, 5642.322921249476, 5644.379118296902, 5441.83674489766, 5606.523445507178, 5615.382307946041, 5620.044592419216, 5658.660480371191, 5364.892702146013, 5553.972230138824, 5557.41647127062, 5604.8318550443555, 5608.719564021864, 5629.0, 5656.37779844225, 5691.060974939089, 5717.514011309086, 5725.341585717696, 5397.298351214474, 5451.291332126798, 5502.0921547945745, 5568.554515638658, 5585.720713964204], "value": 5269.639257785604, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7560812262911, 618.8081694674651, 627.8179327994882, 646.3633321178638, 653.4772182254198, 42041.789791051044, 43394.34908476375, 43437.0, 46970.76514617422, 47024.76487617566, 45055.32417013747, 45385.0922981541, 45492.77253613735, 45496.54503454964, 45604.77197614015, 8828.293736501064, 8988.77528061797, 8989.0, 9008.189262966333, 9008.819823603524, 8816.515091669955, 8834.602442890053, 8845.4250473719, 8845.469271843678, 8895.466272023667, 8941.329400295004, 8964.282857371427, 8975.326850486239, 8992.23565996891, 9011.0, 8877.911220887838, 8903.688370907019, 8929.46423214606, 8966.103389661015, 8984.640614375417, 8669.869951950726, 8755.124487551258, 8756.518391488466, 8759.343049271267, 8769.605367758402, 41570.37644435336, 41985.58014419878, 42128.578714212774, 42140.57859421397, 42185.36721949173, 3589.3898037333715, 3628.9455658164884, 3735.5517337919623, 3770.7360484766077, 4037.394390841368, 31621.841890790627, 31702.207444813834, 31930.680693193004, 32266.35467290641, 33000.0, 4338.175746608134, 4400.273954797454, 4419.801108950105, 4481.9103617927785, 4515.119551687422, 365157.0, 371099.0, 372401.96593119384, 372527.0, 372974.0, 35407.29185416277, 56189.71905140448, 56406.0, 56411.0, 56658.0, 35624.0, 35648.108797279754, 35951.64048359535, 36043.279134417164, 36088.45867311992, 13987.930060349836, 14173.220472873885, 14184.574462766133, 14194.432222710975, 14260.42958281657, 11425.200235983568, 11452.198346115692, 11472.0, 11494.310341379543, 11499.942500287445, 8197.46716463428, 8208.794780130425, 8294.460860044077, 8369.62336694838, 8382.706605268786, 3245.140037889914, 3274.4773680238804, 3281.9005633113175, 3283.8029718216985, 3313.204830840581, 952.6570434643522, 958.1328897347911, 1029.3823705776624, 1038.3510306058713, 1130.745582244005, 30480.0, 33114.33771324608, 33195.83402082974, 33317.0, 33368.49947250793, 1126.5493802479075, 1169.1990986174499, 1187.3469591724518, 1188.7814989635692, 1249.3066348176667, 16662.58343541421, 16906.0, 17074.146292685316, 17157.75879197288, 17315.826841731672, 583048.0, 587085.0, 587907.0, 590500.0, 593363.0, 58103.70948145317, 58121.41878581245, 58385.0, 58621.413785862445, 58829.70585147047, 1258.5154715434442, 1304.2435387475432, 1372.6362513933816, 1374.5257886029303, 1377.5591810620506, 30520.0, 31305.8434707825, 31407.0, 32148.357032858745, 32503.837480812446, 51713.741431292605, 52389.0, 52438.737806310724, 52495.21257181222, 52691.20963185632, 498314.0, 506845.0, 511793.0, 512407.0, 512606.0, 43544.782276088416, 43616.0, 44297.77851110724, 44661.10677786491, 44802.0, 47893.0, 48618.0, 48746.5125348742, 49372.50627493679, 49435.0, 40370.59629403786, 40677.389839151845, 40764.0, 41570.58429415788, 42077.78961105175, 40089.799551002056, 40218.9945251371, 40337.39493907653, 40595.59404405918, 41163.794181028905, 39866.60133398629, 41061.38407923824, 42667.5733242676, 42689.359659605754, 45146.54853451424, 33143.17142071467, 36486.0, 36594.0, 38912.0, 39397.0, 27878.0, 28522.42955140927, 28591.14226573206, 28655.0, 28728.856355718923], "value": 19331.48188331925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.90226541099304, 377.4847333389924, 383.130294232093, 385.6163117697891, 391.49301654357606, 17555.0, 18922.14850331735, 18924.0, 19511.609767804654, 19552.217911283533, 17476.475705728848, 18170.727439088423, 19149.329773457932, 19412.611747765073, 19482.220711171572, 5158.7936482540745, 5280.841574752763, 5314.123169676998, 5353.518183363496, 5360.65155764876, 5269.367675878881, 5309.097453432906, 5322.600804939626, 5336.653117547347, 5345.599080068991, 5182.274481572583, 5280.841574752763, 5305.973470132644, 5306.044911915854, 5425.213344065108, 5665.0, 5738.42615738427, 5769.913451298234, 5793.0, 5806.854828629276, 5165.405978312505, 5175.120229560984, 5179.249008893689, 5181.35233095863, 5215.035218484554, 21708.0, 21798.455038624004, 22457.43856403603, 22602.20892268779, 22749.658755118686, 2315.444293369596, 2353.8587684738973, 2377.5720370333333, 2409.3013026222375, 2433.5376278507206, 10181.236407269484, 10197.694069177936, 10379.636712715019, 10391.324563903398, 10600.310979786367, 1957.148640341456, 2023.5649335392814, 2024.3724445421967, 2041.193728477258, 2083.4687154775434, 82952.17047829565, 83948.0, 83985.0, 84813.0, 85180.99999999937, 10711.83932241017, 10872.61945831892, 10975.615853445252, 10982.104232033234, 11216.270942388719, 14861.777073343908, 15136.621584460476, 15158.0, 15198.544043678707, 15255.542333730005, 7383.741569045165, 7483.13943896448, 7827.765167044998, 7902.0, 7931.167227441151, 7157.1769246537315, 7244.710211591478, 7270.527415717961, 7400.333969942731, 7470.514416562906, 4656.906861862812, 4678.064387122589, 4721.4570324413135, 4733.384659994179, 4771.33201351811, 1902.4482899959135, 1944.1834429539344, 1992.9302474413325, 2002.909869055896, 2021.5047313408015, 877.2630192219314, 914.8856392950881, 1014.700663304327, 1038.2939601071344, 1062.516554967488, 18538.629227415648, 18575.81424185741, 18873.339433119774, 19121.52196195106, 19501.414957551297, 908.2143945487106, 981.0630847540582, 983.8130755156498, 985.4629227071264, 1026.820306446369, 10328.225383096147, 10728.89271107279, 10749.462526873625, 10765.192610554239, 10792.273236282157, 496681.0, 519757.0, 522851.0, 526858.0, 536772.0, 81931.0, 93890.0, 95636.0, 95685.71870586544, 100068.0, 983.9065288797552, 1013.1793247469574, 1027.8766548014287, 1032.896710328961, 1045.508610952866, 17209.106998229934, 17516.0, 17588.29646814164, 17632.118394080502, 17745.29018839232, 30632.387352253278, 31151.68848311488, 40951.18097637971, 42295.0, 44731.776341118086, 54795.726021371236, 56801.431985681265, 59294.70352648209, 60013.09980350211, 60213.0, 7641.961790191013, 8670.436421632827, 8871.467711937305, 8938.37431379797, 8968.05835387275, 12430.875691242973, 13748.518801842287, 14035.157890526601, 14054.367553460323, 14344.713105737617, 11756.882431175922, 11927.0, 11968.521259149536, 12355.382230888239, 12696.492140314283, 12357.32034738098, 12399.13206075566, 12439.880410763075, 12633.747325053631, 12678.429470673658, 12171.391430428266, 12310.630681079581, 12337.198082124632, 12586.622401327975, 12685.746285074063, 7493.100827900686, 7903.525788452711, 7960.0, 8014.519128852287, 8073.919260807317, 8873.866891996497, 10524.842127367943, 10939.398333091756, 11167.329960202414, 12300.200486968319], "value": 9108.255515375657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.9709805803884, 1482.5774654223544, 1597.976030359545, 1747.1177055586927, 1750.7986581543119, 8066.4353495255355, 8461.703840365588, 8626.309895208384, 9161.358704890652, 9190.586423610928, 8577.957110214456, 8744.300455963523, 8755.343349248817, 8803.867941980876, 8888.777780555489, 2220.5336879255374, 2253.143805353963, 2261.2989973108306, 2283.474800795818, 2284.7258329000542, 2211.7124773779387, 2244.136007637055, 2286.6798648189265, 2288.187693368855, 2302.792748652621, 2251.9887400563057, 2252.7859853313907, 2267.8887345200815, 2293.0827668932475, 2295.173737454515, 2238.541099074686, 2257.16484900587, 2258.67249248858, 2259.7966183043604, 2259.807916327114, 2243.1588154442084, 2247.505548779266, 2252.2004688335733, 2263.6265016272296, 2269.909203631853, 8704.173103555153, 8864.335174861912, 8900.065493123258, 8900.465972041633, 8924.55377231136, 4980.676256043345, 5152.484751524855, 5152.613553983466, 5163.173892177271, 5175.663581867204, 3247.6102867655795, 3251.886183983549, 3361.46216605342, 3426.468897320919, 3446.293509830504, 1116.2242241641982, 1127.3912087472836, 1132.399828091113, 1154.591398493836, 1154.7113221694576, 12249.755004899942, 12422.130450868442, 12464.189827661174, 12498.687532811662, 12530.874691253062, 4548.272276435754, 4549.363089167519, 4631.305304204397, 4654.767261636973, 4659.207934651117, 10693.625723099654, 10700.197485188643, 10701.946490267499, 10703.518341674644, 10703.946480267548, 5127.66670166438, 5189.818356357509, 5193.2989046479, 5204.21936709489, 5208.348956380452, 4106.815193316308, 4556.65825063115, 4695.929561056587, 4727.57451829337, 4757.833475828399, 4016.256992456405, 4039.3537034074407, 4096.5903409659395, 4112.938305925413, 4140.648044916215, 1208.7159517513378, 1223.0887988448485, 1249.8375211222483, 1253.4547471849774, 1255.7927941889668, 944.367273926471, 1019.8215312320315, 1026.3328836256494, 1031.6698656429871, 1043.7703705185, 6021.397860213943, 6156.6921653917125, 6201.224846894138, 6239.688015599202, 6343.283582089508, 421.90085329947436, 432.9307310830315, 434.2552522424058, 438.0844035964785, 442.8095918754966, 4075.3479443289525, 4081.9795901020307, 4114.629683328515, 4127.422160897477, 4134.37984302357, 10811.35131892089, 11077.003069723763, 11182.776344473064, 11186.993170614684, 11276.210665253517, 11028.2280240384, 11046.502907369188, 11080.722981925517, 11084.612038578773, 11107.38909359993, 8137.104918458965, 8351.29014033814, 8360.289375403037, 8378.748637540763, 8398.748037558884, 5993.400659933972, 6113.113598528277, 6134.355892631388, 6154.507639388928, 6162.753489860355, 10440.791184176425, 10469.895301046892, 10472.162227021667, 10538.947305263424, 10617.362958222531, 10356.792864142524, 10508.527116279938, 10590.364578125336, 10679.839802402816, 10728.034476897117, 7232.168300645493, 7548.358389536951, 7815.452918295665, 7937.444378893422, 7968.2031796822175, 8799.780005499657, 8823.558822059, 8837.91162088371, 8866.822663546563, 8903.421277616933, 7334.596597187206, 7404.370628496638, 7525.435592330707, 7764.4953078052, 8032.558209298545, 7669.1947345527915, 7779.7666070017995, 7799.766007019798, 7900.920990790249, 8038.67845286182, 7068.0, 7069.858602828018, 7107.82230444243, 7125.35871771543, 7129.643517824192, 5075.7969681212335, 5154.0, 5267.947320526746, 5327.733613319396, 5377.435369286325, 5225.843224703265, 5248.212768084665, 5278.9472105278455, 5297.125974214211, 5346.518813306821], "value": 4570.125688320046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.77064898597496, 322.30864795014696, 328.59090432411654, 329.4794225124304, 333.6096766782864, 5401.405845357008, 5448.0, 5523.281973343464, 5538.363088244853, 5619.0, 5498.615096943216, 5549.278593782813, 5557.249771280876, 5564.527015203713, 5575.721213939297, 4294.205571969195, 4318.157959197958, 4340.0, 4340.262155433568, 4346.239408103585, 4072.839240816368, 4268.615824575788, 4276.647843685976, 4338.891527711817, 4352.7605981670995, 4208.831646734127, 4217.975371821528, 4229.661627069842, 4249.702520823544, 4252.829886804524, 4263.424437700902, 4268.914621707564, 4271.188474189925, 4306.5262821089655, 4311.568843115695, 3543.5747710274672, 3721.6650501455, 3748.100455890594, 3761.2101458693705, 3761.774293542396, 5419.83740487786, 5435.701036442994, 5444.210589464506, 5450.345958484968, 5451.781928722847, 4861.225652636797, 4898.338724272213, 4904.485029071931, 4905.2887331337115, 4926.901461970776, 5519.254900588449, 5760.683162426065, 5813.314138899714, 5825.679587622679, 5839.708014599253, 4051.2910240707756, 4055.7363771354767, 4062.8577999770164, 4067.0, 4076.32740597801, 5937.584369094208, 5945.613535120204, 6000.699965001776, 6038.63768173911, 6066.666333351708, 4087.51839932142, 4095.91808163841, 4155.480564929384, 4164.646005089541, 4182.372644103409, 4188.895277618023, 4215.494140703136, 4220.810063547147, 4222.662187025031, 4246.596573325529, 4854.757262136879, 4873.586659868598, 4875.829345972874, 4881.316615673809, 4885.291632713308, 5205.7917683293, 5842.532597392198, 5857.355690874, 5869.325027621793, 5888.499477544371, 1437.1951707044088, 1440.7118576284786, 1455.6142622205125, 1456.6504039030556, 1458.358322338168, 904.1184844776291, 915.9129882661136, 929.4469790474657, 929.8837645294338, 931.1386967055447, 4998.925016124761, 5042.629963916953, 5080.74596270185, 5119.8720031998755, 5142.537171654569, 5212.4266330703595, 5246.376811594203, 5290.603204759658, 5366.543843773245, 5369.3556773187465, 5010.847505073853, 5035.985605757653, 5060.544550990355, 5216.713080780593, 5698.17376480408, 3192.170035790711, 3246.805191688506, 3259.739220862373, 3264.9347013059605, 3268.624108227537, 5957.523398128139, 6244.781432649836, 6324.272708638566, 6328.7468501260355, 6340.841478963062, 6131.202943617302, 6151.108089327023, 6176.629402235881, 6179.3202747697715, 6218.160548326008, 6196.194494715748, 6227.96886015567, 6262.373762623702, 6266.905996410058, 6283.59156654816, 5734.340550836707, 5963.671998040149, 5989.431004054608, 5990.0, 6068.4841788448475, 5886.852828679317, 5939.4357536034, 5943.524518038633, 5970.910436343372, 6001.719346648246, 5957.463828255478, 6014.248218972629, 6171.413715697002, 6179.3820617937845, 6288.050704281687, 4210.59999300066, 4212.304969679968, 4223.93664095045, 4236.894077648083, 4242.787860606895, 5750.971245143747, 5877.529797616266, 6050.818475445743, 6085.208922840003, 6093.0, 5748.0, 5833.649981001154, 5844.678542680023, 5859.882802343844, 5862.765489380377, 5740.827775166752, 5781.913271300849, 5785.56608254391, 5797.797077102281, 5823.505002074871, 5620.241267428844, 5686.260786097946, 5703.20155178267, 5712.800051998326, 5735.799247026334, 5845.941540584539, 5916.55625828056, 5921.792737254175, 5932.288125424977, 5961.8807623846415, 5599.60802743804, 5692.715364231854, 5756.338021127456, 5802.390748971297, 5820.330661973927], "value": 4373.794374564167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7040648537344, 747.1221314954927, 750.2572453271262, 785.8153333966517, 841.1126261793809, 15037.699246015072, 15171.669962250582, 15703.450379236729, 16623.584410389733, 16747.33010679573, 13963.860361396382, 13997.160170389783, 14019.0, 14080.71838563228, 14135.71728565428, 796.6176235407008, 799.9920000800005, 803.9839203215961, 810.720301495983, 813.2680587471293, 814.5479259011246, 823.4647479138548, 824.7608193623842, 824.9340052795792, 825.8430898129366, 850.4514588090677, 856.6530555125184, 859.1365677494109, 861.5218553702692, 862.5730263519566, 853.6116067189445, 856.1481326080527, 856.4989481153501, 856.8671855862351, 856.9400141990063, 619.5322531488742, 620.4725982914487, 621.9689015549204, 626.6709977261928, 627.3475585391234, 16332.836671633251, 16429.0, 16554.751678724708, 16610.83389166105, 16643.91678041614, 14859.554213373616, 15286.566940538965, 15380.692386152326, 15441.613959651098, 15551.844481555152, 12401.0, 12496.270215432289, 12576.37118144089, 12613.243205407613, 12724.936375318157, 3805.1058001369656, 3821.2166505866508, 3836.1521359377325, 3877.2245550889934, 3927.0, 62844.0, 62966.37033629697, 63202.36797632011, 67340.3265967339, 84741.0, 11754.529818807152, 11917.106217033584, 11993.940030299793, 12123.636290911287, 12256.080793940311, 21640.783592164193, 21679.566408672054, 21729.130834766747, 21829.0, 22228.666570001464, 8233.0, 8481.0, 8531.360147988926, 8706.39055266138, 9105.681301154427, 4734.0058587696285, 4794.808207671724, 4843.4430040545785, 4959.330490383824, 5062.594992400599, 3461.44616861301, 3559.305935342635, 3584.874529391511, 3603.3694103531775, 3604.9639503605154, 629.4586655476287, 637.6365471681097, 643.1960049937578, 655.0665301944709, 658.8484648530865, 642.4795915308615, 685.7874059041714, 695.4957655699577, 727.912650481935, 728.7449392712614, 8544.273736732323, 9167.358284920125, 9274.536273186448, 9312.767180820534, 9375.34372593912, 688.7761477519726, 689.2005273882372, 690.2200513419804, 694.7776711452286, 704.503325155764, 4429.911401771947, 4467.195904737178, 4467.30756732707, 4535.795889184995, 4621.560951709582, 110288.0, 114522.42738786252, 130611.0, 134615.32692336474, 135265.0, 63958.0, 105324.0, 105611.0, 105634.47182764037, 105814.47092764487, 93540.0, 95794.52102739441, 96633.51683241679, 97595.51202243943, 97704.0, 9744.951275243862, 9794.00432103054, 9862.9561879629, 9863.082026086855, 9896.554655040396, 53250.4674953261, 53393.19910201428, 53944.0, 54957.72521137369, 55607.0, 75913.62043189749, 86625.02863859465, 87063.56468217618, 87349.0, 87785.0, 12888.48446062147, 13083.41124649374, 13303.334833258492, 13331.933340333237, 14155.292235388395, 14706.218763209332, 14837.703245934805, 14860.702785944437, 14949.25253737287, 15228.162451065298, 14283.500077497238, 14463.78304325457, 14673.633159171106, 14687.339069741674, 15142.697146056797, 14052.929735351257, 14329.355179017179, 14451.92774036123, 14503.1298122113, 14539.200343981183, 13378.197308161542, 13746.381412836246, 13746.862531374558, 13938.431042468621, 14333.56999290023, 10829.783404332027, 10857.457127143769, 11145.777084458428, 11189.608363707232, 11661.533538658698, 11277.661670149908, 11620.0, 11791.646250612495, 11801.0, 12118.636440906786], "value": 7716.350592649527, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 161.0, 192.0, 132.0, 154.0, 153.0, 127.0, 196.0, 138.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 165.0, 174.0, 166.0, 162.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 161.0, 76.0, 76.0, 76.0, 75.0, 160.0, 75.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 155.0, 85.0, 83.0, 84.0, 141.0, 86.0, 85.0, 149.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 56.0, 54.0, 57.0, 55.0, 56.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 80.0, 81.0, 81.0, 87.0, 80.0, 81.0, 107.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 124.0, 129.0, 128.0, 140.0, 133.0, 127.0, 141.0, 131.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 165.0, 158.0, 161.0, 173.0, 160.0, 163.0, 159.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 72.0, 68.0, 63.0, 62.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}]}]} 05:19:10 INFO - Return code: 0 05:19:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:19:10 ERROR - # TBPL SUCCESS # 05:19:10 INFO - Running post-action listener: _resource_record_post_action 05:19:10 INFO - ##### 05:19:10 INFO - ##### Finished run-tests step (success) 05:19:10 INFO - ##### 05:19:10 INFO - Running post-run listener: _resource_record_post_run 05:19:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 568426496; Read time: 0; Write time: 399876 05:19:10 INFO - TinderboxPrint: CPU usage
13.4% 05:19:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:19:10 INFO - TinderboxPrint: I/O write bytes / time
568,426,496 / 399,876 05:19:10 INFO - TinderboxPrint: CPU idle
8,227.3 (86.5%) 05:19:10 INFO - TinderboxPrint: CPU user
1,221.6 (12.8%) 05:19:10 INFO - TinderboxPrint: Swap in / out
0 / 0 05:19:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273166336; Read time: 0; Write time: 237772 05:19:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294674432; Read time: 0; Write time: 162092 05:19:11 INFO - Running post-run listener: _upload_blobber_files 05:19:11 INFO - Blob upload gear active. 05:19:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:19:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:19:11 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'] 05:19:11 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 05:19:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:14 INFO - (blobuploader) - INFO - Done attempting. 05:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:15 INFO - (blobuploader) - INFO - Done attempting. 05:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:16 INFO - (blobuploader) - INFO - Done attempting. 05:19:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:19:16 INFO - Return code: 0 05:19:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:19:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:19:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0727adbb8d056d05b246afa420eb37a6221519bc7603540b9cd7fa9268f4bea5b6ee3c7e65843751b73850eb2b20449dd53cf30526aa4d7d29f009b0a3b98491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e9694f347209d1b6065a4f9498bcab4201522ab4dead8e53b6875aaf6bfcd9587f79ea2b92ad45b46169b618a9de71498f13b65d9b165eb1c82622822d69d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd21fdd918f6f0842a904be3ebd2bf341093747629246f1927c99b45468c885b34ef69faef7547949e30ebc5d247c3cd23ed70a2a4d9fd721cd59c08789b9160"} 05:19:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:19:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:19:16 INFO - Contents: 05:19:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0727adbb8d056d05b246afa420eb37a6221519bc7603540b9cd7fa9268f4bea5b6ee3c7e65843751b73850eb2b20449dd53cf30526aa4d7d29f009b0a3b98491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e9694f347209d1b6065a4f9498bcab4201522ab4dead8e53b6875aaf6bfcd9587f79ea2b92ad45b46169b618a9de71498f13b65d9b165eb1c82622822d69d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd21fdd918f6f0842a904be3ebd2bf341093747629246f1927c99b45468c885b34ef69faef7547949e30ebc5d247c3cd23ed70a2a4d9fd721cd59c08789b9160"} 05:19:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:19:16 INFO - Copying logs to upload dir... 05:19:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:19:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.829286 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-22 05:19:15.921273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:19:15.924609) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0727adbb8d056d05b246afa420eb37a6221519bc7603540b9cd7fa9268f4bea5b6ee3c7e65843751b73850eb2b20449dd53cf30526aa4d7d29f009b0a3b98491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e9694f347209d1b6065a4f9498bcab4201522ab4dead8e53b6875aaf6bfcd9587f79ea2b92ad45b46169b618a9de71498f13b65d9b165eb1c82622822d69d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd21fdd918f6f0842a904be3ebd2bf341093747629246f1927c99b45468c885b34ef69faef7547949e30ebc5d247c3cd23ed70a2a4d9fd721cd59c08789b9160"} build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0727adbb8d056d05b246afa420eb37a6221519bc7603540b9cd7fa9268f4bea5b6ee3c7e65843751b73850eb2b20449dd53cf30526aa4d7d29f009b0a3b98491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e9694f347209d1b6065a4f9498bcab4201522ab4dead8e53b6875aaf6bfcd9587f79ea2b92ad45b46169b618a9de71498f13b65d9b165eb1c82622822d69d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd21fdd918f6f0842a904be3ebd2bf341093747629246f1927c99b45468c885b34ef69faef7547949e30ebc5d247c3cd23ed70a2a4d9fd721cd59c08789b9160"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:19:15.950933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:19:15.951350) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466595224.512864-378242722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:19:16.034482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:19:16.034902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:19:16.035282) ========= ========= Total master_lag: 0.18 =========