builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1466695996.68 results: success (0) buildid: 20160623053004 builduid: ec09f4010edb4e879ae2822395415733 revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.685175) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.686299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.687016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.705822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.706554) ========= 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=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 08:33:16-- 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% 60.9M=0s 2016-06-23 08:33:17 (60.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.851048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.851861) ========= 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=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015125 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.906186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:16.907077) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 08:33:17,157 truncating revision to first 12 chars 2016-06-23 08:33:17,157 Setting DEBUG logging. 2016-06-23 08:33:17,157 attempt 1/10 2016-06-23 08:33:17,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:33:17,470 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:17.570113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:17.570894) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:17.571894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:17.572609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:33:17.584239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-23 08:33:17.584606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:33:17 INFO - MultiFileLogger online at 20160623 08:33:17 in /builds/slave/test 08:33:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:33:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:33:17 INFO - {'append_to_log': False, 08:33:17 INFO - 'base_work_dir': '/builds/slave/test', 08:33:17 INFO - 'blob_upload_branch': 'Fx-Team', 08:33:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:33:17 INFO - 'branch': 'Fx-Team', 08:33:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:33:17 INFO - 'config_files': ('talos/linux_config.py',), 08:33:17 INFO - 'default_actions': ('clobber', 08:33:17 INFO - 'read-buildbot-config', 08:33:17 INFO - 'download-and-extract', 08:33:17 INFO - 'populate-webroot', 08:33:17 INFO - 'create-virtualenv', 08:33:17 INFO - 'install', 08:33:17 INFO - 'run-tests'), 08:33:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:33:17 INFO - 'download_minidump_stackwalk': True, 08:33:17 INFO - 'download_symbols': 'ondemand', 08:33:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:33:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:33:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:33:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:33:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:33:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:33:17 INFO - 'installer_path': 'installer.exe', 08:33:17 INFO - 'log_level': 'info', 08:33:17 INFO - 'log_name': 'talos', 08:33:17 INFO - 'log_to_console': True, 08:33:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:33:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:33:17 INFO - 'opt_config_files': (), 08:33:17 INFO - 'pip_index': False, 08:33:17 INFO - 'sps_profile': False, 08:33:17 INFO - 'sps_profile_interval': 0, 08:33:17 INFO - 'suite': 'dromaeojs', 08:33:17 INFO - 'system_bits': '32', 08:33:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:33:17 INFO - 'title': 'talos-linux64-ix-050', 08:33:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:33:17 INFO - 'use_talos_json': True, 08:33:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:33:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:33:17 INFO - 'work_dir': 'build'} 08:33:17 INFO - ##### 08:33:17 INFO - ##### Running clobber step. 08:33:17 INFO - ##### 08:33:17 INFO - Running pre-action listener: _resource_record_pre_action 08:33:17 INFO - Running main action method: clobber 08:33:17 INFO - rmtree: /builds/slave/test/build 08:33:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:33:18 INFO - Running post-action listener: _resource_record_post_action 08:33:18 INFO - ##### 08:33:18 INFO - ##### Finished clobber step (success) 08:33:18 INFO - ##### 08:33:18 INFO - ##### 08:33:18 INFO - ##### Running read-buildbot-config step. 08:33:18 INFO - ##### 08:33:18 INFO - Running pre-action listener: _resource_record_pre_action 08:33:18 INFO - Running main action method: read_buildbot_config 08:33:18 INFO - Using buildbot properties: 08:33:18 INFO - { 08:33:18 INFO - "project": "", 08:33:18 INFO - "product": "firefox", 08:33:18 INFO - "script_repo_revision": "production", 08:33:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:33:18 INFO - "repository": "", 08:33:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:33:18 INFO - "buildid": "20160623053004", 08:33:18 INFO - "pgo_build": "True", 08:33:18 INFO - "basedir": "/builds/slave/test", 08:33:18 INFO - "buildnumber": 208, 08:33:18 INFO - "slavename": "talos-linux64-ix-050", 08:33:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:33:18 INFO - "platform": "ubuntu64_hw", 08:33:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:33:18 INFO - "branch": "fx-team", 08:33:18 INFO - "repo_path": "integration/fx-team", 08:33:18 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 08:33:18 INFO - "stage_platform": "linux64-pgo", 08:33:18 INFO - "builduid": "ec09f4010edb4e879ae2822395415733", 08:33:18 INFO - "slavebuilddir": "test" 08:33:18 INFO - } 08:33:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:33:18 INFO - Running post-action listener: _resource_record_post_action 08:33:18 INFO - ##### 08:33:18 INFO - ##### Finished read-buildbot-config step (success) 08:33:18 INFO - ##### 08:33:18 INFO - ##### 08:33:18 INFO - ##### Running download-and-extract step. 08:33:18 INFO - ##### 08:33:18 INFO - Running pre-action listener: _resource_record_pre_action 08:33:18 INFO - Running main action method: download_and_extract 08:33:18 INFO - mkdir: /builds/slave/test/build/tests 08:33:18 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')]} 08:33:18 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:33:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:33:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:33:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:19 INFO - Downloaded 1361 bytes. 08:33:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:33:19 INFO - Using the following test package requirements: 08:33:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:33:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:33:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:33:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'jsshell-linux-x86_64.zip'], 08:33:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:33:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:33:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:33:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:33:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:33:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:33:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:19 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:33:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:33:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:33:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:20 INFO - Downloaded 24276007 bytes. 08:33:20 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'] 08:33:20 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 08:33:21 INFO - Return code: 0 08:33:21 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 08:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:21 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:22 INFO - Downloaded 24276007 bytes. 08:33:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:33:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:33:23 INFO - Return code: 0 08:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:23 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:24 INFO - Downloaded 14405384 bytes. 08:33:24 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'] 08:33:24 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 08:33:25 INFO - Return code: 0 08:33:25 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')]} 08:33:25 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:33:26 INFO - Downloaded 60160978 bytes. 08:33:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:33:26 INFO - mkdir: /builds/slave/test/properties 08:33:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:33:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:33:26 INFO - Contents: 08:33:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:33:27 INFO - Running post-action listener: _resource_record_post_action 08:33:27 INFO - Running post-action listener: set_extra_try_arguments 08:33:27 INFO - ##### 08:33:27 INFO - ##### Finished download-and-extract step (success) 08:33:27 INFO - ##### 08:33:27 INFO - ##### 08:33:27 INFO - ##### Running populate-webroot step. 08:33:27 INFO - ##### 08:33:27 INFO - Running pre-action listener: _resource_record_pre_action 08:33:27 INFO - Running main action method: populate_webroot 08:33:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:27 INFO - '--tppagecycles', 08:33:27 INFO - '7'], 08:33:27 INFO - 'tests': ['tsvgm']}}, 08:33:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:33:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:33:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:33:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['damp', 'tps']}, 08:33:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'tests': ['damp', 'tps']}, 08:33:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['dromaeo_dom']}, 08:33:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['basic_compositor_video']}, 08:33:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:33:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['a11yr', 08:33:27 INFO - 'ts_paint', 08:33:27 INFO - 'tpaint', 08:33:27 INFO - 'sessionrestore', 08:33:27 INFO - 'sessionrestore_no_auto_restore', 08:33:27 INFO - 'tabpaint']}, 08:33:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['tsvgx', 08:33:27 INFO - 'tsvgr_opacity', 08:33:27 INFO - 'tart', 08:33:27 INFO - 'tscrollx', 08:33:27 INFO - 'cart']}, 08:33:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:33:27 INFO - 'tsvgr_opacity', 08:33:27 INFO - 'tart', 08:33:27 INFO - 'tscrollx', 08:33:27 INFO - 'cart']}, 08:33:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'talos_options': ['--disable-e10s'], 08:33:27 INFO - 'tests': ['tp5o']}, 08:33:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'tests': ['tp5o']}, 08:33:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'talos_options': ['--disable-e10s', 08:33:27 INFO - '--xperf_path', 08:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:27 INFO - 'tests': ['tp5n']}, 08:33:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:27 INFO - 'talos_options': ['--xperf_path', 08:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:27 INFO - 'tests': ['tp5n']}}, 08:33:27 INFO - 'talos.zip': {'path': '', 08:33:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:27 INFO - Running post-action listener: _resource_record_post_action 08:33:27 INFO - ##### 08:33:27 INFO - ##### Finished populate-webroot step (success) 08:33:27 INFO - ##### 08:33:27 INFO - ##### 08:33:27 INFO - ##### Running create-virtualenv step. 08:33:27 INFO - ##### 08:33:27 INFO - Running pre-action listener: _resource_record_pre_action 08:33:27 INFO - Running main action method: create_virtualenv 08:33:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:33:27 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 08:33:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:33:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:27 INFO - Using real prefix '/usr' 08:33:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:33:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:29 INFO - Installing pip.................done. 08:33:29 INFO - Return code: 0 08:33:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:29 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:29 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 08:33:29 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 08:33:29 INFO - Using env: {'DISPLAY': ':0', 08:33:29 INFO - 'HOME': '/home/cltbld', 08:33:29 INFO - 'LANG': 'en_US.UTF-8', 08:33:29 INFO - 'LANGUAGE': 'en_US:en', 08:33:29 INFO - 'LOGNAME': 'cltbld', 08:33:29 INFO - 'MAIL': '/var/mail/cltbld', 08:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:29 INFO - 'MOZ_NO_REMOTE': '1', 08:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:29 INFO - 'NO_EM_RESTART': '1', 08:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:29 INFO - 'PWD': '/builds/slave/test', 08:33:29 INFO - 'SHELL': '/bin/bash', 08:33:29 INFO - 'SHLVL': '1', 08:33:29 INFO - 'TERM': 'linux', 08:33:29 INFO - 'TMOUT': '86400', 08:33:29 INFO - 'USER': 'cltbld', 08:33:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:29 INFO - '_': '/tools/buildbot/bin/python'} 08:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:30 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 08:33:30 INFO - Cleaning up... 08:33:30 INFO - Return code: 0 08:33:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:30 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 08:33:30 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 08:33:30 INFO - Using env: {'DISPLAY': ':0', 08:33:30 INFO - 'HOME': '/home/cltbld', 08:33:30 INFO - 'LANG': 'en_US.UTF-8', 08:33:30 INFO - 'LANGUAGE': 'en_US:en', 08:33:30 INFO - 'LOGNAME': 'cltbld', 08:33:30 INFO - 'MAIL': '/var/mail/cltbld', 08:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:30 INFO - 'MOZ_NO_REMOTE': '1', 08:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:30 INFO - 'NO_EM_RESTART': '1', 08:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:30 INFO - 'PWD': '/builds/slave/test', 08:33:30 INFO - 'SHELL': '/bin/bash', 08:33:30 INFO - 'SHLVL': '1', 08:33:30 INFO - 'TERM': 'linux', 08:33:30 INFO - 'TMOUT': '86400', 08:33:30 INFO - 'USER': 'cltbld', 08:33:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:30 INFO - '_': '/tools/buildbot/bin/python'} 08:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:30 INFO - Downloading/unpacking psutil>=3.1.1 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:32 INFO - Installing collected packages: psutil 08:33:32 INFO - Running setup.py install for psutil 08:33:32 INFO - building 'psutil._psutil_linux' extension 08:33:32 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 08:33:32 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 08:33:32 INFO - building 'psutil._psutil_posix' extension 08:33:32 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 08:33:32 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 08:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:32 INFO - Successfully installed psutil 08:33:32 INFO - Cleaning up... 08:33:32 INFO - Return code: 0 08:33:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:33:32 INFO - Using env: {'DISPLAY': ':0', 08:33:32 INFO - 'HOME': '/home/cltbld', 08:33:32 INFO - 'LANG': 'en_US.UTF-8', 08:33:32 INFO - 'LANGUAGE': 'en_US:en', 08:33:32 INFO - 'LOGNAME': 'cltbld', 08:33:32 INFO - 'MAIL': '/var/mail/cltbld', 08:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:32 INFO - 'MOZ_NO_REMOTE': '1', 08:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:32 INFO - 'NO_EM_RESTART': '1', 08:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:32 INFO - 'PWD': '/builds/slave/test', 08:33:32 INFO - 'SHELL': '/bin/bash', 08:33:32 INFO - 'SHLVL': '1', 08:33:32 INFO - 'TERM': 'linux', 08:33:32 INFO - 'TMOUT': '86400', 08:33:32 INFO - 'USER': 'cltbld', 08:33:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:32 INFO - '_': '/tools/buildbot/bin/python'} 08:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33:33 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 08:33:33 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 08:33:33 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 08:33:33 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 08:33:33 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 08:33:33 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 08:33:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:35 INFO - Installing collected packages: mozsystemmonitor 08:33:35 INFO - Running setup.py install for mozsystemmonitor 08:33:35 INFO - Successfully installed mozsystemmonitor 08:33:35 INFO - Cleaning up... 08:33:35 INFO - Return code: 0 08:33:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:33:35 INFO - Using env: {'DISPLAY': ':0', 08:33:35 INFO - 'HOME': '/home/cltbld', 08:33:35 INFO - 'LANG': 'en_US.UTF-8', 08:33:35 INFO - 'LANGUAGE': 'en_US:en', 08:33:35 INFO - 'LOGNAME': 'cltbld', 08:33:35 INFO - 'MAIL': '/var/mail/cltbld', 08:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:35 INFO - 'MOZ_NO_REMOTE': '1', 08:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:35 INFO - 'NO_EM_RESTART': '1', 08:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:35 INFO - 'PWD': '/builds/slave/test', 08:33:35 INFO - 'SHELL': '/bin/bash', 08:33:35 INFO - 'SHLVL': '1', 08:33:35 INFO - 'TERM': 'linux', 08:33:35 INFO - 'TMOUT': '86400', 08:33:35 INFO - 'USER': 'cltbld', 08:33:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:35 INFO - '_': '/tools/buildbot/bin/python'} 08:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:37 INFO - warning: no files found matching '*.txt' 08:33:37 INFO - no previously-included directories found matching 'build' 08:33:37 INFO - no previously-included directories found matching 'dist' 08:33:37 INFO - no previously-included directories found matching '.git*' 08:33:37 INFO - Installing collected packages: jsonschema, functools32 08:33:37 INFO - Running setup.py install for functools32 08:33:37 INFO - warning: no files found matching '*.txt' 08:33:37 INFO - no previously-included directories found matching 'build' 08:33:37 INFO - no previously-included directories found matching 'dist' 08:33:37 INFO - no previously-included directories found matching '.git*' 08:33:37 INFO - Successfully installed jsonschema functools32 08:33:37 INFO - Cleaning up... 08:33:37 INFO - Return code: 0 08:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:37 INFO - Using env: {'DISPLAY': ':0', 08:33:37 INFO - 'HOME': '/home/cltbld', 08:33:37 INFO - 'LANG': 'en_US.UTF-8', 08:33:37 INFO - 'LANGUAGE': 'en_US:en', 08:33:37 INFO - 'LOGNAME': 'cltbld', 08:33:37 INFO - 'MAIL': '/var/mail/cltbld', 08:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:37 INFO - 'MOZ_NO_REMOTE': '1', 08:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:37 INFO - 'NO_EM_RESTART': '1', 08:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:37 INFO - 'PWD': '/builds/slave/test', 08:33:37 INFO - 'SHELL': '/bin/bash', 08:33:37 INFO - 'SHLVL': '1', 08:33:37 INFO - 'TERM': 'linux', 08:33:37 INFO - 'TMOUT': '86400', 08:33:37 INFO - 'USER': 'cltbld', 08:33:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:37 INFO - '_': '/tools/buildbot/bin/python'} 08:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:38 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 08:33:38 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 08:33:38 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 08:33:38 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 08:33:38 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 08:33:38 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 08:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - Downloading docopt-0.6.1.tar.gz 08:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:40 INFO - Running setup.py install for blobuploader 08:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:40 INFO - Running setup.py install for requests 08:33:41 INFO - Running setup.py install for docopt 08:33:41 INFO - Successfully installed blobuploader requests docopt 08:33:41 INFO - Cleaning up... 08:33:41 INFO - Return code: 0 08:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:41 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:41 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 08:33:41 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 08:33:41 INFO - Using env: {'DISPLAY': ':0', 08:33:41 INFO - 'HOME': '/home/cltbld', 08:33:41 INFO - 'LANG': 'en_US.UTF-8', 08:33:41 INFO - 'LANGUAGE': 'en_US:en', 08:33:41 INFO - 'LOGNAME': 'cltbld', 08:33:41 INFO - 'MAIL': '/var/mail/cltbld', 08:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:41 INFO - 'MOZ_NO_REMOTE': '1', 08:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:41 INFO - 'NO_EM_RESTART': '1', 08:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:41 INFO - 'PWD': '/builds/slave/test', 08:33:41 INFO - 'SHELL': '/bin/bash', 08:33:41 INFO - 'SHLVL': '1', 08:33:41 INFO - 'TERM': 'linux', 08:33:41 INFO - 'TMOUT': '86400', 08:33:41 INFO - 'USER': 'cltbld', 08:33:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:41 INFO - '_': '/tools/buildbot/bin/python'} 08:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:41 INFO - Running setup.py (path:/tmp/pip-bnHoG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:41 INFO - Running setup.py (path:/tmp/pip-0iGQFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:41 INFO - Running setup.py (path:/tmp/pip-2haiAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:41 INFO - Running setup.py (path:/tmp/pip-qduKsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:41 INFO - Running setup.py (path:/tmp/pip-W2nGsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:41 INFO - Running setup.py (path:/tmp/pip-5XI9Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:41 INFO - Running setup.py (path:/tmp/pip-mtVjcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:42 INFO - Running setup.py (path:/tmp/pip-HnCdzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:42 INFO - Running setup.py (path:/tmp/pip-cGtMve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:42 INFO - Running setup.py (path:/tmp/pip-OblfMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:42 INFO - Running setup.py (path:/tmp/pip-IBmopk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:42 INFO - Running setup.py (path:/tmp/pip-xeWcbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:42 INFO - Running setup.py (path:/tmp/pip-ajKu0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:42 INFO - Running setup.py (path:/tmp/pip-TfZOep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:42 INFO - Running setup.py (path:/tmp/pip-rtnRTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:42 INFO - Running setup.py (path:/tmp/pip-LsDW4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:42 INFO - Running setup.py (path:/tmp/pip-pl4Rz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:42 INFO - Running setup.py install for manifestparser 08:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:42 INFO - Running setup.py install for mozcrash 08:33:43 INFO - Running setup.py install for mozdebug 08:33:43 INFO - Running setup.py install for mozdevice 08:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for mozfile 08:33:43 INFO - Running setup.py install for mozhttpd 08:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for mozinfo 08:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for mozInstall 08:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for mozleak 08:33:43 INFO - Running setup.py install for mozlog 08:33:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for moznetwork 08:33:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:43 INFO - Running setup.py install for mozprocess 08:33:44 INFO - Running setup.py install for mozprofile 08:33:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:44 INFO - Running setup.py install for mozrunner 08:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:44 INFO - Running setup.py install for mozscreenshot 08:33:44 INFO - Running setup.py install for moztest 08:33:44 INFO - Running setup.py install for mozversion 08:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:44 INFO - Cleaning up... 08:33:44 INFO - Return code: 0 08:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:44 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')]} 08:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:44 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')]} 08:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:44 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:44 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 08:33:44 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 08:33:44 INFO - Using env: {'DISPLAY': ':0', 08:33:44 INFO - 'HOME': '/home/cltbld', 08:33:44 INFO - 'LANG': 'en_US.UTF-8', 08:33:44 INFO - 'LANGUAGE': 'en_US:en', 08:33:44 INFO - 'LOGNAME': 'cltbld', 08:33:44 INFO - 'MAIL': '/var/mail/cltbld', 08:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:44 INFO - 'MOZ_NO_REMOTE': '1', 08:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:44 INFO - 'NO_EM_RESTART': '1', 08:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:44 INFO - 'PWD': '/builds/slave/test', 08:33:44 INFO - 'SHELL': '/bin/bash', 08:33:44 INFO - 'SHLVL': '1', 08:33:44 INFO - 'TERM': 'linux', 08:33:44 INFO - 'TMOUT': '86400', 08:33:44 INFO - 'USER': 'cltbld', 08:33:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:44 INFO - '_': '/tools/buildbot/bin/python'} 08:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:44 INFO - Running setup.py (path:/tmp/pip-xZJlDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:44 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)) 08:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:44 INFO - Running setup.py (path:/tmp/pip-ZKJQ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:44 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)) 08:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:44 INFO - Running setup.py (path:/tmp/pip-HrFiaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:45 INFO - Running setup.py (path:/tmp/pip-oJyxKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:45 INFO - Running setup.py (path:/tmp/pip-XRTYPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:45 INFO - Running setup.py (path:/tmp/pip-j0lNrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:45 INFO - Running setup.py (path:/tmp/pip-kPBmkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:45 INFO - Running setup.py (path:/tmp/pip-Dhi4j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:45 INFO - Running setup.py (path:/tmp/pip-P_A_T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:45 INFO - Running setup.py (path:/tmp/pip-mKw5V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:45 INFO - Running setup.py (path:/tmp/pip-6B3zD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:45 INFO - Running setup.py (path:/tmp/pip-YU8MIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:45 INFO - Running setup.py (path:/tmp/pip-uHLJbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:45 INFO - Running setup.py (path:/tmp/pip-SJcUO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:45 INFO - Running setup.py (path:/tmp/pip-nDqZAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:45 INFO - Running setup.py (path:/tmp/pip-0A4npF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:45 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)) 08:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:45 INFO - Running setup.py (path:/tmp/pip-yzVvXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:46 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)) 08:33:46 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)) 08:33:46 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)) 08:33:46 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)) 08:33:46 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)) 08:33:46 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)) 08:33:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:47 INFO - Downloading blessings-1.6.tar.gz 08:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:48 INFO - Installing collected packages: blessings 08:33:48 INFO - Running setup.py install for blessings 08:33:48 INFO - Successfully installed blessings 08:33:48 INFO - Cleaning up... 08:33:48 INFO - Return code: 0 08:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:48 INFO - Reading from file tmpfile_stdout 08:33:48 INFO - Current package versions: 08:33:48 INFO - argparse == 1.2.1 08:33:48 INFO - blessings == 1.6 08:33:48 INFO - blobuploader == 1.2.4 08:33:48 INFO - docopt == 0.6.1 08:33:48 INFO - functools32 == 3.2.3-2 08:33:48 INFO - jsonschema == 2.5.1 08:33:48 INFO - manifestparser == 1.1 08:33:48 INFO - mozInstall == 1.12 08:33:48 INFO - mozcrash == 0.17 08:33:48 INFO - mozdebug == 0.1 08:33:48 INFO - mozdevice == 0.48 08:33:48 INFO - mozfile == 1.2 08:33:48 INFO - mozhttpd == 0.7 08:33:48 INFO - mozinfo == 0.9 08:33:48 INFO - mozleak == 0.1 08:33:48 INFO - mozlog == 3.2 08:33:48 INFO - moznetwork == 0.27 08:33:48 INFO - mozprocess == 0.22 08:33:48 INFO - mozprofile == 0.28 08:33:48 INFO - mozrunner == 6.11 08:33:48 INFO - mozscreenshot == 0.1 08:33:48 INFO - mozsystemmonitor == 0.3 08:33:48 INFO - moztest == 0.7 08:33:48 INFO - mozversion == 1.4 08:33:48 INFO - psutil == 3.1.1 08:33:48 INFO - requests == 1.2.3 08:33:48 INFO - wsgiref == 0.1.2 08:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:48 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')]} 08:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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')]} 08:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:48 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 08:33:48 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 08:33:48 INFO - Using env: {'DISPLAY': ':0', 08:33:48 INFO - 'HOME': '/home/cltbld', 08:33:48 INFO - 'LANG': 'en_US.UTF-8', 08:33:48 INFO - 'LANGUAGE': 'en_US:en', 08:33:48 INFO - 'LOGNAME': 'cltbld', 08:33:48 INFO - 'MAIL': '/var/mail/cltbld', 08:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:48 INFO - 'MOZ_NO_REMOTE': '1', 08:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:48 INFO - 'NO_EM_RESTART': '1', 08:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:48 INFO - 'PWD': '/builds/slave/test', 08:33:48 INFO - 'SHELL': '/bin/bash', 08:33:48 INFO - 'SHLVL': '1', 08:33:48 INFO - 'TERM': 'linux', 08:33:48 INFO - 'TMOUT': '86400', 08:33:48 INFO - 'USER': 'cltbld', 08:33:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:48 INFO - '_': '/tools/buildbot/bin/python'} 08:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 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)) 08:33:48 INFO - Cleaning up... 08:33:48 INFO - Return code: 0 08:33:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:48 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')]} 08:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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')]} 08:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:48 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 08:33:48 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 08:33:48 INFO - Using env: {'DISPLAY': ':0', 08:33:48 INFO - 'HOME': '/home/cltbld', 08:33:48 INFO - 'LANG': 'en_US.UTF-8', 08:33:48 INFO - 'LANGUAGE': 'en_US:en', 08:33:48 INFO - 'LOGNAME': 'cltbld', 08:33:48 INFO - 'MAIL': '/var/mail/cltbld', 08:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:48 INFO - 'MOZ_NO_REMOTE': '1', 08:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:48 INFO - 'NO_EM_RESTART': '1', 08:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:48 INFO - 'PWD': '/builds/slave/test', 08:33:48 INFO - 'SHELL': '/bin/bash', 08:33:48 INFO - 'SHLVL': '1', 08:33:48 INFO - 'TERM': 'linux', 08:33:48 INFO - 'TMOUT': '86400', 08:33:48 INFO - 'USER': 'cltbld', 08:33:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:48 INFO - '_': '/tools/buildbot/bin/python'} 08:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:48 INFO - Cleaning up... 08:33:48 INFO - Return code: 0 08:33:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:33:48 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')]} 08:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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')]} 08:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:48 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 0x7f1253fc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', '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 08:33:48 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 08:33:48 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 08:33:48 INFO - Using env: {'DISPLAY': ':0', 08:33:48 INFO - 'HOME': '/home/cltbld', 08:33:48 INFO - 'LANG': 'en_US.UTF-8', 08:33:48 INFO - 'LANGUAGE': 'en_US:en', 08:33:48 INFO - 'LOGNAME': 'cltbld', 08:33:48 INFO - 'MAIL': '/var/mail/cltbld', 08:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:48 INFO - 'MOZ_NO_REMOTE': '1', 08:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:48 INFO - 'NO_EM_RESTART': '1', 08:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:48 INFO - 'PWD': '/builds/slave/test', 08:33:48 INFO - 'SHELL': '/bin/bash', 08:33:48 INFO - 'SHLVL': '1', 08:33:48 INFO - 'TERM': 'linux', 08:33:48 INFO - 'TMOUT': '86400', 08:33:48 INFO - 'USER': 'cltbld', 08:33:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:48 INFO - '_': '/tools/buildbot/bin/python'} 08:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:49 INFO - Downloading/unpacking flake8 08:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:50 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 08:33:50 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 08:33:50 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 08:33:50 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 08:33:50 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 08:33:50 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 08:33:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:51 INFO - no previously-included directories found matching 'docs/_build' 08:33:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:51 INFO - Running setup.py install for pep8 08:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:51 INFO - no previously-included directories found matching 'docs/_build' 08:33:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:33:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:51 INFO - Cleaning up... 08:33:51 INFO - Return code: 0 08:33:51 INFO - Running post-action listener: _resource_record_post_action 08:33:51 INFO - Running post-action listener: _start_resource_monitoring 08:33:51 INFO - Starting resource monitoring. 08:33:51 INFO - ##### 08:33:51 INFO - ##### Finished create-virtualenv step (success) 08:33:51 INFO - ##### 08:33:51 INFO - ##### 08:33:51 INFO - ##### Running install step. 08:33:51 INFO - ##### 08:33:51 INFO - Running pre-action listener: _resource_record_pre_action 08:33:51 INFO - Running main action method: install 08:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:52 INFO - Reading from file tmpfile_stdout 08:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:52 INFO - Reading from file tmpfile_stdout 08:33:52 INFO - Output received: 08:33:52 INFO - Usage: mozinstall [options] installer 08:33:52 INFO - Options: 08:33:52 INFO - -h, --help show this help message and exit 08:33:52 INFO - -d DEST, --destination=DEST 08:33:52 INFO - Directory to install application into. [default: 08:33:52 INFO - "/builds/slave/test"] 08:33:52 INFO - --app=APP Application being installed. [default: firefox] 08:33:52 INFO - mkdir: /builds/slave/test/build/application 08:33:52 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'] 08:33:52 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 08:34:09 INFO - Reading from file tmpfile_stdout 08:34:09 INFO - Output received: 08:34:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:34:09 INFO - Running post-action listener: _resource_record_post_action 08:34:09 INFO - ##### 08:34:09 INFO - ##### Finished install step (success) 08:34:09 INFO - ##### 08:34:09 INFO - ##### 08:34:09 INFO - ##### Running run-tests step. 08:34:09 INFO - ##### 08:34:09 INFO - Running pre-action listener: _resource_record_pre_action 08:34:09 INFO - Running main action method: run_tests 08:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:34:09 INFO - Python 2.7.3 08:34:09 INFO - Return code: 0 08:34:09 INFO - grabbing minidump binary from tooltool 08:34:09 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')]} 08:34:09 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 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:34:09 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 08:34:09 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 08:34:09 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 08:34:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:34:09 INFO - Return code: 0 08:34:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:34:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:34:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:34:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:34:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:34:10 INFO - Return code: 0 08:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:34:10 INFO - Using env: {'DISPLAY': ':0', 08:34:10 INFO - 'HOME': '/home/cltbld', 08:34:10 INFO - 'LANG': 'en_US.UTF-8', 08:34:10 INFO - 'LANGUAGE': 'en_US:en', 08:34:10 INFO - 'LOGNAME': 'cltbld', 08:34:10 INFO - 'MAIL': '/var/mail/cltbld', 08:34:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:34:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:10 INFO - 'MOZ_NO_REMOTE': '1', 08:34:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:10 INFO - 'NO_EM_RESTART': '1', 08:34:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:10 INFO - 'PWD': '/builds/slave/test', 08:34:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:34:10 INFO - 'SHELL': '/bin/bash', 08:34:10 INFO - 'SHLVL': '1', 08:34:10 INFO - 'TERM': 'linux', 08:34:10 INFO - 'TMOUT': '86400', 08:34:10 INFO - 'USER': 'cltbld', 08:34:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092', 08:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:10 INFO - '_': '/tools/buildbot/bin/python'} 08:34:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:34:10 INFO - mozversion application_buildid: 20160623053004 08:34:10 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:34:10 INFO - mozversion application_display_name: Nightly 08:34:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:34:10 INFO - mozversion application_name: Firefox 08:34:10 INFO - mozversion application_remotingname: firefox 08:34:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:34:10 INFO - mozversion application_vendor: Mozilla 08:34:10 INFO - mozversion application_version: 50.0a1 08:34:10 INFO - mozversion platform_buildid: 20160623053004 08:34:10 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:34:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:34:10 INFO - mozversion platform_version: 50.0a1 08:34:10 INFO - using testdate: 1466696050 08:34:10 INFO - actual date: 1466696050 08:34:10 INFO - starting webserver on 'localhost:37620' 08:34:10 INFO - SUITE-START | Running 2 tests 08:34:10 INFO - TEST-START | dromaeo_css 08:34:10 INFO - operating with platform_type : linux_ 08:34:10 INFO - Initialising browser for dromaeo_css test... 08:34:10 INFO - TEST-INFO | started process 7245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUfJ9x/profile http://localhost:37620/getInfo.html) 08:34:14 INFO - PROCESS | 7245 | __metrics Screen width/height:1600/1200 08:34:14 INFO - PROCESS | 7245 | colorDepth:24 08:34:14 INFO - PROCESS | 7245 | Browser inner width/height: 1024/697 08:34:14 INFO - PROCESS | 7245 | __metrics 08:34:15 INFO - PROCESS | 7245 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:16 INFO - TEST-INFO | 7245: exit 0 08:34:16 INFO - Browser initialized. 08:34:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:16 INFO - TEST-INFO | started process 7328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUfJ9x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:28 INFO - PROCESS | 7328 | RSS: Main: 173998080 08:34:28 INFO - PROCESS | 7328 | 08:35:19 INFO - PROCESS | 7328 | 1466696119853 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] 08:37:27 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37620/tests/dromaeo/cssquery-ext.html) 08:37:28 INFO - PROCESS | 7328 | RSS: Main: 274329600 08:37:28 INFO - PROCESS | 7328 | 08:40:30 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-ext.html (next: http://localhost:37620/tests/dromaeo/cssquery-jquery.html) 08:40:31 INFO - PROCESS | 7328 | RSS: Main: 258543616 08:40:31 INFO - PROCESS | 7328 | 08:43:33 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37620/tests/dromaeo/cssquery-mootools.html) 08:43:33 INFO - PROCESS | 7328 | RSS: Main: 264892416 08:43:33 INFO - PROCESS | 7328 | 08:46:35 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37620/tests/dromaeo/cssquery-prototype.html) 08:46:36 INFO - PROCESS | 7328 | RSS: Main: 255885312 08:46:36 INFO - PROCESS | 7328 | 08:49:39 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37620/tests/dromaeo/cssquery-yui.html) 08:49:39 INFO - PROCESS | 7328 | RSS: Main: 245280768 08:49:39 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | Cycle 1(1): loaded http://localhost:37620/tests/dromaeo/cssquery-yui.html (next: http://localhost:37620/tests/dromaeo/cssquery-dojo.html) 08:52:42 INFO - PROCESS | 7328 | RSS: Main: 290902016 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | __start_tp_report 08:52:42 INFO - PROCESS | 7328 | _x_x_mozilla_page_load 08:52:42 INFO - PROCESS | 7328 | _x_x_mozilla_page_load_details 08:52:42 INFO - PROCESS | 7328 | |i|pagename|runs| 08:52:42 INFO - PROCESS | 7328 | |0;dojo.html;3032.1206850013496;3057.2051266670674;3071.15543225613;3079.276370053036;3110.4245714542812;5082.4917508249155;5117.948820511794;5159.277701121846;5206.531412172903;5270.235815806705;5112.182050871861;5115.309433226514;5223.686578805275;5277.577793776498;5318.654287471311;4613.861584152481;4667.719936803803;4676.415448068991;4733.715977041371;4920.089783390066;4820.084184005028;4843.321934929113;4874.780634871439;4902.607791376681;4913.729744864031;4620.0297937433015;4654.138984287918;4670.743109128996;4674.3222232776225;4695.835645752416;4679.438467383901;4687.624990000826;4702.435707715062;4749.857504274877;4783.593394561466;4697.412823397075;4712.505186955389;4734.692245004098;4735.83424580138;4774.761261936924;5102.489751024905;5159.303494028333;5263.736813159365;5317.707526086064;5320.787168513255;5614.719264036782;5628.54971602275;5654.293213348332;5661.915071273934;5667.773289068432;5484.588655850787;5657.094864821609;5675.233843431167;5675.262215911946;5679.290088738908;5184.792608295664;5256.789728410859;5259.605529585297;5313.734313284321;5316.12283973144;5761;5787.739551720183;5788.0449725795615;5791.189233507313;5794.8551286217335;5349.063913815066;5409.783608655688;5563.276774019432;5589.441055894378;5595.38450770415;5550.888982220333;5603.635763675429;5630.268065151586;5664.716764161775;5666.688332141689;5589.413111623221;5606.803761868397;5610.074337734228;5611.494965453129;5615.18579805934;5357.651752636066;5451;5511.641743286674;5611.2144299798065;5611.961787069406;4225.704200705921;4229.450171477688;4262.552431994658;4288.721233119837;4288.849890253826;3802.1065049713297;3818.503594532693;3832.48261484696;3851.114243723959;3870.1679138985255;5106.310648062538;5130.948690513047;5173;5200.713960732196;5203.661761985459;5497.615166938276;5498.862528436821;5516.696581687966;5545.223668686387;5580.748866301026;5122.206058061007;5148.56237219833;5164.354455693038;5165.819196328111;5211.583073354198;4682.976585117052;4757.857264282077;4810.158222311082;4821.156297647897;4848.587870031016;5686.488216060575;5726.284214473191;5786.913196302059;5789.710514474344;5794.536437085023;5444.8094316698725;5668.121441176624;5686.374498805211;5692.117721753135;5735.996200664784;5640.182173584889;5713.457221563945;5717.571182161271;5745.626534275259;5764.3371012332445;5517.641353312022;5542.002439560918;5552.555795536428;5553.416891226363;5564.998300305984;5385.946140538545;5643.040683083967;5643.858903527444;5649.067903795992;5656.208130861601;5541.972290138524;5560.91658625129;5568.972155139199;5570.86072848182;5614.85962850932;5532.336119665666;5543.833684989457;5545.833624991256;5546.528545073714;5548.945700316927;5041.344625198701;5284.577233821362;5284.682919024717;5467.753951072291;5529.474699903502;5506.2291279221745;5565.220869078414;5571.498565129158;5575.637583557056;5579.776808927598;5347.117725575392;5356.866078348073;5387.515123638891;5395.028894798974;5397.082495975615 08:52:42 INFO - PROCESS | 7328 | |1;ext.html;557.1519018165882;581.6277582347298;591.8106206014074;594.7472324262187;599.3407252022776;29462.116136515913;36620;37284.440733388954;37598.62401375985;37600.623993760055;38760.22479550407;39031.414528782094;39123.60876391235;39202.8039859801;39216.607833921655;8435.114312997124;8629.69796057135;8630;8632.482051076924;8678.566071696421;8462.069172391031;8548.743537693848;8564.785880352978;8565.914340856574;8571.571421428935;8550.657973681045;8594.09761974993;8606.612702428374;8610.827783444327;8612.956935215316;8588.441751286178;8624.611892464854;8644.092370301121;8645.567721613894;8646.178613031783;8459.95770021152;8507.404481686284;8513.063563008063;8523.14768523149;8526.360522960802;36002.45996310058;36028.27943441117;36079.63920360815;36109.916702498704;36286.45570316447;3175.7776955613117;3197.2486465680545;3284.6715328467203;3422.366862130489;3678.4666223397726;28418.005369812163;29632.851835740683;29802.40395192084;29954.85022574873;30214;4251.914961700749;4406;4419.692051106423;4453.398791163184;4523.185826551219;332348;335959;337582;338037;338300;48597;48978.26532602014;49019.26471102936;49031.754841225564;49066.264006039935;45652.771736141105;50221.49778502241;51098;51350.22974655383;54799.17801232905;14802.851971480148;14990.700185996218;15028.323725432381;15049.849501505063;15057.698846023019;11628.476718547685;11688.123390745728;11696.122790790725;11700.239484433485;11709.355985420883;14315.856841431452;15372.154531500875;15737.055776653437;15744;16178.382161783962;5935.198748168942;5959.344472108065;5966.373530779292;6046.788362407295;6048.939510604838;818.7625588579245;868.4008034456205;933.421278807144;934.4159900062461;1010.9536629588341;28238;28539.286517836805;28735;29367.412651747272;29456.705432945397;936.6862101196176;956.5173980330599;969.9272554558436;990.2820455170088;999.8550210219478;14494.637634059021;15140.470083547023;15152.242387880562;15418.768718469231;15505.689886202214;157424;157640;158360;158528;158562;46619.766901165276;47272.52727472681;47318.52681473141;47330.5266947333;47334.28998565024;1148.2249481600054;1156.2946602572424;1197.4372045138946;1210.4371467267588;1219.439058033297;26995.190144295702;28103.43793124167;28286.79290508153;28545;28747.568786468637;42420.78789606032;42737.358939616555;42812.143757125305;42895.356569652104;42907.78546107374;432530;435809;435847;435963;436259;23112.653310200025;24545.263642090766;25222.74777252204;25298.241052768448;25782.742172578033;40307.1938561233;40682.18635627212;40748.1850362997;40956.79521602373;41328;31907.840460797546;32588.348233035682;32789.54078444078;32863.507047394785;33121.668783311856;35421.291574168885;35503.64496355003;35665.21673916242;35867.461988070725;35974.460383094796;35220.119497012776;35222.47166292457;35494.64505354913;35501;35632.64367356293;31895.840520797246;32322.83838580792;32711.836440818595;32772.50841237431;32898.83550582232;24857;25084.122055727963;25152.49695006126;25328.11351602685;25553 08:52:42 INFO - PROCESS | 7328 | |2;jquery.html;364.6171519904101;364.762904112327;369.7245552063711;377.38863041872173;384.73453317211124;17040;18097.37588049732;18206;18494.352697655584;18503.722444163348;15541.52355526226;16498;16853.747193792104;16904.83095169048;16938.915305423456;4931.408231012275;5121.590272778188;5154.896902061956;5158.0199762045095;5163.096458119833;3753.174301653632;4553.203189441851;5061.569766569827;6008.639481631116;6021.909671354912;6025.548083893704;6038.33578306386;6053;6066.726997285111;6066.939330606681;5480.150576660624;5585.134304182818;5609.411011843738;5612.550995920337;6021.036634138539;5422.1053526168525;5424.887897980904;5427.511523962823;5430.049741295257;5448.128299472065;12301.692457688629;12581.685457863536;12619.810702839464;12638.810417843739;12643.17819341749;2173.8695678259355;2305.8155347572156;2323.744388117306;2679.303381120903;2710.2953232159584;9199.67801126964;9287.674931377436;9364.765880852965;9743.610255589769;9761.658341957997;1857.4706208730581;1865.0767869904348;1931.3626503254034;1982.6431242376366;1983.1968052938582;78198;78484.60757696175;78982.60508697477;80114;80986.95065246715;10309.07218350352;10451.372917624967;10485;10580.312279701795;10666.786664266827;14673.92663036678;14741.484048058266;14753.483628072965;14784.334704938303;14790.704185916222;7441.888371674429;7647.426443016796;7693.884591731128;7774.105977812511;7828.412869034732;7320.084989376328;7379.225181355988;7549.6225188740345;7554.357879580297;7558.546487210785;4117.423560701504;4135.60711732385;4363.47638283408;4522;4587.357769912215;1701.5831121375343;1795.739617755418;1801.9909900450414;1809.1587411853552;1885.820847019531;808.3290868579182;816.8243827577099;850.4302117581235;888.6045709659139;906.243286855483;17171.742423863652;17423.825761742475;17783.19975601101;18093.36673216431;18258.178381972844;857.4598003257908;878.2534845381502;886.1714297132202;919.1681528216974;924.7225832250298;9532.809343813085;9613.90386096144;10072.244581656405;10105.090541851268;10212.8765835758;496261;504892;512216;514122;515978;88014.55992719995;90745.54627226821;92553.5372323134;94401.5839762404;94587.52706236563;849.0999540487103;882.8278485695356;885.2386947225381;896.4442045931564;909.2453263791037;15919.761203582188;16013.119278439797;16111.919440403191;16112.838871611602;16193.67612647764;39156.80421597874;40265.79867100646;42488.78755606202;43391;43551.12897741964;59660.403395965484;60020.699896500235;60115;60733.69633151806;61143;8086.636101375335;8257.174282571696;8342.040665323566;8416.36877234222;8419.8737018946;13562.86437135616;13996.230207338695;14034.228117453638;14142.575722728334;14196.36116374745;12026.15816892809;12241.816372754594;12441.751164976831;12609.30648814324;12641.87358126407;11314.60398886035;11780.469878855301;11911.52353905834;12367.75264494723;12376.381180941096;12365.876341236832;12529.874701252871;12543.623691289276;12685.682857928625;12778.297193654438;7451.18037015917;7496.512726672749;7586.544807311579;7815.2184781523665;9215.723528294162;10827.350358978487;11579.8263026053;11626.767464650491;11629.18595698293;11692.532298707956 08:52:42 INFO - PROCESS | 7328 | |3;mootools.html;1095.7479779650675;1205.8432403787506;1211.388248934288;1240.0699475393455;1386.826646669167;7666.501677390966;7999.760007199779;8031.598420078994;8192.262696357328;8201.466904651208;7914.28771410573;8086.433949623529;8088.069871964726;8097.392695547843;8150.470219435732;1901.7622797150357;2129.691194776756;2192.7807219278066;2214.601371753092;2242.6972358731527;2262.875541845198;2270.2848602690183;2270.965935510969;2271.7728227177317;2273.6362182050875;2225.688403623494;2226.265332440291;2243.741969673492;2257.413072601127;2271.7273927128686;1823.6626224148574;2127.0428307261795;2191.824654027674;2206.7793220677963;2212.203606701586;2218.556288742258;2240.7199100112484;2248.7413947396094;2256.0975609756065;2257.3115199864037;8300.12848650889;8437.451565648213;8438.113998030241;8442.240198382175;8444.873326900102;4865.5134486551415;4996.200607902718;4997.675151115202;5028.949710502921;5037.798488060474;3102.4105419970133;3282.9343413131605;3319.551860498826;3331.750118741104;3375.2280052972387;1031.865857438528;1050.196599601298;1054.3726482742757;1088.1892989722628;1090.6891535912227;12048.096392770578;12049.096317776202;12083.879161208451;12084.214526055779;12121.212121212093;4260.786960651955;4359.324304732771;4442.244818380883;4447.110577884436;4476.037651904856;9596.280278978966;9599.376040557481;9611.375260608038;9612;9625.807483850283;4986.650934434628;5006.274090256892;5011.899762004739;5024.648274620815;5027.673201241908;3819.102510909934;4444.31113177458;4642.907141857144;4647.907041859144;4686.133065382915;3670.853165873335;3730.552333719971;3820.7134464915243;3824.4263360496147;3842.731008829411;1221.1757063981777;1226.4726167747776;1241.3110723548336;1242.9937850310691;1249;817.8732296494053;877.3507604372718;880.423322723617;890.25663570919;901.008890220765;5573.136163894522;5678.886422271531;5689;5723.084306511021;5976.85057873548;826.7478419082238;831.7837362285728;854.4275335525213;857.1342943626858;905.6105874473908;3973.980130099331;3985.222881538072;3989.3816458448987;4088.856890008895;4133.400656904732;10208.693739187836;10385.63650272237;10516.842247366296;10518.368897866152;10537.104346130665;10280.794384112276;10340.586376544854;10385.376877387382;10398.792024159475;10432.113270371952;7353.485256032026;7641.159472458136;7647.388208943383;7652.617369131521;7737.497062690907;5601.8945531596655;5659.490645841894;5803.100519419497;5871.823845284648;5912.201852749996;9414.811703765748;9814.460204688525;9960.50197490108;9974.102330790263;10049.045340692623;10038.849417258602;10074.54664540112;10149.64476243328;10263.281570290008;10283.12593429567;7352.5220860643885;7398.667059982421;7421.7031318748805;7461.141968673455;7469.514481558681;7853.725119620786;7858.214178582096;7864.764057078297;7866.567338796421;7905.802354940943;7043.6830342633675;7044.5068845182395;7135.8572828544175;7183.676734546853;7329.706811727685;7000.194977577644;7005.159380874327;7040.964795175992;7112.288771122846;7180.425565954815;6472.223333200046;6490.253620833476;6539.6403197824575;6546.672666366758;6550.115734375989;4802.495737947465;4804.903901922012;4938.407391113089;5029.723365214948;5067.214581739836;4958.132326842716;4969.527894849984;4998.6750861193905;5086.830029093256;5144.562712169358 08:52:42 INFO - PROCESS | 7328 | |4;prototype.html;298.6207516454102;303.1118821851974;311.2483352703222;314.488955447398;314.5816064634037;5319.707416092114;5326.334208223972;5360.705161216141;5372.382176049756;5397.865053373663;4957.429895562012;5067.797288108481;5170.612204084689;5194.766235519402;5287.28621636079;4044.9191016179657;4052;4094.303968325392;4096.692748043901;4096.815643296044;4085.8569950051756;4091.529474110486;4096.365063415175;4098.3401722302515;4100;3769.6607305342513;3869.4776205212356;3972.6027397260186;4005.719599628027;4061.208064427438;3992.8203230854683;4021.155557332964;4033.838646454138;4072.165206132736;4077.5718549552316;3568.8750893718593;3582.4805403216387;3587.910302242439;3589.4974703541525;3592.940082675617;4843.539863712942;5129.563987061104;5137.895352499193;5163.7159956202395;5197.948020519784;4590.173768721629;4600.148972440109;4621.399218101659;4653.837115700934;4660.86017419478;5463.672179669193;5493.23094766733;5500.80747173847;5513.338399392099;5517.475839795253;3668.413053911388;3872.1287710264965;3879.866073659476;3884.3396622574232;3895.590962948878;5723.427657234285;5731.111677689923;5734.16854556087;5748.425157484218;5768.250127483442;3922.9800251934703;3923.6664883485223;3927.626875446828;3929.351656976567;3933.1347103637154;3780.3006443807435;3952.130531283113;3977.1506249594077;3977.7414468059483;3982.6415622594104;4538.1831270370985;4545.8636240912165;4553.383548840114;4562.794674239601;4565.429321334833;5514.786746915672;5519.2824932758485;5532.2531458253425;5537.529310008695;5539.2522009529;1346.3672074125145;1361.8161548191065;1373.4231622718482;1377.6762460821699;1381.3093453273364;859.5358506406595;859.9465654573098;872.616048938465;879.5382424227332;883.1830556735123;4696.671233013724;4755.096531658974;4775;4780.856574302777;4801;5025.296458495814;5034.773435195351;5068.074131829955;5119.667221630657;5124.359455068116;4489.483709373399;4824.614030877521;4827.565519103297;4828.199644206352;4833.347498087784;2688.892444302206;2704.0265504418394;2711.91864244073;2711.986440067787;2714.3763076292976;5106.872328191751;5123.385193776696;5124.256982737482;5168.8966220675375;5171.97414012935;4775.331453596499;5146.202338637517;5152.458991805806;5154.484551544815;5181.274621552986;5113.821016264487;5164.690118592821;5170.638055336166;5200.5059519345605;5222.294990176353;4957.851264462072;4993.575546078624;5014.598832093497;5025.547700706954;5033.219850923113;4811.735354555533;4924.261360795909;4982.775775090202;5011.223260394645;5096.51583099605;5169.276301317894;5191.896162076813;5216.40011398694;5224.50367215114;5241.877039798887;3590.37168495507;3603.747737658444;3603.9099022524647;3607.4747676625943;3608.7654302470255;5422.5119739223655;5431.782728690966;5615.8876822464135;5678.290213723285;5686.800961966312;5488.341399032141;5529.751161197675;5551.333839939233;5598.412166722435;5609.298837645294;5335.813246536352;5583.2642005417865;5593.8321850344555;5612.186232996111;5668.149777533403;5492.313460817398;5516.393196748274;5525.64621667694;5531.861703457284;5567.55459563242;5598.384177740364;5620.381758006534;5624.240727501735;5631.071842641885;5632.5775566831835;5169.7673604687125;5509.972450137724;5514.145307477347;5517.531009864207;5519.66881987066 08:52:42 INFO - PROCESS | 7328 | |5;yui.html;557.2838902010917;559.602682095712;611.688039100059;634.1249076274742;649.8050584824555;12367.505299788008;13082.934585327084;13250.933745331273;13335.133216340942;13339.799903001438;12591.370431478435;12862.356882155902;12877.871221287784;12877.935610321958;12895.29075900825;494.57466578742253;497.5621453121257;505.300159279397;570.0594019867211;591.3672370563498;599.5892813422819;599.6072572465042;600.6996501749126;600.8918394688955;601.4917394801386;623.5666211982674;625.109219362409;625.906114082889;626.2672672972633;626.6929204689692;518.2200787814334;600.9669468179248;602.7167231401235;623.6507555768784;624.2041397218537;453.23629683982597;455.00127220750466;455.12615777706884;455.6354916067133;455.6901307111163;12344.876551234462;12362.814557781641;12380.442880070328;12393.380330983415;12397;12586.118971671987;12957.22256664603;13066.803997940038;13407.195568265935;13427.798583021262;11799.469023893946;11809.822852657217;11888.821667674993;11974.22167559106;12225.449854756558;3708.091517578184;3735.1782607826235;3829.923401531954;3925.8429662813455;4265.786710664454;75049.62475187589;75539.62230188868;75640;75949.62025189894;77133;9887.406755594688;10048;10213.489325533694;10248.795024099476;10279.229057820694;16735.91216570919;16993;17026.659466810594;17041.82958170427;17117.22972466217;7634;7669.616519174019;7678.347340476011;7713.8457230855065;7734.187910269453;4597.264437689953;4664.253719404946;4752.928706069411;4797.424309082932;4923.606111511071;3085.460044492205;3172.2228054126886;3174.412733644237;3176.7140957313954;3177.3645270945904;521.4889408379734;530.5092789170002;532.547334765454;532.9040772660958;536.5653820405485;500.86226287770427;563.5278822721045;563.9172788246576;597.5936363272929;613.6164896939413;8495.781494357034;8858.291336693179;8938.50838203892;9007.504587247764;9034.548272586344;567.9943200568024;614.7848253111375;615.1725928625991;616.1281786272374;630.3601844128214;4274.893127671771;4339.82640694375;4396.274614688605;4414.183376075436;4453.287474004143;113275;113955;115014;121211.39394302972;121568;93280;94529;95984.52007739917;97960.51019744856;99253;66421.66789166024;88534;90720.5463972676;90755.54622226847;91938;8227.177282271725;8410.369222308229;8532.573371331533;8539.786505337417;8583.141685831368;51139.23291150561;51602.48397515977;52088;53029;53340.46659533355;74681;75257.6237118811;75958.62020689862;77102.61448692721;77968;10269.281150319406;10286;10315.948420257851;10498.265121441731;10886.61896833607;11903.46434410471;12147.088968327587;12300.630981070582;12337.50649973991;12403.689907752378;11430.085593152695;11459.48432320531;11601.535938562363;11664.825027624762;11773.882261177621;10751.569937202425;10975.50610222526;11227.382493962583;11355.489002995051;11425.485853136795;10232.795344092927;10354.430506322225;10432.374057556268;10437.530311136168;10497.737556561147;9596.856047159437;9611.759706007406;9648.228141748783;9893.210756698261;9903.900960990586;9477.95261023718;9847.950760246153;10090.495475226357;10950.507227174638;11239.325640461599 08:52:42 INFO - PROCESS | 7328 | __end_tp_report 08:52:42 INFO - PROCESS | 7328 | __start_cc_report 08:52:42 INFO - PROCESS | 7328 | _x_x_mozilla_cycle_collect,827 08:52:42 INFO - PROCESS | 7328 | __end_cc_report 08:52:42 INFO - PROCESS | 7328 | __startTimestamp1466697162337__endTimestamp 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | ------- Summary: start ------- 08:52:42 INFO - PROCESS | 7328 | Number of tests: 6 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#0] dojo.html Cycles:165 Average:5191.59 Median:5385.95 stddev:592.63 (11.0%) stddev-sans-first:569.72 08:52:42 INFO - PROCESS | 7328 | Values: 3032.1 3057.2 3071.2 3079.3 3110.4 5082.5 5117.9 5159.3 5206.5 5270.2 5112.2 5115.3 5223.7 5277.6 5318.7 4613.9 4667.7 4676.4 4733.7 4920.1 4820.1 4843.3 4874.8 4902.6 4913.7 4620.0 4654.1 4670.7 4674.3 4695.8 4679.4 4687.6 4702.4 4749.9 4783.6 4697.4 4712.5 4734.7 4735.8 4774.8 5102.5 5159.3 5263.7 5317.7 5320.8 5614.7 5628.5 5654.3 5661.9 5667.8 5484.6 5657.1 5675.2 5675.3 5679.3 5184.8 5256.8 5259.6 5313.7 5316.1 5761.0 5787.7 5788.0 5791.2 5794.9 5349.1 5409.8 5563.3 5589.4 5595.4 5550.9 5603.6 5630.3 5664.7 5666.7 5589.4 5606.8 5610.1 5611.5 5615.2 5357.7 5451.0 5511.6 5611.2 5612.0 4225.7 4229.5 4262.6 4288.7 4288.8 3802.1 3818.5 3832.5 3851.1 3870.2 5106.3 5130.9 5173.0 5200.7 5203.7 5497.6 5498.9 5516.7 5545.2 5580.7 5122.2 5148.6 5164.4 5165.8 5211.6 4683.0 4757.9 4810.2 4821.2 4848.6 5686.5 5726.3 5786.9 5789.7 5794.5 5444.8 5668.1 5686.4 5692.1 5736.0 5640.2 5713.5 5717.6 5745.6 5764.3 5517.6 5542.0 5552.6 5553.4 5565.0 5385.9 5643.0 5643.9 5649.1 5656.2 5542.0 5560.9 5569.0 5570.9 5614.9 5532.3 5543.8 5545.8 5546.5 5548.9 5041.3 5284.6 5284.7 5467.8 5529.5 5506.2 5565.2 5571.5 5575.6 5579.8 5347.1 5356.9 5387.5 5395.0 5397.1 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#1] ext.html Cycles:180 Average:46151.21 Median:36453.23 stddev:87718.44 (240.6%) stddev-sans-first:87897.72 08:52:42 INFO - PROCESS | 7328 | Values: 557.2 581.6 591.8 594.7 599.3 29462.1 36620.0 37284.4 37598.6 37600.6 38760.2 39031.4 39123.6 39202.8 39216.6 8435.1 8629.7 8630.0 8632.5 8678.6 8462.1 8548.7 8564.8 8565.9 8571.6 8550.7 8594.1 8606.6 8610.8 8613.0 8588.4 8624.6 8644.1 8645.6 8646.2 8460.0 8507.4 8513.1 8523.1 8526.4 36002.5 36028.3 36079.6 36109.9 36286.5 3175.8 3197.2 3284.7 3422.4 3678.5 28418.0 29632.9 29802.4 29954.9 30214.0 4251.9 4406.0 4419.7 4453.4 4523.2 332348.0 335959.0 337582.0 338037.0 338300.0 48597.0 48978.3 49019.3 49031.8 49066.3 45652.8 50221.5 51098.0 51350.2 54799.2 14802.9 14990.7 15028.3 15049.8 15057.7 11628.5 11688.1 11696.1 11700.2 11709.4 14315.9 15372.2 15737.1 15744.0 16178.4 5935.2 5959.3 5966.4 6046.8 6048.9 818.8 868.4 933.4 934.4 1011.0 28238.0 28539.3 28735.0 29367.4 29456.7 936.7 956.5 969.9 990.3 999.9 14494.6 15140.5 15152.2 15418.8 15505.7 157424.0 157640.0 158360.0 158528.0 158562.0 46619.8 47272.5 47318.5 47330.5 47334.3 1148.2 1156.3 1197.4 1210.4 1219.4 26995.2 28103.4 28286.8 28545.0 28747.6 42420.8 42737.4 42812.1 42895.4 42907.8 432530.0 435809.0 435847.0 435963.0 436259.0 23112.7 24545.3 25222.7 25298.2 25782.7 40307.2 40682.2 40748.2 40956.8 41328.0 31907.8 32588.3 32789.5 32863.5 33121.7 35421.3 35503.6 35665.2 35867.5 35974.5 35220.1 35222.5 35494.6 35501.0 35632.6 31895.8 32322.8 32711.8 32772.5 32898.8 24857.0 25084.1 25152.5 25328.1 25553.0 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#2] jquery.html Cycles:180 Average:28955.95 Median:23957.30 stddev:83877.33 (350.1%) stddev-sans-first:84085.16 08:52:42 INFO - PROCESS | 7328 | Values: 364.6 364.8 369.7 377.4 384.7 17040.0 18097.4 18206.0 18494.4 18503.7 15541.5 16498.0 16853.7 16904.8 16938.9 4931.4 5121.6 5154.9 5158.0 5163.1 3753.2 4553.2 5061.6 6008.6 6021.9 6025.5 6038.3 6053.0 6066.7 6066.9 5480.2 5585.1 5609.4 5612.6 6021.0 5422.1 5424.9 5427.5 5430.0 5448.1 12301.7 12581.7 12619.8 12638.8 12643.2 2173.9 2305.8 2323.7 2679.3 2710.3 9199.7 9287.7 9364.8 9743.6 9761.7 1857.5 1865.1 1931.4 1982.6 1983.2 78198.0 78484.6 78982.6 80114.0 80987.0 10309.1 10451.4 10485.0 10580.3 10666.8 14673.9 14741.5 14753.5 14784.3 14790.7 7441.9 7647.4 7693.9 7774.1 7828.4 7320.1 7379.2 7549.6 7554.4 7558.5 4117.4 4135.6 4363.5 4522.0 4587.4 1701.6 1795.7 1802.0 1809.2 1885.8 808.3 816.8 850.4 888.6 906.2 17171.7 17423.8 17783.2 18093.4 18258.2 857.5 878.3 886.2 919.2 924.7 9532.8 9613.9 10072.2 10105.1 10212.9 496261.0 504892.0 512216.0 514122.0 515978.0 88014.6 90745.5 92553.5 94401.6 94587.5 849.1 882.8 885.2 896.4 909.2 15919.8 16013.1 16111.9 16112.8 16193.7 39156.8 40265.8 42488.8 43391.0 43551.1 59660.4 60020.7 60115.0 60733.7 61143.0 8086.6 8257.2 8342.0 8416.4 8419.9 13562.9 13996.2 14034.2 14142.6 14196.4 12026.2 12241.8 12441.8 12609.3 12641.9 11314.6 11780.5 11911.5 12367.8 12376.4 12365.9 12529.9 12543.6 12685.7 12778.3 7451.2 7496.5 7586.5 7815.2 9215.7 10827.4 11579.8 11626.8 11629.2 11692.5 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#3] mootools.html Cycles:180 Average:5507.77 Median:4963.83 stddev:3160.41 (63.7%) stddev-sans-first:3151.88 08:52:42 INFO - PROCESS | 7328 | Values: 1095.7 1205.8 1211.4 1240.1 1386.8 7666.5 7999.8 8031.6 8192.3 8201.5 7914.3 8086.4 8088.1 8097.4 8150.5 1901.8 2129.7 2192.8 2214.6 2242.7 2262.9 2270.3 2271.0 2271.8 2273.6 2225.7 2226.3 2243.7 2257.4 2271.7 1823.7 2127.0 2191.8 2206.8 2212.2 2218.6 2240.7 2248.7 2256.1 2257.3 8300.1 8437.5 8438.1 8442.2 8444.9 4865.5 4996.2 4997.7 5028.9 5037.8 3102.4 3282.9 3319.6 3331.8 3375.2 1031.9 1050.2 1054.4 1088.2 1090.7 12048.1 12049.1 12083.9 12084.2 12121.2 4260.8 4359.3 4442.2 4447.1 4476.0 9596.3 9599.4 9611.4 9612.0 9625.8 4986.7 5006.3 5011.9 5024.6 5027.7 3819.1 4444.3 4642.9 4647.9 4686.1 3670.9 3730.6 3820.7 3824.4 3842.7 1221.2 1226.5 1241.3 1243.0 1249.0 817.9 877.4 880.4 890.3 901.0 5573.1 5678.9 5689.0 5723.1 5976.9 826.7 831.8 854.4 857.1 905.6 3974.0 3985.2 3989.4 4088.9 4133.4 10208.7 10385.6 10516.8 10518.4 10537.1 10280.8 10340.6 10385.4 10398.8 10432.1 7353.5 7641.2 7647.4 7652.6 7737.5 5601.9 5659.5 5803.1 5871.8 5912.2 9414.8 9814.5 9960.5 9974.1 10049.0 10038.8 10074.5 10149.6 10263.3 10283.1 7352.5 7398.7 7421.7 7461.1 7469.5 7853.7 7858.2 7864.8 7866.6 7905.8 7043.7 7044.5 7135.9 7183.7 7329.7 7000.2 7005.2 7041.0 7112.3 7180.4 6472.2 6490.3 6539.6 6546.7 6550.1 4802.5 4804.9 4938.4 5029.7 5067.2 4958.1 4969.5 4998.7 5086.8 5144.6 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#4] prototype.html Cycles:180 Average:4451.86 Median:5025.42 stddev:1313.56 (26.1%) stddev-sans-first:1279.72 08:52:42 INFO - PROCESS | 7328 | Values: 298.6 303.1 311.2 314.5 314.6 5319.7 5326.3 5360.7 5372.4 5397.9 4957.4 5067.8 5170.6 5194.8 5287.3 4044.9 4052.0 4094.3 4096.7 4096.8 4085.9 4091.5 4096.4 4098.3 4100.0 3769.7 3869.5 3972.6 4005.7 4061.2 3992.8 4021.2 4033.8 4072.2 4077.6 3568.9 3582.5 3587.9 3589.5 3592.9 4843.5 5129.6 5137.9 5163.7 5197.9 4590.2 4600.1 4621.4 4653.8 4660.9 5463.7 5493.2 5500.8 5513.3 5517.5 3668.4 3872.1 3879.9 3884.3 3895.6 5723.4 5731.1 5734.2 5748.4 5768.3 3923.0 3923.7 3927.6 3929.4 3933.1 3780.3 3952.1 3977.2 3977.7 3982.6 4538.2 4545.9 4553.4 4562.8 4565.4 5514.8 5519.3 5532.3 5537.5 5539.3 1346.4 1361.8 1373.4 1377.7 1381.3 859.5 859.9 872.6 879.5 883.2 4696.7 4755.1 4775.0 4780.9 4801.0 5025.3 5034.8 5068.1 5119.7 5124.4 4489.5 4824.6 4827.6 4828.2 4833.3 2688.9 2704.0 2711.9 2712.0 2714.4 5106.9 5123.4 5124.3 5168.9 5172.0 4775.3 5146.2 5152.5 5154.5 5181.3 5113.8 5164.7 5170.6 5200.5 5222.3 4957.9 4993.6 5014.6 5025.5 5033.2 4811.7 4924.3 4982.8 5011.2 5096.5 5169.3 5191.9 5216.4 5224.5 5241.9 3590.4 3603.7 3603.9 3607.5 3608.8 5422.5 5431.8 5615.9 5678.3 5686.8 5488.3 5529.8 5551.3 5598.4 5609.3 5335.8 5583.3 5593.8 5612.2 5668.1 5492.3 5516.4 5525.6 5531.9 5567.6 5598.4 5620.4 5624.2 5631.1 5632.6 5169.8 5510.0 5514.1 5517.5 5519.7 08:52:42 INFO - PROCESS | 7328 | 08:52:42 INFO - PROCESS | 7328 | [#5] yui.html Cycles:180 Average:19881.71 Median:4860.52 stddev:30249.60 (622.4%) stddev-sans-first:30299.66 08:52:42 INFO - PROCESS | 7328 | Values: 557.3 559.6 611.7 634.1 649.8 12367.5 13082.9 13250.9 13335.1 13339.8 12591.4 12862.4 12877.9 12877.9 12895.3 494.6 497.6 505.3 570.1 591.4 599.6 599.6 600.7 600.9 601.5 623.6 625.1 625.9 626.3 626.7 518.2 601.0 602.7 623.7 624.2 453.2 455.0 455.1 455.6 455.7 12344.9 12362.8 12380.4 12393.4 12397.0 12586.1 12957.2 13066.8 13407.2 13427.8 11799.5 11809.8 11888.8 11974.2 12225.4 3708.1 3735.2 3829.9 3925.8 4265.8 75049.6 75539.6 75640.0 75949.6 77133.0 9887.4 10048.0 10213.5 10248.8 10279.2 16735.9 16993.0 17026.7 17041.8 17117.2 7634.0 7669.6 7678.3 7713.8 7734.2 4597.3 4664.3 4752.9 4797.4 4923.6 3085.5 3172.2 3174.4 3176.7 3177.4 521.5 530.5 532.5 532.9 536.6 500.9 563.5 563.9 597.6 613.6 8495.8 8858.3 8938.5 9007.5 9034.5 568.0 614.8 615.2 616.1 630.4 4274.9 4339.8 4396.3 4414.2 4453.3 113275.0 113955.0 115014.0 121211.4 121568.0 93280.0 94529.0 95984.5 97960.5 99253.0 66421.7 88534.0 90720.5 90755.5 91938.0 8227.2 8410.4 8532.6 8539.8 8583.1 51139.2 51602.5 52088.0 53029.0 53340.5 74681.0 75257.6 75958.6 77102.6 77968.0 10269.3 10286.0 10315.9 10498.3 10886.6 11903.5 12147.1 12300.6 12337.5 12403.7 11430.1 11459.5 11601.5 11664.8 11773.9 10751.6 10975.5 11227.4 11355.5 11425.5 10232.8 10354.4 10432.4 10437.5 10497.7 9596.9 9611.8 9648.2 9893.2 9903.9 9478.0 9848.0 10090.5 10950.5 11239.3 08:52:42 INFO - PROCESS | 7328 | -------- Summary: end -------- 08:52:42 INFO - PROCESS | 7328 | 08:52:43 INFO - TEST-INFO | 7328: exit 0 08:52:43 INFO - TEST-OK | dromaeo_css | took 1112590ms 08:52:43 INFO - TEST-START | kraken 08:52:43 INFO - operating with platform_type : linux_ 08:52:43 INFO - Initialising browser for kraken test... 08:52:43 INFO - TEST-INFO | started process 7512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rnXAs/profile http://localhost:37620/getInfo.html) 08:52:47 INFO - PROCESS | 7512 | __metrics Screen width/height:1600/1200 08:52:47 INFO - PROCESS | 7512 | colorDepth:24 08:52:47 INFO - PROCESS | 7512 | Browser inner width/height: 1024/697 08:52:47 INFO - PROCESS | 7512 | __metrics 08:52:48 INFO - PROCESS | 7512 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:49 INFO - TEST-INFO | 7512: exit 0 08:52:49 INFO - Browser initialized. 08:52:49 INFO - Running cycle 1/1 for kraken test... 08:52:49 INFO - TEST-INFO | started process 7595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rnXAs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:00 INFO - PROCESS | 7595 | RSS: Main: 173219840 08:53:00 INFO - PROCESS | 7595 | 08:53:03 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37620/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:04 INFO - PROCESS | 7595 | RSS: Main: 232730624 08:53:04 INFO - PROCESS | 7595 | 08:53:06 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37620/tests/kraken/driver.html?testName=audio-dft) 08:53:07 INFO - PROCESS | 7595 | RSS: Main: 221114368 08:53:07 INFO - PROCESS | 7595 | 08:53:10 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37620/tests/kraken/driver.html?testName=audio-fft) 08:53:11 INFO - PROCESS | 7595 | RSS: Main: 286687232 08:53:11 INFO - PROCESS | 7595 | 08:53:13 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37620/tests/kraken/driver.html?testName=audio-oscillator) 08:53:14 INFO - PROCESS | 7595 | RSS: Main: 197812224 08:53:14 INFO - PROCESS | 7595 | 08:53:16 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:16 INFO - PROCESS | 7595 | RSS: Main: 201564160 08:53:16 INFO - PROCESS | 7595 | 08:53:19 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37620/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:20 INFO - PROCESS | 7595 | RSS: Main: 235761664 08:53:20 INFO - PROCESS | 7595 | 08:53:23 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37620/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:24 INFO - PROCESS | 7595 | RSS: Main: 237981696 08:53:24 INFO - PROCESS | 7595 | 08:53:27 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37620/tests/kraken/driver.html?testName=json-parse-financial) 08:53:27 INFO - PROCESS | 7595 | RSS: Main: 237838336 08:53:27 INFO - PROCESS | 7595 | 08:53:29 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:30 INFO - PROCESS | 7595 | RSS: Main: 225583104 08:53:30 INFO - PROCESS | 7595 | 08:53:31 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:32 INFO - PROCESS | 7595 | RSS: Main: 230469632 08:53:32 INFO - PROCESS | 7595 | 08:53:34 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:35 INFO - PROCESS | 7595 | RSS: Main: 238161920 08:53:35 INFO - PROCESS | 7595 | 08:53:37 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:38 INFO - PROCESS | 7595 | RSS: Main: 238419968 08:53:38 INFO - PROCESS | 7595 | 08:53:41 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:41 INFO - PROCESS | 7595 | RSS: Main: 240087040 08:53:41 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | Cycle 1(1): loaded http://localhost:37620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37620/tests/kraken/driver.html?testName=ai-astar) 08:53:43 INFO - PROCESS | 7595 | RSS: Main: 282972160 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | __start_tp_report 08:53:43 INFO - PROCESS | 7595 | _x_x_mozilla_page_load 08:53:43 INFO - PROCESS | 7595 | _x_x_mozilla_page_load_details 08:53:43 INFO - PROCESS | 7595 | |i|pagename|runs| 08:53:43 INFO - PROCESS | 7595 | |0;ai-astar;101;110;111;111;113;113;109;109;109;110 08:53:43 INFO - PROCESS | 7595 | |1;audio-beat-detection;153;128;129;171;127;127;162;128;158;125 08:53:43 INFO - PROCESS | 7595 | |2;audio-dft;159;162;162;161;162;161;162;161;161;162 08:53:43 INFO - PROCESS | 7595 | |3;audio-fft;75;75;77;118;76;76;76;75;101;74 08:53:43 INFO - PROCESS | 7595 | |4;audio-oscillator;88;87;120;87;87;86;116;86;87;134 08:53:43 INFO - PROCESS | 7595 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;116;116 08:53:43 INFO - PROCESS | 7595 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;147;146 08:53:43 INFO - PROCESS | 7595 | |7;imaging-desaturate;96;96;96;97;95;95;96;96;96;96 08:53:43 INFO - PROCESS | 7595 | |8;json-parse-financial;54;53;54;54;53;53;56;54;53;54 08:53:43 INFO - PROCESS | 7595 | |9;json-stringify-tinderbox;63;63;62;62;62;63;62;63;63;63 08:53:43 INFO - PROCESS | 7595 | |10;stanford-crypto-aes;78;80;78;79;79;79;79;86;89;84 08:53:43 INFO - PROCESS | 7595 | |11;stanford-crypto-ccm;125;122;127;132;120;131;119;121;139;131 08:53:43 INFO - PROCESS | 7595 | |12;stanford-crypto-pbkdf2;160;159;158;160;165;158;162;162;158;160 08:53:43 INFO - PROCESS | 7595 | |13;stanford-crypto-sha256-iterative;65;67;66;66;63;66;62;62;61;67 08:53:43 INFO - PROCESS | 7595 | __end_tp_report 08:53:43 INFO - PROCESS | 7595 | __start_cc_report 08:53:43 INFO - PROCESS | 7595 | _x_x_mozilla_cycle_collect,1637 08:53:43 INFO - PROCESS | 7595 | __end_cc_report 08:53:43 INFO - PROCESS | 7595 | __startTimestamp1466697223537__endTimestamp 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | ------- Summary: start ------- 08:53:43 INFO - PROCESS | 7595 | Number of tests: 14 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:3.37 (3.1%) stddev-sans-first:1.59 08:53:43 INFO - PROCESS | 7595 | Values: 101.0 110.0 111.0 111.0 113.0 113.0 109.0 109.0 109.0 110.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:141.00 stddev:17.96 (12.7%) stddev-sans-first:18.50 08:53:43 INFO - PROCESS | 7595 | Values: 153.0 128.0 129.0 171.0 127.0 127.0 162.0 128.0 158.0 125.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.53 08:53:43 INFO - PROCESS | 7595 | Values: 159.0 162.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 162.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:14.91 (19.7%) stddev-sans-first:15.58 08:53:43 INFO - PROCESS | 7595 | Values: 75.0 75.0 77.0 118.0 76.0 76.0 76.0 75.0 101.0 74.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:87.00 stddev:18.18 (20.9%) stddev-sans-first:18.94 08:53:43 INFO - PROCESS | 7595 | Values: 88.0 87.0 120.0 87.0 87.0 86.0 116.0 86.0 87.0 134.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:53:43 INFO - PROCESS | 7595 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:53:43 INFO - PROCESS | 7595 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:53:43 INFO - PROCESS | 7595 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 08:53:43 INFO - PROCESS | 7595 | Values: 54.0 53.0 54.0 54.0 53.0 53.0 56.0 54.0 53.0 54.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:53:43 INFO - PROCESS | 7595 | Values: 63.0 63.0 62.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.50 stddev:3.84 (4.8%) stddev-sans-first:3.91 08:53:43 INFO - PROCESS | 7595 | Values: 78.0 80.0 78.0 79.0 79.0 79.0 79.0 86.0 89.0 84.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:129.00 stddev:6.48 (5.0%) stddev-sans-first:6.85 08:53:43 INFO - PROCESS | 7595 | Values: 125.0 122.0 127.0 132.0 120.0 131.0 119.0 121.0 139.0 131.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:2.25 (1.4%) stddev-sans-first:2.39 08:53:43 INFO - PROCESS | 7595 | Values: 160.0 159.0 158.0 160.0 165.0 158.0 162.0 162.0 158.0 160.0 08:53:43 INFO - PROCESS | 7595 | 08:53:43 INFO - PROCESS | 7595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:66.00 stddev:2.27 (3.4%) stddev-sans-first:2.40 08:53:43 INFO - PROCESS | 7595 | Values: 65.0 67.0 66.0 66.0 63.0 66.0 62.0 62.0 61.0 67.0 08:53:43 INFO - PROCESS | 7595 | -------- Summary: end -------- 08:53:43 INFO - PROCESS | 7595 | 08:53:44 INFO - TEST-INFO | 7595: exit 0 08:53:44 INFO - TEST-OK | kraken | took 61438ms 08:53:44 INFO - SUITE-END | took 1174s 08:53:44 INFO - Completed test suite (00:19:34) 08:53:44 INFO - javascript benchmark 08:53:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.1206850013496, 3057.2051266670674, 3071.15543225613, 3079.276370053036, 3110.4245714542812, 5082.4917508249155, 5117.948820511794, 5159.277701121846, 5206.531412172903, 5270.235815806705, 5112.182050871861, 5115.309433226514, 5223.686578805275, 5277.577793776498, 5318.654287471311, 4613.861584152481, 4667.719936803803, 4676.415448068991, 4733.715977041371, 4920.089783390066, 4820.084184005028, 4843.321934929113, 4874.780634871439, 4902.607791376681, 4913.729744864031, 4620.0297937433015, 4654.138984287918, 4670.743109128996, 4674.3222232776225, 4695.835645752416, 4679.438467383901, 4687.624990000826, 4702.435707715062, 4749.857504274877, 4783.593394561466, 4697.412823397075, 4712.505186955389, 4734.692245004098, 4735.83424580138, 4774.761261936924, 5102.489751024905, 5159.303494028333, 5263.736813159365, 5317.707526086064, 5320.787168513255, 5614.719264036782, 5628.54971602275, 5654.293213348332, 5661.915071273934, 5667.773289068432, 5484.588655850787, 5657.094864821609, 5675.233843431167, 5675.262215911946, 5679.290088738908, 5184.792608295664, 5256.789728410859, 5259.605529585297, 5313.734313284321, 5316.12283973144, 5761.0, 5787.739551720183, 5788.0449725795615, 5791.189233507313, 5794.8551286217335, 5349.063913815066, 5409.783608655688, 5563.276774019432, 5589.441055894378, 5595.38450770415, 5550.888982220333, 5603.635763675429, 5630.268065151586, 5664.716764161775, 5666.688332141689, 5589.413111623221, 5606.803761868397, 5610.074337734228, 5611.494965453129, 5615.18579805934, 5357.651752636066, 5451.0, 5511.641743286674, 5611.2144299798065, 5611.961787069406, 4225.704200705921, 4229.450171477688, 4262.552431994658, 4288.721233119837, 4288.849890253826, 3802.1065049713297, 3818.503594532693, 3832.48261484696, 3851.114243723959, 3870.1679138985255, 5106.310648062538, 5130.948690513047, 5173.0, 5200.713960732196, 5203.661761985459, 5497.615166938276, 5498.862528436821, 5516.696581687966, 5545.223668686387, 5580.748866301026, 5122.206058061007, 5148.56237219833, 5164.354455693038, 5165.819196328111, 5211.583073354198, 4682.976585117052, 4757.857264282077, 4810.158222311082, 4821.156297647897, 4848.587870031016, 5686.488216060575, 5726.284214473191, 5786.913196302059, 5789.710514474344, 5794.536437085023, 5444.8094316698725, 5668.121441176624, 5686.374498805211, 5692.117721753135, 5735.996200664784, 5640.182173584889, 5713.457221563945, 5717.571182161271, 5745.626534275259, 5764.3371012332445, 5517.641353312022, 5542.002439560918, 5552.555795536428, 5553.416891226363, 5564.998300305984, 5385.946140538545, 5643.040683083967, 5643.858903527444, 5649.067903795992, 5656.208130861601, 5541.972290138524, 5560.91658625129, 5568.972155139199, 5570.86072848182, 5614.85962850932, 5532.336119665666, 5543.833684989457, 5545.833624991256, 5546.528545073714, 5548.945700316927, 5041.344625198701, 5284.577233821362, 5284.682919024717, 5467.753951072291, 5529.474699903502, 5506.2291279221745, 5565.220869078414, 5571.498565129158, 5575.637583557056, 5579.776808927598, 5347.117725575392, 5356.866078348073, 5387.515123638891, 5395.028894798974, 5397.082495975615], "value": 5152.012263601698, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1519018165882, 581.6277582347298, 591.8106206014074, 594.7472324262187, 599.3407252022776, 29462.116136515913, 36620.0, 37284.440733388954, 37598.62401375985, 37600.623993760055, 38760.22479550407, 39031.414528782094, 39123.60876391235, 39202.8039859801, 39216.607833921655, 8435.114312997124, 8629.69796057135, 8630.0, 8632.482051076924, 8678.566071696421, 8462.069172391031, 8548.743537693848, 8564.785880352978, 8565.914340856574, 8571.571421428935, 8550.657973681045, 8594.09761974993, 8606.612702428374, 8610.827783444327, 8612.956935215316, 8588.441751286178, 8624.611892464854, 8644.092370301121, 8645.567721613894, 8646.178613031783, 8459.95770021152, 8507.404481686284, 8513.063563008063, 8523.14768523149, 8526.360522960802, 36002.45996310058, 36028.27943441117, 36079.63920360815, 36109.916702498704, 36286.45570316447, 3175.7776955613117, 3197.2486465680545, 3284.6715328467203, 3422.366862130489, 3678.4666223397726, 28418.005369812163, 29632.851835740683, 29802.40395192084, 29954.85022574873, 30214.0, 4251.914961700749, 4406.0, 4419.692051106423, 4453.398791163184, 4523.185826551219, 332348.0, 335959.0, 337582.0, 338037.0, 338300.0, 48597.0, 48978.26532602014, 49019.26471102936, 49031.754841225564, 49066.264006039935, 45652.771736141105, 50221.49778502241, 51098.0, 51350.22974655383, 54799.17801232905, 14802.851971480148, 14990.700185996218, 15028.323725432381, 15049.849501505063, 15057.698846023019, 11628.476718547685, 11688.123390745728, 11696.122790790725, 11700.239484433485, 11709.355985420883, 14315.856841431452, 15372.154531500875, 15737.055776653437, 15744.0, 16178.382161783962, 5935.198748168942, 5959.344472108065, 5966.373530779292, 6046.788362407295, 6048.939510604838, 818.7625588579245, 868.4008034456205, 933.421278807144, 934.4159900062461, 1010.9536629588341, 28238.0, 28539.286517836805, 28735.0, 29367.412651747272, 29456.705432945397, 936.6862101196176, 956.5173980330599, 969.9272554558436, 990.2820455170088, 999.8550210219478, 14494.637634059021, 15140.470083547023, 15152.242387880562, 15418.768718469231, 15505.689886202214, 157424.0, 157640.0, 158360.0, 158528.0, 158562.0, 46619.766901165276, 47272.52727472681, 47318.52681473141, 47330.5266947333, 47334.28998565024, 1148.2249481600054, 1156.2946602572424, 1197.4372045138946, 1210.4371467267588, 1219.439058033297, 26995.190144295702, 28103.43793124167, 28286.79290508153, 28545.0, 28747.568786468637, 42420.78789606032, 42737.358939616555, 42812.143757125305, 42895.356569652104, 42907.78546107374, 432530.0, 435809.0, 435847.0, 435963.0, 436259.0, 23112.653310200025, 24545.263642090766, 25222.74777252204, 25298.241052768448, 25782.742172578033, 40307.1938561233, 40682.18635627212, 40748.1850362997, 40956.79521602373, 41328.0, 31907.840460797546, 32588.348233035682, 32789.54078444078, 32863.507047394785, 33121.668783311856, 35421.291574168885, 35503.64496355003, 35665.21673916242, 35867.461988070725, 35974.460383094796, 35220.119497012776, 35222.47166292457, 35494.64505354913, 35501.0, 35632.64367356293, 31895.840520797246, 32322.83838580792, 32711.836440818595, 32772.50841237431, 32898.83550582232, 24857.0, 25084.122055727963, 25152.49695006126, 25328.11351602685, 25553.0], "value": 17442.592449373507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6171519904101, 364.762904112327, 369.7245552063711, 377.38863041872173, 384.73453317211124, 17040.0, 18097.37588049732, 18206.0, 18494.352697655584, 18503.722444163348, 15541.52355526226, 16498.0, 16853.747193792104, 16904.83095169048, 16938.915305423456, 4931.408231012275, 5121.590272778188, 5154.896902061956, 5158.0199762045095, 5163.096458119833, 3753.174301653632, 4553.203189441851, 5061.569766569827, 6008.639481631116, 6021.909671354912, 6025.548083893704, 6038.33578306386, 6053.0, 6066.726997285111, 6066.939330606681, 5480.150576660624, 5585.134304182818, 5609.411011843738, 5612.550995920337, 6021.036634138539, 5422.1053526168525, 5424.887897980904, 5427.511523962823, 5430.049741295257, 5448.128299472065, 12301.692457688629, 12581.685457863536, 12619.810702839464, 12638.810417843739, 12643.17819341749, 2173.8695678259355, 2305.8155347572156, 2323.744388117306, 2679.303381120903, 2710.2953232159584, 9199.67801126964, 9287.674931377436, 9364.765880852965, 9743.610255589769, 9761.658341957997, 1857.4706208730581, 1865.0767869904348, 1931.3626503254034, 1982.6431242376366, 1983.1968052938582, 78198.0, 78484.60757696175, 78982.60508697477, 80114.0, 80986.95065246715, 10309.07218350352, 10451.372917624967, 10485.0, 10580.312279701795, 10666.786664266827, 14673.92663036678, 14741.484048058266, 14753.483628072965, 14784.334704938303, 14790.704185916222, 7441.888371674429, 7647.426443016796, 7693.884591731128, 7774.105977812511, 7828.412869034732, 7320.084989376328, 7379.225181355988, 7549.6225188740345, 7554.357879580297, 7558.546487210785, 4117.423560701504, 4135.60711732385, 4363.47638283408, 4522.0, 4587.357769912215, 1701.5831121375343, 1795.739617755418, 1801.9909900450414, 1809.1587411853552, 1885.820847019531, 808.3290868579182, 816.8243827577099, 850.4302117581235, 888.6045709659139, 906.243286855483, 17171.742423863652, 17423.825761742475, 17783.19975601101, 18093.36673216431, 18258.178381972844, 857.4598003257908, 878.2534845381502, 886.1714297132202, 919.1681528216974, 924.7225832250298, 9532.809343813085, 9613.90386096144, 10072.244581656405, 10105.090541851268, 10212.8765835758, 496261.0, 504892.0, 512216.0, 514122.0, 515978.0, 88014.55992719995, 90745.54627226821, 92553.5372323134, 94401.5839762404, 94587.52706236563, 849.0999540487103, 882.8278485695356, 885.2386947225381, 896.4442045931564, 909.2453263791037, 15919.761203582188, 16013.119278439797, 16111.919440403191, 16112.838871611602, 16193.67612647764, 39156.80421597874, 40265.79867100646, 42488.78755606202, 43391.0, 43551.12897741964, 59660.403395965484, 60020.699896500235, 60115.0, 60733.69633151806, 61143.0, 8086.636101375335, 8257.174282571696, 8342.040665323566, 8416.36877234222, 8419.8737018946, 13562.86437135616, 13996.230207338695, 14034.228117453638, 14142.575722728334, 14196.36116374745, 12026.15816892809, 12241.816372754594, 12441.751164976831, 12609.30648814324, 12641.87358126407, 11314.60398886035, 11780.469878855301, 11911.52353905834, 12367.75264494723, 12376.381180941096, 12365.876341236832, 12529.874701252871, 12543.623691289276, 12685.682857928625, 12778.297193654438, 7451.18037015917, 7496.512726672749, 7586.544807311579, 7815.2184781523665, 9215.723528294162, 10827.350358978487, 11579.8263026053, 11626.767464650491, 11629.18595698293, 11692.532298707956], "value": 8724.024341527396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1095.7479779650675, 1205.8432403787506, 1211.388248934288, 1240.0699475393455, 1386.826646669167, 7666.501677390966, 7999.760007199779, 8031.598420078994, 8192.262696357328, 8201.466904651208, 7914.28771410573, 8086.433949623529, 8088.069871964726, 8097.392695547843, 8150.470219435732, 1901.7622797150357, 2129.691194776756, 2192.7807219278066, 2214.601371753092, 2242.6972358731527, 2262.875541845198, 2270.2848602690183, 2270.965935510969, 2271.7728227177317, 2273.6362182050875, 2225.688403623494, 2226.265332440291, 2243.741969673492, 2257.413072601127, 2271.7273927128686, 1823.6626224148574, 2127.0428307261795, 2191.824654027674, 2206.7793220677963, 2212.203606701586, 2218.556288742258, 2240.7199100112484, 2248.7413947396094, 2256.0975609756065, 2257.3115199864037, 8300.12848650889, 8437.451565648213, 8438.113998030241, 8442.240198382175, 8444.873326900102, 4865.5134486551415, 4996.200607902718, 4997.675151115202, 5028.949710502921, 5037.798488060474, 3102.4105419970133, 3282.9343413131605, 3319.551860498826, 3331.750118741104, 3375.2280052972387, 1031.865857438528, 1050.196599601298, 1054.3726482742757, 1088.1892989722628, 1090.6891535912227, 12048.096392770578, 12049.096317776202, 12083.879161208451, 12084.214526055779, 12121.212121212093, 4260.786960651955, 4359.324304732771, 4442.244818380883, 4447.110577884436, 4476.037651904856, 9596.280278978966, 9599.376040557481, 9611.375260608038, 9612.0, 9625.807483850283, 4986.650934434628, 5006.274090256892, 5011.899762004739, 5024.648274620815, 5027.673201241908, 3819.102510909934, 4444.31113177458, 4642.907141857144, 4647.907041859144, 4686.133065382915, 3670.853165873335, 3730.552333719971, 3820.7134464915243, 3824.4263360496147, 3842.731008829411, 1221.1757063981777, 1226.4726167747776, 1241.3110723548336, 1242.9937850310691, 1249.0, 817.8732296494053, 877.3507604372718, 880.423322723617, 890.25663570919, 901.008890220765, 5573.136163894522, 5678.886422271531, 5689.0, 5723.084306511021, 5976.85057873548, 826.7478419082238, 831.7837362285728, 854.4275335525213, 857.1342943626858, 905.6105874473908, 3973.980130099331, 3985.222881538072, 3989.3816458448987, 4088.856890008895, 4133.400656904732, 10208.693739187836, 10385.63650272237, 10516.842247366296, 10518.368897866152, 10537.104346130665, 10280.794384112276, 10340.586376544854, 10385.376877387382, 10398.792024159475, 10432.113270371952, 7353.485256032026, 7641.159472458136, 7647.388208943383, 7652.617369131521, 7737.497062690907, 5601.8945531596655, 5659.490645841894, 5803.100519419497, 5871.823845284648, 5912.201852749996, 9414.811703765748, 9814.460204688525, 9960.50197490108, 9974.102330790263, 10049.045340692623, 10038.849417258602, 10074.54664540112, 10149.64476243328, 10263.281570290008, 10283.12593429567, 7352.5220860643885, 7398.667059982421, 7421.7031318748805, 7461.141968673455, 7469.514481558681, 7853.725119620786, 7858.214178582096, 7864.764057078297, 7866.567338796421, 7905.802354940943, 7043.6830342633675, 7044.5068845182395, 7135.8572828544175, 7183.676734546853, 7329.706811727685, 7000.194977577644, 7005.159380874327, 7040.964795175992, 7112.288771122846, 7180.425565954815, 6472.223333200046, 6490.253620833476, 6539.6403197824575, 6546.672666366758, 6550.115734375989, 4802.495737947465, 4804.903901922012, 4938.407391113089, 5029.723365214948, 5067.214581739836, 4958.132326842716, 4969.527894849984, 4998.6750861193905, 5086.830029093256, 5144.562712169358], "value": 4381.030211575982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.6207516454102, 303.1118821851974, 311.2483352703222, 314.488955447398, 314.5816064634037, 5319.707416092114, 5326.334208223972, 5360.705161216141, 5372.382176049756, 5397.865053373663, 4957.429895562012, 5067.797288108481, 5170.612204084689, 5194.766235519402, 5287.28621636079, 4044.9191016179657, 4052.0, 4094.303968325392, 4096.692748043901, 4096.815643296044, 4085.8569950051756, 4091.529474110486, 4096.365063415175, 4098.3401722302515, 4100.0, 3769.6607305342513, 3869.4776205212356, 3972.6027397260186, 4005.719599628027, 4061.208064427438, 3992.8203230854683, 4021.155557332964, 4033.838646454138, 4072.165206132736, 4077.5718549552316, 3568.8750893718593, 3582.4805403216387, 3587.910302242439, 3589.4974703541525, 3592.940082675617, 4843.539863712942, 5129.563987061104, 5137.895352499193, 5163.7159956202395, 5197.948020519784, 4590.173768721629, 4600.148972440109, 4621.399218101659, 4653.837115700934, 4660.86017419478, 5463.672179669193, 5493.23094766733, 5500.80747173847, 5513.338399392099, 5517.475839795253, 3668.413053911388, 3872.1287710264965, 3879.866073659476, 3884.3396622574232, 3895.590962948878, 5723.427657234285, 5731.111677689923, 5734.16854556087, 5748.425157484218, 5768.250127483442, 3922.9800251934703, 3923.6664883485223, 3927.626875446828, 3929.351656976567, 3933.1347103637154, 3780.3006443807435, 3952.130531283113, 3977.1506249594077, 3977.7414468059483, 3982.6415622594104, 4538.1831270370985, 4545.8636240912165, 4553.383548840114, 4562.794674239601, 4565.429321334833, 5514.786746915672, 5519.2824932758485, 5532.2531458253425, 5537.529310008695, 5539.2522009529, 1346.3672074125145, 1361.8161548191065, 1373.4231622718482, 1377.6762460821699, 1381.3093453273364, 859.5358506406595, 859.9465654573098, 872.616048938465, 879.5382424227332, 883.1830556735123, 4696.671233013724, 4755.096531658974, 4775.0, 4780.856574302777, 4801.0, 5025.296458495814, 5034.773435195351, 5068.074131829955, 5119.667221630657, 5124.359455068116, 4489.483709373399, 4824.614030877521, 4827.565519103297, 4828.199644206352, 4833.347498087784, 2688.892444302206, 2704.0265504418394, 2711.91864244073, 2711.986440067787, 2714.3763076292976, 5106.872328191751, 5123.385193776696, 5124.256982737482, 5168.8966220675375, 5171.97414012935, 4775.331453596499, 5146.202338637517, 5152.458991805806, 5154.484551544815, 5181.274621552986, 5113.821016264487, 5164.690118592821, 5170.638055336166, 5200.5059519345605, 5222.294990176353, 4957.851264462072, 4993.575546078624, 5014.598832093497, 5025.547700706954, 5033.219850923113, 4811.735354555533, 4924.261360795909, 4982.775775090202, 5011.223260394645, 5096.51583099605, 5169.276301317894, 5191.896162076813, 5216.40011398694, 5224.50367215114, 5241.877039798887, 3590.37168495507, 3603.747737658444, 3603.9099022524647, 3607.4747676625943, 3608.7654302470255, 5422.5119739223655, 5431.782728690966, 5615.8876822464135, 5678.290213723285, 5686.800961966312, 5488.341399032141, 5529.751161197675, 5551.333839939233, 5598.412166722435, 5609.298837645294, 5335.813246536352, 5583.2642005417865, 5593.8321850344555, 5612.186232996111, 5668.149777533403, 5492.313460817398, 5516.393196748274, 5525.64621667694, 5531.861703457284, 5567.55459563242, 5598.384177740364, 5620.381758006534, 5624.240727501735, 5631.071842641885, 5632.5775566831835, 5169.7673604687125, 5509.972450137724, 5514.145307477347, 5517.531009864207, 5519.66881987066], "value": 4028.8132205006264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2838902010917, 559.602682095712, 611.688039100059, 634.1249076274742, 649.8050584824555, 12367.505299788008, 13082.934585327084, 13250.933745331273, 13335.133216340942, 13339.799903001438, 12591.370431478435, 12862.356882155902, 12877.871221287784, 12877.935610321958, 12895.29075900825, 494.57466578742253, 497.5621453121257, 505.300159279397, 570.0594019867211, 591.3672370563498, 599.5892813422819, 599.6072572465042, 600.6996501749126, 600.8918394688955, 601.4917394801386, 623.5666211982674, 625.109219362409, 625.906114082889, 626.2672672972633, 626.6929204689692, 518.2200787814334, 600.9669468179248, 602.7167231401235, 623.6507555768784, 624.2041397218537, 453.23629683982597, 455.00127220750466, 455.12615777706884, 455.6354916067133, 455.6901307111163, 12344.876551234462, 12362.814557781641, 12380.442880070328, 12393.380330983415, 12397.0, 12586.118971671987, 12957.22256664603, 13066.803997940038, 13407.195568265935, 13427.798583021262, 11799.469023893946, 11809.822852657217, 11888.821667674993, 11974.22167559106, 12225.449854756558, 3708.091517578184, 3735.1782607826235, 3829.923401531954, 3925.8429662813455, 4265.786710664454, 75049.62475187589, 75539.62230188868, 75640.0, 75949.62025189894, 77133.0, 9887.406755594688, 10048.0, 10213.489325533694, 10248.795024099476, 10279.229057820694, 16735.91216570919, 16993.0, 17026.659466810594, 17041.82958170427, 17117.22972466217, 7634.0, 7669.616519174019, 7678.347340476011, 7713.8457230855065, 7734.187910269453, 4597.264437689953, 4664.253719404946, 4752.928706069411, 4797.424309082932, 4923.606111511071, 3085.460044492205, 3172.2228054126886, 3174.412733644237, 3176.7140957313954, 3177.3645270945904, 521.4889408379734, 530.5092789170002, 532.547334765454, 532.9040772660958, 536.5653820405485, 500.86226287770427, 563.5278822721045, 563.9172788246576, 597.5936363272929, 613.6164896939413, 8495.781494357034, 8858.291336693179, 8938.50838203892, 9007.504587247764, 9034.548272586344, 567.9943200568024, 614.7848253111375, 615.1725928625991, 616.1281786272374, 630.3601844128214, 4274.893127671771, 4339.82640694375, 4396.274614688605, 4414.183376075436, 4453.287474004143, 113275.0, 113955.0, 115014.0, 121211.39394302972, 121568.0, 93280.0, 94529.0, 95984.52007739917, 97960.51019744856, 99253.0, 66421.66789166024, 88534.0, 90720.5463972676, 90755.54622226847, 91938.0, 8227.177282271725, 8410.369222308229, 8532.573371331533, 8539.786505337417, 8583.141685831368, 51139.23291150561, 51602.48397515977, 52088.0, 53029.0, 53340.46659533355, 74681.0, 75257.6237118811, 75958.62020689862, 77102.61448692721, 77968.0, 10269.281150319406, 10286.0, 10315.948420257851, 10498.265121441731, 10886.61896833607, 11903.46434410471, 12147.088968327587, 12300.630981070582, 12337.50649973991, 12403.689907752378, 11430.085593152695, 11459.48432320531, 11601.535938562363, 11664.825027624762, 11773.882261177621, 10751.569937202425, 10975.50610222526, 11227.382493962583, 11355.489002995051, 11425.485853136795, 10232.795344092927, 10354.430506322225, 10432.374057556268, 10437.530311136168, 10497.737556561147, 9596.856047159437, 9611.759706007406, 9648.228141748783, 9893.210756698261, 9903.900960990586, 9477.95261023718, 9847.950760246153, 10090.495475226357, 10950.507227174638, 11239.325640461599], "value": 6554.7674798406315, "unit": "score"}], "name": "dromaeo_css", "value": 6703.112037243481, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 111.0, 113.0, 113.0, 109.0, 109.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 129.0, 171.0, 127.0, 127.0, 162.0, 128.0, 158.0, 125.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 118.0, 76.0, 76.0, 76.0, 75.0, 101.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 120.0, 87.0, 87.0, 86.0, 116.0, 86.0, 87.0, 134.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 53.0, 53.0, 56.0, 54.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 79.0, 79.0, 79.0, 79.0, 86.0, 89.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 127.0, 132.0, 120.0, 131.0, 119.0, 121.0, 139.0, 131.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 160.0, 165.0, 158.0, 162.0, 162.0, 158.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 63.0, 66.0, 62.0, 62.0, 61.0, 67.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1499.1, "alertThreshold": 2.0}]} 08:53:44 INFO - Return code: 0 08:53:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:44 INFO - # TBPL SUCCESS # 08:53:44 INFO - Running post-action listener: _resource_record_post_action 08:53:44 INFO - ##### 08:53:44 INFO - ##### Finished run-tests step (success) 08:53:44 INFO - ##### 08:53:44 INFO - Running post-run listener: _resource_record_post_run 08:53:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 551501824; Read time: 0; Write time: 364928 08:53:44 INFO - TinderboxPrint: CPU usage
13.2% 08:53:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:53:44 INFO - TinderboxPrint: I/O write bytes / time
551,501,824 / 364,928 08:53:44 INFO - TinderboxPrint: CPU idle
8,250.8 (86.7%) 08:53:44 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 08:53:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256671744; Read time: 0; Write time: 187620 08:53:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294678528; Read time: 0; Write time: 177280 08:53:45 INFO - Running post-run listener: _upload_blobber_files 08:53:45 INFO - Blob upload gear active. 08:53:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:45 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 08:53:45 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'] 08:53:45 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 08:53:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:53:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:46 INFO - (blobuploader) - INFO - Done attempting. 08:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:49 INFO - (blobuploader) - INFO - Done attempting. 08:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:50 INFO - (blobuploader) - INFO - Done attempting. 08:53:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:50 INFO - Return code: 0 08:53:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c7fcbe8a207cc13da20f806bfdc525bd09cfe1312d7db53a9c3017f4f43e2743db5d8f567c4b489c4c2c2fde6a2e759fe1bcc9e3a94c980891c655f08036ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286a38e8e5670fb6e9e8d39e2f7bd02cdd04be25a39ee41fbcd47f52990f89bd9e1c7b60a38f46b2b77da384cfa90b7cc58298233983af7161d9e5dc3653e72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1251a51ac64cba2629efef006759b5e53f194d9baf460e4691d46a6472b7867b7d289db127e1ca1c4965507c9aafc58de75a40e6a170228aa2602223dc3218a0"} 08:53:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:50 INFO - Contents: 08:53:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c7fcbe8a207cc13da20f806bfdc525bd09cfe1312d7db53a9c3017f4f43e2743db5d8f567c4b489c4c2c2fde6a2e759fe1bcc9e3a94c980891c655f08036ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286a38e8e5670fb6e9e8d39e2f7bd02cdd04be25a39ee41fbcd47f52990f89bd9e1c7b60a38f46b2b77da384cfa90b7cc58298233983af7161d9e5dc3653e72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1251a51ac64cba2629efef006759b5e53f194d9baf460e4691d46a6472b7867b7d289db127e1ca1c4965507c9aafc58de75a40e6a170228aa2602223dc3218a0"} 08:53:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:50 INFO - Copying logs to upload dir... 08:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.914883 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-23 08:53:50.516078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:53:50.520011) ========= 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=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c7fcbe8a207cc13da20f806bfdc525bd09cfe1312d7db53a9c3017f4f43e2743db5d8f567c4b489c4c2c2fde6a2e759fe1bcc9e3a94c980891c655f08036ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286a38e8e5670fb6e9e8d39e2f7bd02cdd04be25a39ee41fbcd47f52990f89bd9e1c7b60a38f46b2b77da384cfa90b7cc58298233983af7161d9e5dc3653e72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1251a51ac64cba2629efef006759b5e53f194d9baf460e4691d46a6472b7867b7d289db127e1ca1c4965507c9aafc58de75a40e6a170228aa2602223dc3218a0"} build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c7fcbe8a207cc13da20f806bfdc525bd09cfe1312d7db53a9c3017f4f43e2743db5d8f567c4b489c4c2c2fde6a2e759fe1bcc9e3a94c980891c655f08036ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286a38e8e5670fb6e9e8d39e2f7bd02cdd04be25a39ee41fbcd47f52990f89bd9e1c7b60a38f46b2b77da384cfa90b7cc58298233983af7161d9e5dc3653e72b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1251a51ac64cba2629efef006759b5e53f194d9baf460e4691d46a6472b7867b7d289db127e1ca1c4965507c9aafc58de75a40e6a170228aa2602223dc3218a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:53:50.546528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:53:50.546965) ========= 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=6dbc10da6d83fee962c624be000001a8-1466695995.200776-579337092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:53:50.634372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:53:50.635382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:53:50.636326) ========= ========= Total master_lag: 0.19 =========