builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1466435474.49 results: success (0) buildid: 20160620053002 builduid: 2dc8763fb1a14871929aa723d8195914 revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:14.488798) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:14.489258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:14.489585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:14.926115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:14.926428) ========= 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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 08:11:15-- 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% 88.3M=0s 2016-06-20 08:11:15 (88.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:15.046140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:15.046507) ========= 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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:15.102339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 08:11:15.102990) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 08:11:15,810 truncating revision to first 12 chars 2016-06-20 08:11:15,810 Setting DEBUG logging. 2016-06-20 08:11:15,810 attempt 1/10 2016-06-20 08:11:15,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 08:11:16,538 unpacking tar archive at: fx-team-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 08:11:16.178097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:16.178443) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:16.178951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:16.179301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:11:16.189335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-20 08:11:16.189656) ========= /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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:16 INFO - MultiFileLogger online at 20160620 08:11:16 in /builds/slave/test 08:11:16 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:11:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:16 INFO - {'append_to_log': False, 08:11:16 INFO - 'base_work_dir': '/builds/slave/test', 08:11:16 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:16 INFO - 'branch': 'Fx-Team', 08:11:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:16 INFO - 'config_files': ('talos/linux_config.py',), 08:11:16 INFO - 'default_actions': ('clobber', 08:11:16 INFO - 'read-buildbot-config', 08:11:16 INFO - 'download-and-extract', 08:11:16 INFO - 'populate-webroot', 08:11:16 INFO - 'create-virtualenv', 08:11:16 INFO - 'install', 08:11:16 INFO - 'run-tests'), 08:11:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:16 INFO - 'download_minidump_stackwalk': True, 08:11:16 INFO - 'download_symbols': 'ondemand', 08:11:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:16 INFO - 'installer_path': 'installer.exe', 08:11:16 INFO - 'log_level': 'info', 08:11:16 INFO - 'log_name': 'talos', 08:11:16 INFO - 'log_to_console': True, 08:11:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:16 INFO - 'opt_config_files': (), 08:11:16 INFO - 'pip_index': False, 08:11:16 INFO - 'sps_profile': False, 08:11:16 INFO - 'sps_profile_interval': 0, 08:11:16 INFO - 'suite': 'dromaeojs', 08:11:16 INFO - 'system_bits': '32', 08:11:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:16 INFO - 'title': 'talos-linux64-ix-052', 08:11:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:16 INFO - 'use_talos_json': True, 08:11:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:16 INFO - 'work_dir': 'build'} 08:11:16 INFO - ##### 08:11:16 INFO - ##### Running clobber step. 08:11:16 INFO - ##### 08:11:16 INFO - Running pre-action listener: _resource_record_pre_action 08:11:16 INFO - Running main action method: clobber 08:11:16 INFO - rmtree: /builds/slave/test/build 08:11:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:17 INFO - Running post-action listener: _resource_record_post_action 08:11:17 INFO - ##### 08:11:17 INFO - ##### Finished clobber step (success) 08:11:17 INFO - ##### 08:11:17 INFO - ##### 08:11:17 INFO - ##### Running read-buildbot-config step. 08:11:17 INFO - ##### 08:11:17 INFO - Running pre-action listener: _resource_record_pre_action 08:11:17 INFO - Running main action method: read_buildbot_config 08:11:17 INFO - Using buildbot properties: 08:11:17 INFO - { 08:11:17 INFO - "project": "", 08:11:17 INFO - "product": "firefox", 08:11:17 INFO - "script_repo_revision": "production", 08:11:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:11:17 INFO - "repository": "", 08:11:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:11:17 INFO - "buildid": "20160620053002", 08:11:17 INFO - "pgo_build": "True", 08:11:17 INFO - "basedir": "/builds/slave/test", 08:11:17 INFO - "buildnumber": 1267, 08:11:17 INFO - "slavename": "talos-linux64-ix-052", 08:11:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:11:17 INFO - "platform": "ubuntu64_hw", 08:11:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:17 INFO - "branch": "fx-team", 08:11:17 INFO - "repo_path": "integration/fx-team", 08:11:17 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 08:11:17 INFO - "stage_platform": "linux64-pgo", 08:11:17 INFO - "builduid": "2dc8763fb1a14871929aa723d8195914", 08:11:17 INFO - "slavebuilddir": "test" 08:11:17 INFO - } 08:11:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:11:17 INFO - Running post-action listener: _resource_record_post_action 08:11:17 INFO - ##### 08:11:17 INFO - ##### Finished read-buildbot-config step (success) 08:11:17 INFO - ##### 08:11:17 INFO - ##### 08:11:17 INFO - ##### Running download-and-extract step. 08:11:17 INFO - ##### 08:11:17 INFO - Running pre-action listener: _resource_record_pre_action 08:11:17 INFO - Running main action method: download_and_extract 08:11:17 INFO - mkdir: /builds/slave/test/build/tests 08:11:17 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:11:17 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:18 INFO - Downloaded 1361 bytes. 08:11:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:18 INFO - Using the following test package requirements: 08:11:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'jsshell-linux-x86_64.zip'], 08:11:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11: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:11:18 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:19 INFO - Downloaded 24220838 bytes. 08:11:19 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:11:19 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:11:20 INFO - Return code: 0 08:11:20 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:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:20 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:21 INFO - Downloaded 24220838 bytes. 08:11:21 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:11:21 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:11:23 INFO - Return code: 0 08:11: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:11:23 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:24 INFO - Downloaded 14405384 bytes. 08:11: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:11: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:11:24 INFO - Return code: 0 08:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:24 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/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:11:25 INFO - Downloaded 60128070 bytes. 08:11:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:25 INFO - mkdir: /builds/slave/test/properties 08:11:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:25 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:25 INFO - Contents: 08:11:25 INFO - build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:26 INFO - Running post-action listener: _resource_record_post_action 08:11:26 INFO - Running post-action listener: set_extra_try_arguments 08:11:26 INFO - ##### 08:11:26 INFO - ##### Finished download-and-extract step (success) 08:11:26 INFO - ##### 08:11:26 INFO - ##### 08:11:26 INFO - ##### Running populate-webroot step. 08:11:26 INFO - ##### 08:11:26 INFO - Running pre-action listener: _resource_record_pre_action 08:11:26 INFO - Running main action method: populate_webroot 08:11:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:26 INFO - '--tppagecycles', 08:11:26 INFO - '7'], 08:11:26 INFO - 'tests': ['tsvgm']}}, 08:11:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['damp', 'tps']}, 08:11:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['damp', 'tps']}, 08:11:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['dromaeo_dom']}, 08:11:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['basic_compositor_video']}, 08:11:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tsvgx', 08:11:26 INFO - 'tsvgr_opacity', 08:11:26 INFO - 'tart', 08:11:26 INFO - 'tscrollx', 08:11:26 INFO - 'cart']}, 08:11:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:26 INFO - 'tsvgr_opacity', 08:11:26 INFO - 'tart', 08:11:26 INFO - 'tscrollx', 08:11:26 INFO - 'cart']}, 08:11:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tp5o']}, 08:11:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['tp5o']}, 08:11:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s', 08:11:26 INFO - '--xperf_path', 08:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:26 INFO - 'tests': ['tp5n']}, 08:11:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--xperf_path', 08:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:26 INFO - 'tests': ['tp5n']}}, 08:11:26 INFO - 'talos.zip': {'path': '', 08:11:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:26 INFO - Running post-action listener: _resource_record_post_action 08:11:26 INFO - ##### 08:11:26 INFO - ##### Finished populate-webroot step (success) 08:11:26 INFO - ##### 08:11:26 INFO - ##### 08:11:26 INFO - ##### Running create-virtualenv step. 08:11:26 INFO - ##### 08:11:26 INFO - Running pre-action listener: _resource_record_pre_action 08:11:26 INFO - Running main action method: create_virtualenv 08:11:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:26 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:11:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:26 INFO - Using real prefix '/usr' 08:11:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:29 INFO - Installing pip.................done. 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11: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:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11: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:11: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:11:29 INFO - Using env: {'DISPLAY': ':0', 08:11:29 INFO - 'HOME': '/home/cltbld', 08:11:29 INFO - 'LANG': 'en_US.UTF-8', 08:11:29 INFO - 'LANGUAGE': 'en_US:en', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MAIL': '/var/mail/cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SHLVL': '1', 08:11:29 INFO - 'TERM': 'linux', 08:11:29 INFO - 'TMOUT': '86400', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - '_': '/tools/buildbot/bin/python'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 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:11:29 INFO - Cleaning up... 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11: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:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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', '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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:11: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 psutil>=3.1.1 08:11:29 INFO - Using env: {'DISPLAY': ':0', 08:11:29 INFO - 'HOME': '/home/cltbld', 08:11:29 INFO - 'LANG': 'en_US.UTF-8', 08:11:29 INFO - 'LANGUAGE': 'en_US:en', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MAIL': '/var/mail/cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SHLVL': '1', 08:11:29 INFO - 'TERM': 'linux', 08:11:29 INFO - 'TMOUT': '86400', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - '_': '/tools/buildbot/bin/python'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 INFO - Downloading/unpacking psutil>=3.1.1 08:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:29 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:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:31 INFO - Installing collected packages: psutil 08:11:31 INFO - Running setup.py install for psutil 08:11:31 INFO - building 'psutil._psutil_linux' extension 08:11:31 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:11:31 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:11:31 INFO - building 'psutil._psutil_posix' extension 08:11:31 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:11:31 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:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:32 INFO - Successfully installed psutil 08:11:32 INFO - Cleaning up... 08:11:32 INFO - Return code: 0 08:11:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11: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:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11: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:11: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:11:32 INFO - Using env: {'DISPLAY': ':0', 08:11:32 INFO - 'HOME': '/home/cltbld', 08:11:32 INFO - 'LANG': 'en_US.UTF-8', 08:11:32 INFO - 'LANGUAGE': 'en_US:en', 08:11:32 INFO - 'LOGNAME': 'cltbld', 08:11:32 INFO - 'MAIL': '/var/mail/cltbld', 08:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:32 INFO - 'MOZ_NO_REMOTE': '1', 08:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:32 INFO - 'NO_EM_RESTART': '1', 08:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:32 INFO - 'PWD': '/builds/slave/test', 08:11:32 INFO - 'SHELL': '/bin/bash', 08:11:32 INFO - 'SHLVL': '1', 08:11:32 INFO - 'TERM': 'linux', 08:11:32 INFO - 'TMOUT': '86400', 08:11:32 INFO - 'USER': 'cltbld', 08:11:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:32 INFO - '_': '/tools/buildbot/bin/python'} 08:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:34 INFO - Installing collected packages: mozsystemmonitor 08:11:34 INFO - Running setup.py install for mozsystemmonitor 08:11:34 INFO - Successfully installed mozsystemmonitor 08:11:34 INFO - Cleaning up... 08:11:34 INFO - Return code: 0 08:11:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:34 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:11:34 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:11:34 INFO - Using env: {'DISPLAY': ':0', 08:11:34 INFO - 'HOME': '/home/cltbld', 08:11:34 INFO - 'LANG': 'en_US.UTF-8', 08:11:34 INFO - 'LANGUAGE': 'en_US:en', 08:11:34 INFO - 'LOGNAME': 'cltbld', 08:11:34 INFO - 'MAIL': '/var/mail/cltbld', 08:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:34 INFO - 'MOZ_NO_REMOTE': '1', 08:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:34 INFO - 'NO_EM_RESTART': '1', 08:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:34 INFO - 'PWD': '/builds/slave/test', 08:11:34 INFO - 'SHELL': '/bin/bash', 08:11:34 INFO - 'SHLVL': '1', 08:11:34 INFO - 'TERM': 'linux', 08:11:34 INFO - 'TMOUT': '86400', 08:11:34 INFO - 'USER': 'cltbld', 08:11:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:34 INFO - '_': '/tools/buildbot/bin/python'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:34 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:11:34 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:11:34 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:11:34 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:11:34 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:11:34 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:11:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:36 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:11:36 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:11:36 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:11:36 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:11:36 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:11:36 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:11:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:36 INFO - warning: no files found matching '*.txt' 08:11:36 INFO - no previously-included directories found matching 'build' 08:11:36 INFO - no previously-included directories found matching 'dist' 08:11:36 INFO - no previously-included directories found matching '.git*' 08:11:36 INFO - Installing collected packages: jsonschema, functools32 08:11:36 INFO - Running setup.py install for functools32 08:11:36 INFO - warning: no files found matching '*.txt' 08:11:36 INFO - no previously-included directories found matching 'build' 08:11:36 INFO - no previously-included directories found matching 'dist' 08:11:36 INFO - no previously-included directories found matching '.git*' 08:11:36 INFO - Successfully installed jsonschema functools32 08:11:36 INFO - Cleaning up... 08:11:36 INFO - Return code: 0 08:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:36 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:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:36 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:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:36 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:36 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:11:36 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:11:36 INFO - Using env: {'DISPLAY': ':0', 08:11:36 INFO - 'HOME': '/home/cltbld', 08:11:36 INFO - 'LANG': 'en_US.UTF-8', 08:11:36 INFO - 'LANGUAGE': 'en_US:en', 08:11:36 INFO - 'LOGNAME': 'cltbld', 08:11:36 INFO - 'MAIL': '/var/mail/cltbld', 08:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:36 INFO - 'MOZ_NO_REMOTE': '1', 08:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:36 INFO - 'NO_EM_RESTART': '1', 08:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:36 INFO - 'PWD': '/builds/slave/test', 08:11:36 INFO - 'SHELL': '/bin/bash', 08:11:36 INFO - 'SHLVL': '1', 08:11:36 INFO - 'TERM': 'linux', 08:11:36 INFO - 'TMOUT': '86400', 08:11:36 INFO - 'USER': 'cltbld', 08:11:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:36 INFO - '_': '/tools/buildbot/bin/python'} 08:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:11: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:11: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:11: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:11: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:11: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:11: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:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:39 INFO - Downloading docopt-0.6.1.tar.gz 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:39 INFO - Running setup.py install for blobuploader 08:11:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:39 INFO - Running setup.py install for requests 08:11:40 INFO - Running setup.py install for docopt 08:11:40 INFO - Successfully installed blobuploader requests docopt 08:11:40 INFO - Cleaning up... 08:11:40 INFO - Return code: 0 08:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:40 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:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:40 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:11:40 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:11:40 INFO - Using env: {'DISPLAY': ':0', 08:11:40 INFO - 'HOME': '/home/cltbld', 08:11:40 INFO - 'LANG': 'en_US.UTF-8', 08:11:40 INFO - 'LANGUAGE': 'en_US:en', 08:11:40 INFO - 'LOGNAME': 'cltbld', 08:11:40 INFO - 'MAIL': '/var/mail/cltbld', 08:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:40 INFO - 'MOZ_NO_REMOTE': '1', 08:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:40 INFO - 'NO_EM_RESTART': '1', 08:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:40 INFO - 'PWD': '/builds/slave/test', 08:11:40 INFO - 'SHELL': '/bin/bash', 08:11:40 INFO - 'SHLVL': '1', 08:11:40 INFO - 'TERM': 'linux', 08:11:40 INFO - 'TMOUT': '86400', 08:11:40 INFO - 'USER': 'cltbld', 08:11:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:40 INFO - '_': '/tools/buildbot/bin/python'} 08:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:40 INFO - Running setup.py (path:/tmp/pip-w53Xao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:40 INFO - Running setup.py (path:/tmp/pip-2ZykTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:40 INFO - Running setup.py (path:/tmp/pip-JKJXbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:40 INFO - Running setup.py (path:/tmp/pip-cBuUc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:40 INFO - Running setup.py (path:/tmp/pip-Vi0BPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:40 INFO - Running setup.py (path:/tmp/pip-Ua4Lwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 INFO - Running setup.py (path:/tmp/pip-AD4FO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:41 INFO - Running setup.py (path:/tmp/pip-Rv6Kxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:41 INFO - Running setup.py (path:/tmp/pip-XXrggx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:41 INFO - Running setup.py (path:/tmp/pip-0aS0Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:41 INFO - Running setup.py (path:/tmp/pip-WK7ioO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:41 INFO - Running setup.py (path:/tmp/pip-ps2fA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:41 INFO - Running setup.py (path:/tmp/pip-cR9RiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:41 INFO - Running setup.py (path:/tmp/pip-B1Nevv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:41 INFO - Running setup.py (path:/tmp/pip-orX033-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:41 INFO - Running setup.py (path:/tmp/pip-8Lzj1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:41 INFO - Running setup.py (path:/tmp/pip-mKADuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:41 INFO - Running setup.py install for manifestparser 08:11:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:41 INFO - Running setup.py install for mozcrash 08:11:42 INFO - Running setup.py install for mozdebug 08:11:42 INFO - Running setup.py install for mozdevice 08:11:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozfile 08:11:42 INFO - Running setup.py install for mozhttpd 08:11:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozinfo 08:11:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozInstall 08:11:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozleak 08:11:42 INFO - Running setup.py install for mozlog 08:11:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for moznetwork 08:11:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozprocess 08:11:43 INFO - Running setup.py install for mozprofile 08:11:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozrunner 08:11:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozscreenshot 08:11:43 INFO - Running setup.py install for moztest 08:11:43 INFO - Running setup.py install for mozversion 08:11:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:43 INFO - Cleaning up... 08:11:43 INFO - Return code: 0 08:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:43 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:43 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:11:43 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:11:43 INFO - Using env: {'DISPLAY': ':0', 08:11:43 INFO - 'HOME': '/home/cltbld', 08:11:43 INFO - 'LANG': 'en_US.UTF-8', 08:11:43 INFO - 'LANGUAGE': 'en_US:en', 08:11:43 INFO - 'LOGNAME': 'cltbld', 08:11:43 INFO - 'MAIL': '/var/mail/cltbld', 08:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:43 INFO - 'MOZ_NO_REMOTE': '1', 08:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:43 INFO - 'NO_EM_RESTART': '1', 08:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:43 INFO - 'PWD': '/builds/slave/test', 08:11:43 INFO - 'SHELL': '/bin/bash', 08:11:43 INFO - 'SHLVL': '1', 08:11:43 INFO - 'TERM': 'linux', 08:11:43 INFO - 'TMOUT': '86400', 08:11:43 INFO - 'USER': 'cltbld', 08:11:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:43 INFO - '_': '/tools/buildbot/bin/python'} 08:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:43 INFO - Running setup.py (path:/tmp/pip-kzAZyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:43 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:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:43 INFO - Running setup.py (path:/tmp/pip-z5z6PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11: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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:44 INFO - Running setup.py (path:/tmp/pip-7fXyxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:44 INFO - Running setup.py (path:/tmp/pip-26zjcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:44 INFO - Running setup.py (path:/tmp/pip-cX2BuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:44 INFO - Running setup.py (path:/tmp/pip-667Q46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:44 INFO - Running setup.py (path:/tmp/pip-hj2ElK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:44 INFO - Running setup.py (path:/tmp/pip-0COPW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:44 INFO - Running setup.py (path:/tmp/pip-hi03eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:44 INFO - Running setup.py (path:/tmp/pip-kome41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:44 INFO - Running setup.py (path:/tmp/pip-TKYyyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:44 INFO - Running setup.py (path:/tmp/pip-fNzZIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:44 INFO - Running setup.py (path:/tmp/pip-tkPTSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:44 INFO - Running setup.py (path:/tmp/pip-vbNX3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:44 INFO - Running setup.py (path:/tmp/pip-W8MVEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:44 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:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:44 INFO - Running setup.py (path:/tmp/pip-H3LJFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11: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:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:45 INFO - Running setup.py (path:/tmp/pip-u9vhZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:46 INFO - Downloading blessings-1.6.tar.gz 08:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:47 INFO - Installing collected packages: blessings 08:11:47 INFO - Running setup.py install for blessings 08:11:47 INFO - Successfully installed blessings 08:11:47 INFO - Cleaning up... 08:11:47 INFO - Return code: 0 08:11:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:47 INFO - Reading from file tmpfile_stdout 08:11:47 INFO - Current package versions: 08:11:47 INFO - argparse == 1.2.1 08:11:47 INFO - blessings == 1.6 08:11:47 INFO - blobuploader == 1.2.4 08:11:47 INFO - docopt == 0.6.1 08:11:47 INFO - functools32 == 3.2.3-2 08:11:47 INFO - jsonschema == 2.5.1 08:11:47 INFO - manifestparser == 1.1 08:11:47 INFO - mozInstall == 1.12 08:11:47 INFO - mozcrash == 0.17 08:11:47 INFO - mozdebug == 0.1 08:11:47 INFO - mozdevice == 0.48 08:11:47 INFO - mozfile == 1.2 08:11:47 INFO - mozhttpd == 0.7 08:11:47 INFO - mozinfo == 0.9 08:11:47 INFO - mozleak == 0.1 08:11:47 INFO - mozlog == 3.2 08:11:47 INFO - moznetwork == 0.27 08:11:47 INFO - mozprocess == 0.22 08:11:47 INFO - mozprofile == 0.28 08:11:47 INFO - mozrunner == 6.11 08:11:47 INFO - mozscreenshot == 0.1 08:11:47 INFO - mozsystemmonitor == 0.3 08:11:47 INFO - moztest == 0.7 08:11:47 INFO - mozversion == 1.4 08:11:47 INFO - psutil == 3.1.1 08:11:47 INFO - requests == 1.2.3 08:11:47 INFO - wsgiref == 0.1.2 08:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:47 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:11:47 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:11:47 INFO - Using env: {'DISPLAY': ':0', 08:11:47 INFO - 'HOME': '/home/cltbld', 08:11:47 INFO - 'LANG': 'en_US.UTF-8', 08:11:47 INFO - 'LANGUAGE': 'en_US:en', 08:11:47 INFO - 'LOGNAME': 'cltbld', 08:11:47 INFO - 'MAIL': '/var/mail/cltbld', 08:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:47 INFO - 'MOZ_NO_REMOTE': '1', 08:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:47 INFO - 'NO_EM_RESTART': '1', 08:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:47 INFO - 'PWD': '/builds/slave/test', 08:11:47 INFO - 'SHELL': '/bin/bash', 08:11:47 INFO - 'SHLVL': '1', 08:11:47 INFO - 'TERM': 'linux', 08:11:47 INFO - 'TMOUT': '86400', 08:11:47 INFO - 'USER': 'cltbld', 08:11:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:47 INFO - '_': '/tools/buildbot/bin/python'} 08:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 INFO - Cleaning up... 08:11:47 INFO - Return code: 0 08:11:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:47 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:11:47 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:11:47 INFO - Using env: {'DISPLAY': ':0', 08:11:47 INFO - 'HOME': '/home/cltbld', 08:11:47 INFO - 'LANG': 'en_US.UTF-8', 08:11:47 INFO - 'LANGUAGE': 'en_US:en', 08:11:47 INFO - 'LOGNAME': 'cltbld', 08:11:47 INFO - 'MAIL': '/var/mail/cltbld', 08:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:47 INFO - 'MOZ_NO_REMOTE': '1', 08:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:47 INFO - 'NO_EM_RESTART': '1', 08:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:47 INFO - 'PWD': '/builds/slave/test', 08:11:47 INFO - 'SHELL': '/bin/bash', 08:11:47 INFO - 'SHLVL': '1', 08:11:47 INFO - 'TERM': 'linux', 08:11:47 INFO - 'TMOUT': '86400', 08:11:47 INFO - 'USER': 'cltbld', 08:11:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:47 INFO - '_': '/tools/buildbot/bin/python'} 08:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:47 INFO - Cleaning up... 08:11:47 INFO - Return code: 0 08:11:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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 0x7f848804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, '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': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', '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:11:47 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:11:47 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:11:47 INFO - Using env: {'DISPLAY': ':0', 08:11:47 INFO - 'HOME': '/home/cltbld', 08:11:47 INFO - 'LANG': 'en_US.UTF-8', 08:11:47 INFO - 'LANGUAGE': 'en_US:en', 08:11:47 INFO - 'LOGNAME': 'cltbld', 08:11:47 INFO - 'MAIL': '/var/mail/cltbld', 08:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:47 INFO - 'MOZ_NO_REMOTE': '1', 08:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:47 INFO - 'NO_EM_RESTART': '1', 08:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:47 INFO - 'PWD': '/builds/slave/test', 08:11:47 INFO - 'SHELL': '/bin/bash', 08:11:47 INFO - 'SHLVL': '1', 08:11:47 INFO - 'TERM': 'linux', 08:11:47 INFO - 'TMOUT': '86400', 08:11:47 INFO - 'USER': 'cltbld', 08:11:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:47 INFO - '_': '/tools/buildbot/bin/python'} 08:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:48 INFO - Downloading/unpacking flake8 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:11:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:11: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:11: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:11: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:11: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:11: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:11: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:11:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:11:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:11: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:11: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:11: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:11: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:11: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:11: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:11:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:11: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:11: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:11: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:11: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:11: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:11: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:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:11:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:50 INFO - no previously-included directories found matching 'docs/_build' 08:11:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:11:50 INFO - Running setup.py install for pep8 08:11:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:50 INFO - no previously-included directories found matching 'docs/_build' 08:11:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:11:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:11:50 INFO - Cleaning up... 08:11:51 INFO - Return code: 0 08:11:51 INFO - Running post-action listener: _resource_record_post_action 08:11:51 INFO - Running post-action listener: _start_resource_monitoring 08:11:51 INFO - Starting resource monitoring. 08:11:51 INFO - ##### 08:11:51 INFO - ##### Finished create-virtualenv step (success) 08:11:51 INFO - ##### 08:11:51 INFO - ##### 08:11:51 INFO - ##### Running install step. 08:11:51 INFO - ##### 08:11:51 INFO - Running pre-action listener: _resource_record_pre_action 08:11:51 INFO - Running main action method: install 08:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:51 INFO - Reading from file tmpfile_stdout 08:11:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:51 INFO - Reading from file tmpfile_stdout 08:11:51 INFO - Output received: 08:11:51 INFO - Usage: mozinstall [options] installer 08:11:51 INFO - Options: 08:11:51 INFO - -h, --help show this help message and exit 08:11:51 INFO - -d DEST, --destination=DEST 08:11:51 INFO - Directory to install application into. [default: 08:11:51 INFO - "/builds/slave/test"] 08:11:51 INFO - --app=APP Application being installed. [default: firefox] 08:11:51 INFO - mkdir: /builds/slave/test/build/application 08:11:51 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:11:51 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:12:08 INFO - Reading from file tmpfile_stdout 08:12:08 INFO - Output received: 08:12:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - ##### 08:12:08 INFO - ##### Finished install step (success) 08:12:08 INFO - ##### 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running run-tests step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: run_tests 08:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:08 INFO - Python 2.7.3 08:12:08 INFO - Return code: 0 08:12:08 INFO - grabbing minidump binary from tooltool 08:12:08 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:12:08 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 0x1446110>, '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 0x13b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:08 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:12:08 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:12:08 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:12:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:08 INFO - Return code: 0 08:12:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:12:09 INFO - Return code: 0 08:12:09 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:12:09 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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:12:09 INFO - Using env: {'DISPLAY': ':0', 08:12:09 INFO - 'HOME': '/home/cltbld', 08:12:09 INFO - 'LANG': 'en_US.UTF-8', 08:12:09 INFO - 'LANGUAGE': 'en_US:en', 08:12:09 INFO - 'LOGNAME': 'cltbld', 08:12:09 INFO - 'MAIL': '/var/mail/cltbld', 08:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:09 INFO - 'MOZ_NO_REMOTE': '1', 08:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:09 INFO - 'NO_EM_RESTART': '1', 08:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:09 INFO - 'PWD': '/builds/slave/test', 08:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:09 INFO - 'SHELL': '/bin/bash', 08:12:09 INFO - 'SHLVL': '1', 08:12:09 INFO - 'TERM': 'linux', 08:12:09 INFO - 'TMOUT': '86400', 08:12:09 INFO - 'USER': 'cltbld', 08:12:09 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261', 08:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:09 INFO - '_': '/tools/buildbot/bin/python'} 08:12:09 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:12:09 INFO - mozversion application_buildid: 20160620053002 08:12:09 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:12:09 INFO - mozversion application_display_name: Nightly 08:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:09 INFO - mozversion application_name: Firefox 08:12:09 INFO - mozversion application_remotingname: firefox 08:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:09 INFO - mozversion application_vendor: Mozilla 08:12:09 INFO - mozversion application_version: 50.0a1 08:12:09 INFO - mozversion platform_buildid: 20160620053002 08:12:09 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:09 INFO - mozversion platform_version: 50.0a1 08:12:09 INFO - using testdate: 1466435529 08:12:09 INFO - actual date: 1466435529 08:12:09 INFO - starting webserver on 'localhost:52810' 08:12:09 INFO - SUITE-START | Running 2 tests 08:12:09 INFO - TEST-START | dromaeo_css 08:12:09 INFO - operating with platform_type : linux_ 08:12:09 INFO - Initialising browser for dromaeo_css test... 08:12:09 INFO - TEST-INFO | started process 17422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXPYf1/profile http://localhost:52810/getInfo.html) 08:12:14 INFO - PROCESS | 17422 | __metrics Screen width/height:1600/1200 08:12:14 INFO - PROCESS | 17422 | colorDepth:24 08:12:14 INFO - PROCESS | 17422 | Browser inner width/height: 1024/697 08:12:14 INFO - PROCESS | 17422 | __metrics 08:12:14 INFO - PROCESS | 17422 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:15 INFO - TEST-INFO | 17422: exit 0 08:12:15 INFO - Browser initialized. 08:12:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:15 INFO - TEST-INFO | started process 17504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXPYf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:27 INFO - PROCESS | 17504 | RSS: Main: 173404160 08:12:27 INFO - PROCESS | 17504 | 08:13:18 INFO - PROCESS | 17504 | 1466435598315 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:15:26 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52810/tests/dromaeo/cssquery-ext.html) 08:15:28 INFO - PROCESS | 17504 | RSS: Main: 261406720 08:15:28 INFO - PROCESS | 17504 | 08:18:30 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-ext.html (next: http://localhost:52810/tests/dromaeo/cssquery-jquery.html) 08:18:30 INFO - PROCESS | 17504 | RSS: Main: 267902976 08:18:30 INFO - PROCESS | 17504 | 08:21:32 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52810/tests/dromaeo/cssquery-mootools.html) 08:21:33 INFO - PROCESS | 17504 | RSS: Main: 256053248 08:21:33 INFO - PROCESS | 17504 | 08:24:35 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52810/tests/dromaeo/cssquery-prototype.html) 08:24:35 INFO - PROCESS | 17504 | RSS: Main: 252088320 08:24:35 INFO - PROCESS | 17504 | 08:27:38 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52810/tests/dromaeo/cssquery-yui.html) 08:27:39 INFO - PROCESS | 17504 | RSS: Main: 242225152 08:27:39 INFO - PROCESS | 17504 | 08:30:41 INFO - PROCESS | 17504 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-yui.html (next: http://localhost:52810/tests/dromaeo/cssquery-dojo.html) 08:30:42 INFO - PROCESS | 17504 | RSS: Main: 296849408 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | __start_tp_report 08:30:42 INFO - PROCESS | 17504 | _x_x_mozilla_page_load 08:30:42 INFO - PROCESS | 17504 | _x_x_mozilla_page_load_details 08:30:42 INFO - PROCESS | 17504 | |i|pagename|runs| 08:30:42 INFO - PROCESS | 17504 | |0;dojo.html;3121.0480803354976;3122.2350524121593;3137.9058628241155;3147.291859331651;3160.97268387774;5305.389880163772;5368.919466208;5445.754941027653;5461.825707472897;5531.640443371178;5436.945630543693;5537.418571050032;5556.416576259485;5564.527015203703;5600.85997850054;4911.656184067117;4968.130577149002;4974.527419895104;4987.8254261100865;5158.43257241705;5074.112030394685;5075.6447048706605;5092.821751238707;5108.259302401149;5117.692938423688;4894.804207831682;4916.631252656065;4938.037082768861;4947.579455746266;4993.151164302078;4897.951020489821;4898.534639209305;4902.3626928499425;4916.336294600254;4978.278149668277;4948.1093403187415;4965.528274813923;4971.304017437562;4972.055309491185;4995.325631039836;5298.284731561228;5389.865253368658;5449.482299181572;5459.181122831567;5541.362743284493;5840.065589505702;5880.500157486619;5884.440978107073;5887.823365299005;5892.145638882381;5862.179294898718;5902.144189092601;5942.3760505146765;5949.791757288517;5952.285725712899;5323.44103869092;5409.350877894639;5473.972630136824;5477.233187353773;5551.861203469945;6059.971166748962;6061.058892093405;6062.354796503716;6101.664408457489;6111.786087487006;5594.496495315441;5789.218455508537;5835.533157347402;5841.620294680833;5842.328132264844;5761.452661997104;5794.768209271582;5813.12803079533;5844.240248767718;5845.88308233833;5822.883542329129;5826.941730582725;5832;5834.358220595731;5837.708114594253;5609.859753506195;5742.13867919807;5777;5832.88334233313;5852;4405.669574781904;4421.270490369117;4425.645948324126;4454.621357184611;4469.150861336336;3932.8230229639735;3946.5264168299414;3956.090099277182;3959.7030222732833;3984.5816189300285;5395.757190926418;5456.208849716769;5464.836054918359;5543.279373681396;5543.944560554342;5851.473367396869;5858.414158584107;5905.822825315161;5941.346451890288;5961.940380596226;5566.304211973504;5585.3297604287745;5586.190002449622;5588.888222235532;5590.860228494239;4957.157283261854;4987.102321582078;5107.055194788902;5112.846614601568;5161.974190129025;5947.31605865331;5969.074793407029;6012.518998480111;6024.277086749706;6079.787207447718;5847.298324201123;5858.326292476419;5858.355580886185;5861.325947515919;5894.086416605433;5912.172295878494;5956;5960;6000.849978750566;6035.728392222449;5771.307443106686;5794.82615521535;5802.5357971361345;5803.564732645153;5854.356020837789;5908.231929849092;5910.674912879833;5915.08316210988;5917.556183286185;5927.436893495111;5549.278593782782;5644.802431915027;5684.772609095755;5694.658320500783;5721.027425337619;5745.626534275259;5745.6552606843725;5747.655140691572;5751.74117164737;5751.971240143773;5662.8301150965535;5670.744816483186;5671.149327600893;5675.404082571271;5675.517581005495;5649.039663257338;5694.743736531783;5779.8555036124435;5790.39200883918;5862.032764593794;5639.689817060101;5663.915041274302;5667.2349232854685;5680.630759000652;5681.488666020078 08:30:42 INFO - PROCESS | 17504 | |1;ext.html;591.1930215256176;604.0214851939855;621.7979156774048;640.6860638287241;644.0596728775986;30824.53763193551;42840;43626.34560481588;43702.12595748083;43830.56169438309;44157.55842441574;44428.555714442846;44596.10807783842;44684.55315446845;44738.77630611842;8795.208431241186;9000.729978100635;9013.188813006827;9015.504147271897;9023.323250756186;8801.559922003906;8893.28853691703;8900.554972251393;8901.599428025755;8902.109789021111;8924.419912705653;8953.955230223839;8963.058878817728;8968.192862642361;8970.102989701043;8887.95556022219;8897;8918.331125165607;8925.553722313858;8930.419522731067;8838.381313308071;8916.910830891673;8917.197452229331;8917.643294268222;8918.063603321623;42194.78902605498;42580;42594.361084583754;42615.7869210652;42741;3659.8902032939054;3753.174301653632;3767.416050512175;4023.577524359929;4181.435506206684;32313.51529727056;32640.347193056004;33143.33713325744;33196.3360732784;33249.501257481155;4414.4040554525045;4494.617957473619;4532.88667783308;4658.930116048262;4659;329737;329929;330105;330585;331156;55585.44414555884;55997.44002560004;56063;56591;56699;59756;60024;60041.09527404317;60204.698976504835;60229;14905.478308259158;15095.698086038217;15119.848801512064;15122.621934451727;15139.848601514064;11257.605983790692;11340.886591134147;11356.148288878201;11360.20478566509;11371.431428428545;14652.267386630625;16590.419335323204;16611.584710382336;16708.6658266834;16801.24394402255;5201.803585175431;6176.474999624992;6183.96908015457;6244;6402.871942561216;962.3888830592624;1018.3279035836313;1039.184240371305;1078.5955266774959;1100.9284396514201;32240.83879580587;32749;32928;33038;33297.334053318795;1079.7030816525362;1089.2048804372853;1093.2620481175175;1094.370736826328;1121.170333952869;16835.494935151964;17274;17389.391371301943;17444.738328925076;17472.611820528702;529828;533376;537038;537189;538415;57104;57525;57557.13664295039;57596.136057959164;57672;1205.0781152418408;1296.2352212194662;1303.2376060004813;1313.7175507265983;1366.1666383506251;32132;33368.833155834065;33521.66478335283;33757.35505700487;33944.60553944586;49167;49759.253611195134;49888.75055624699;49889.251661224385;49907.75046124746;390669;391092;392810;393352;393483;34734.87770285382;37060.81469592635;44753.55246447494;45260.773696131306;45980;47209;47825;48368.51631483781;48601.75699121482;49015.26477102775;40620;41268.79365603153;41333.58666413297;42254.78872605618;42422.787886060374;40359;41182.588174117875;41257.793711031256;41376.621039264704;42274.36588451237;39871.80064099777;40427;41501.58498415098;41591.58408415877;41642.375364370164;34435;36216.63783362238;36413.08967275839;36789.63210367862;37273.440898386005;27398.315042124108;27541.31146721348;28021.579676304464;28192.436151276448;28253.293667658472 08:30:42 INFO - PROCESS | 17504 | |2;jquery.html;384.7691385168897;385.863018628387;390.30720471163664;408.88142438692773;412.97728624925634;14449.494267700633;16833.579160520963;18166;19935.501612459695;20011;17645.647087058253;18133.909330453364;18663.626727465442;18800.62398752024;18877;5074.086664400406;5171.224316352549;5244.973775131138;5290.761915713783;5321.840344789663;3836.4245363195605;5183.896322073556;5219.739013049351;5235.79056837728;5525.336959564858;5751.827445176651;5847.122931560258;5856.648601083927;5870.73581688825;5873.030949893263;5621.156826476041;5768.769249230026;5801.071828507461;5813.825585232428;5847.912281315784;5585.497305242548;5605.383407825136;5607.915881261784;5624.268845050158;5634.577406694473;13809.792853107212;14747.705045899129;22423.99092040862;22572.661410078697;22984.54030919389;2260.4059545322853;2319.431739223884;2322.605157123276;2467.6915385576804;2892.6239588853314;10090.19278457729;10152.441615711134;10471.63349282779;10679.145668346591;10758.462076896123;1848.3900312896712;1898.8955607441585;1913.4068438784022;1937.060525645061;1950.6878899376175;82601.58699206526;87193.12806871913;87340;87638.56180719056;88559.55720221357;10367;10371.792564148825;10408.167346612252;10450;10658.413787241621;13846.238456884766;14200.928995354958;14241.857581424054;14274.857251427353;14361.066530675473;7782.571958542221;8074.636641351153;8115.8782618260775;8187.017557893091;8263.628136733862;7404.592747398837;7478.2147874473485;7526.6989320427665;7607.087149542091;7611.086669599684;4934.284528743384;4955.72743499111;4956.553910148104;4963.553280204799;5002.924956125588;1966.557524556992;1991.2333751505485;1995.1520603743352;2006.187494064906;2012.759457273788;930.1489137439303;934.8971613122551;954.9092836180552;978.7553111722069;1027.2860362048455;19304.420867374;19805.900970495055;20021.399358019284;20367;20470.59058818815;922.4511415707643;956;958.9664361747306;1014.4116412480744;1031.9071283584362;10957.83563246552;11238.438078096062;11269.492872820743;11309.94345028286;11397.259178153394;375713;376786;377472;495650;518022;93622.53188734013;100136;102040.22788510255;104147.4792626032;107271;1025.1696126137704;1025.8153532364097;1027.8098551767798;1073.2487258918788;1080.206048554312;17980.460586182435;18081;18450.35423760162;18716.377950404552;18749.34377296788;39873.401898972115;44210;45079.77460112678;45186.09627807491;45393.36853051682;53371;58278.70860645839;60256.39743602683;60720;61171;5889.587728858939;8514.957425212835;8775.210231078978;9032.136611561878;9185.908140918506;11946.342951137423;13934.860651393356;14086.577402677936;14244.71510569762;14415.639609009859;11577.07383409342;11911.76176476483;12421.565245216374;12430.440630171483;12587.559435420082;11291.830622540832;11640.88359116398;11826.586069487526;12117.667056623588;12634.368281586068;12201.14591978553;12455.93772031134;12507.124501284823;12521.37393130358;12742.362881856056;8727.781805454915;8943.776405589912;9010.90989090127;9138.634454622006;9324.393914395543;8961;11633.6509904703;12107.818382724443;12108.21296615717;12154.817677734663 08:30:42 INFO - PROCESS | 17504 | |3;mootools.html;1334.9666258343545;1437;1466.794648749175;1584.8335924727903;1743.5205318537392;8365.790855228615;8699.913000869989;8714.041455439896;9075.183233508982;9087.227585655211;8763.956180219106;8985.640574377034;8994.4153630014;9001.594928228229;9006.234470070052;2020.05057622917;2261.502469456717;2321.3036089173265;2361.4332560185517;2365.9763402366016;2347.190219374313;2418.6372044193336;2418.6492958521003;2419.697537807774;2420.8668523231304;2326.150954901457;2347.190219374313;2352.529494101178;2354.0113152476;2358.6815779869758;1987.3441764217846;2226.832987525942;2242.674812152237;2292.495650956787;2300.033985725999;2291.7822806833324;2302.033146078634;2309.7574754650686;2310.0413328468667;2316.3514216019544;8763.912360876373;8847.20375166238;8847.247983921374;8860.158284962918;8871.689490867853;4988.251762235657;5145.871353216162;5180.533751962342;5186.455422180692;5190.11767999441;3254.3979363817534;3283.9014829555153;3417.8974630761118;3435.175557866119;3437.071990562559;1175.670812172593;1190.4761904761876;1197.3235122155954;1224.4918358881055;1232.6856651553885;12123.151379403445;12370.75258494834;12376.267322574757;12413.999999999909;12449.439775210047;4556.248219043887;4576.313552967082;4658.976705116453;4663.673542852036;4710.387649605529;10251.897481025095;10279;10282.640107596348;10284.125849302744;10315.12321452685;5200.817971370984;5208.322918020633;5208.713520756395;5212.50481204285;5213.113770658997;4402.757848318309;4731.810727570927;4855.611551075976;4857.125717370907;4928.310036594879;3966.206758648224;4014.959850401517;4075.9796201018803;4090.1819636072905;4099.590040995936;1301.076235872541;1304.5694920676153;1331.2877610478347;1333.8199343088752;1344;965.2181732796457;983.9704808855746;989.8020395920845;997.7056768253383;1007.8236308645958;6195.4424101831055;6276.309605943343;6309.116723658692;6426.068220108058;6453.580517266362;1009.3943633819649;1043.5669197283194;1063.2557209952909;1087.9619213327496;1091.6288461922984;4301.0322677397335;4356.106998065389;4380.890477738082;4387.6270517006415;4387.934180987288;10473.68578942633;10917.890821091687;11174.10607151426;11247.550097996153;11298.7175320616;10968.506417211245;11293;11300.265482743594;11321.264117832314;11325.603603873826;7922.762317130495;8098.676052957816;8110.43226974118;8122.553259570662;8124.796880078045;6194.473469755121;6364.172657554488;6376.585521941244;6442.613443193423;6557.442617377576;9673.226141908772;9986.051325124101;10240.231982601186;10362.119219866396;10369.325993810378;10436.63471778484;10612;10636.734081648021;10636.89363106359;10758.354498729788;7898.091719452107;7904.407169462428;7968.601569921597;8004.959975200087;8017.518948862854;8382.664693412195;8434.24091831738;8434.831303374021;8445.957770211355;8450.830983380421;7277;7391.963040184764;7435.776926692208;7460.738874139379;7515.774526764206;7502.887456688045;7571.280728330799;7614.5811980339395;7719.421043421654;7729.884051739116;6952.791416257521;6958.269381714847;7039.120109986252;7042.295770423121;7043.859122817617;5147.948520514747;5194.714290713896;5277.868053298698;5289.20661900718;5294.020606187868;5070.645054846273;5094.2867998479505;5103.464136265788;5195.220716892345;5449.23710680513 08:30:42 INFO - PROCESS | 17504 | |4;prototype.html;325.79637726420987;329.615997363072;335.53528363216947;336.5254990463447;339.58061793684794;5195.636305458619;5200.323957885475;5255.185446255827;5288.805145864467;5298.7350632468415;5151.227315902616;5205.869853253661;5214.06146893559;5215.791368345271;5224.817131400392;4020.6381425671684;4130.917381652365;4155.62599366057;4159.835246131088;4169.207850508394;4071.5928407159345;4126.360414135814;4127.917441651165;4128.050548373876;4136.21411931732;4085.632293093621;4114.136031433402;4116.094459218967;4132.995497183863;4140.834366625331;3912.158885839544;4033.576474470168;4034.789563131049;4040.636342729139;4123.649489793371;3495;3544.769589976643;3657.0491672165163;3666.6883314918264;3682.913540505557;5065.620078494091;5082.872928176788;5085.084684756743;5093.465186155438;5139.897202055975;4500.44734566574;4669.32294817253;4675.812967481296;4677.766111694402;4680.531946805292;5317.494837990384;5493.560515158778;5496.108463467517;5510.476504732044;5519.503244707956;4037.777922214277;4039.8890305166315;4043.433919251307;4048.9595104048876;4049.514058312992;5279.63042587019;5444.50999410055;5649.745761440704;5751.223584816038;5754.539636829044;4060.2488539620263;4097.631213190827;4108.938365924513;4116.629503344713;4124.587541245852;4098.590140985937;4144.378343248537;4144.48193975753;4147.3986271991;4162.501499460192;4394.494633117232;4671.462781780071;4682.204025315705;4684.414448193976;4691.601213896857;5406.162044883049;5420.322459692538;5422.593305502024;5445.863853403696;5447.700376479332;1387.5074348606302;1405.4940221520244;1409.1474657832068;1409.7180563887264;1418.453895250336;882.803800849852;903.4353529044347;923.1276443760581;923.2291036984193;923.8752768376183;4675.509071547439;4726.905461890812;4746.670932139006;4769.856904292877;4792.209285467929;4965.875853103701;4993.226049962262;5011.323471331397;5046.823361182341;5056.91276375581;4725.763711814396;4729.43246810385;4741.202690412673;4764.190087685102;4966.404031516241;2962.563156868917;2964.8221106733236;2983.34366439383;2991.7756168287465;2996.895108671186;5713.514351280188;5768.307803063575;5827.533797296206;5834.3745314608595;5840.561957853178;5544.667319960815;5736.541076713853;5758.798442054592;5760.164776107441;5791.913121303184;5733.713314334266;5743.712814359265;5751.453611906779;5759.761651245002;5759.94240057594;5355.902040081696;5579.972100139474;5584.86037849057;5620.831375058755;5633.943660563342;5521.199426083276;5537.086380747131;5540.833774986596;5557.3331200256225;5563.221149039056;5418.566514678738;5505.229267902577;5679.864027194661;5714.257146570919;5774;4115.36211887158;4128.690348223835;4132.896677583084;4141.585841415835;4148.460700109087;5310.2831117798605;5544.473275038865;5569.577233903103;5601.5238704710555;5605.439456054525;5465.808696695596;5475.342958844804;5507.917381239205;5541.667499950016;5568.220449137043;5511.889762204653;5540.501354878081;5555.50000499957;5568.470995255444;5579.107342825128;5258.684478931276;5455.454454554513;5471.480209380103;5482.697267147728;5483.396826349019;5471.507564319071;5534.723263836872;5552.111662134201;5568.415316391721;5577.8047768327915;5394.460553944731;5397.3552959049;5422.240886275846;5424.477617907534;5429.701366424884 08:30:42 INFO - PROCESS | 17504 | |5;yui.html;777.7938846205756;779.407650185859;780.4575819805237;794.7417089445928;817.4849844597902;14672.11967281964;14675.779863302045;14982.775258371106;15022.699546009087;15030.624234394145;14028.438862445515;14482.275886205674;15058.849411505882;15074.3216555255;15095.698086038272;629.766986215101;754.781113477091;761.2007392238141;784.6978913118462;790.4190420041265;755.7392699518684;774.4965772248056;775.9650815713278;776.6582703610421;776.8174478997431;820.1306614988102;823.7611092783086;823.9958800205991;824.1675907333577;824.2046425199682;662.6885363878945;761.8362052158757;774.2373761844578;823.2138307915926;825.1336097098053;580.4891695308102;581.5870731780441;581.6190395291048;582.2925145947652;584.0975692555013;14539.200343981076;14588.197649129293;14611.63470913225;14615.707685846224;14616.561503154817;13737;14343.067700599531;14573;14638.853611463855;14712.55862324132;12569.811452828215;12875.098743087987;12948.352582370939;12948.48206071756;13040.673983150402;4450.287953927356;4451.977740111279;4487.865364039051;4515.977420112911;4570.9314360284625;76367;80587;80834;81775;82081;11228;11263.549458021751;11265.493052812642;11380.322688372013;11573.305601663758;20767.376978690663;20854;20943.47641308949;20961;21322.893385532974;8114.756557303291;8443.282321002784;8507.149285071444;8703.086175951561;8807.119288071142;4886.047220791911;4900.558949694545;4933.703977761345;4996.425411077773;5019.899602007939;3198.0885447647775;3325.0523600773663;3325.617553981323;3337.7997320160866;3343.114074770188;574.5432381256911;593.0748033068427;594.028762972543;598.0282041682266;615.5814046448459;687.9749173731204;694.5936627073219;709.4537206351081;721.1814590439784;728.0389885351285;9706.174975127193;9845.310828241954;9850.162736167362;9925.702228933143;9932.155766759906;664.1266734244454;676.577139287945;690.4545409126835;693.3309356471029;697.6197972105215;4314.266574682311;4593.563611456906;4600.976995115003;4607.815687372467;4618.330342100444;67937;87375.56312218399;116199;118579.40710296393;118600.40699796446;103671;105086.4745676282;105116;105612.47193763981;106013;89937.55031224932;93545;94695;95663.52168239115;96417;8645.524496152771;8699.91300086991;8736.825263494822;8756.25571826402;9005.684801031932;42646.57353426426;54622.726886365315;55350.72324638351;55456.72271638616;57587;72105.63947180231;79080.20919790959;79437;80995.59502202451;81075.59462202652;11726.530938762695;12056.397180141134;12242.387880606113;12335.321557314433;12421.254724716546;14969.625759356104;15188.544343669708;15677.05937643745;15939.282732276843;16570.17149142514;11310.660680179608;11610.187286889837;14604.561863144123;15399.846001539841;15602.531924042298;13717.725645486835;13771.931140344233;14210.502632407815;14812.62968425798;15491;14508.85491145075;14540.41838326455;14553.417863285773;14658;15548.378064877279;11584.304941703525;11711.238769479956;12008.75982480363;12325;12426.440810163384;12049.939750301193;12258.325792081521;12335.734000129853;12456.377181140726;12458.252504849375 08:30:42 INFO - PROCESS | 17504 | __end_tp_report 08:30:42 INFO - PROCESS | 17504 | __start_cc_report 08:30:42 INFO - PROCESS | 17504 | _x_x_mozilla_cycle_collect,1015 08:30:42 INFO - PROCESS | 17504 | __end_cc_report 08:30:42 INFO - PROCESS | 17504 | __startTimestamp1466436642089__endTimestamp 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | ------- Summary: start ------- 08:30:42 INFO - PROCESS | 17504 | Number of tests: 6 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#0] dojo.html Cycles:165 Average:5437.86 Median:5663.92 stddev:626.39 (11.1%) stddev-sans-first:601.37 08:30:42 INFO - PROCESS | 17504 | Values: 3121.0 3122.2 3137.9 3147.3 3161.0 5305.4 5368.9 5445.8 5461.8 5531.6 5436.9 5537.4 5556.4 5564.5 5600.9 4911.7 4968.1 4974.5 4987.8 5158.4 5074.1 5075.6 5092.8 5108.3 5117.7 4894.8 4916.6 4938.0 4947.6 4993.2 4898.0 4898.5 4902.4 4916.3 4978.3 4948.1 4965.5 4971.3 4972.1 4995.3 5298.3 5389.9 5449.5 5459.2 5541.4 5840.1 5880.5 5884.4 5887.8 5892.1 5862.2 5902.1 5942.4 5949.8 5952.3 5323.4 5409.4 5474.0 5477.2 5551.9 6060.0 6061.1 6062.4 6101.7 6111.8 5594.5 5789.2 5835.5 5841.6 5842.3 5761.5 5794.8 5813.1 5844.2 5845.9 5822.9 5826.9 5832.0 5834.4 5837.7 5609.9 5742.1 5777.0 5832.9 5852.0 4405.7 4421.3 4425.6 4454.6 4469.2 3932.8 3946.5 3956.1 3959.7 3984.6 5395.8 5456.2 5464.8 5543.3 5543.9 5851.5 5858.4 5905.8 5941.3 5961.9 5566.3 5585.3 5586.2 5588.9 5590.9 4957.2 4987.1 5107.1 5112.8 5162.0 5947.3 5969.1 6012.5 6024.3 6079.8 5847.3 5858.3 5858.4 5861.3 5894.1 5912.2 5956.0 5960.0 6000.8 6035.7 5771.3 5794.8 5802.5 5803.6 5854.4 5908.2 5910.7 5915.1 5917.6 5927.4 5549.3 5644.8 5684.8 5694.7 5721.0 5745.6 5745.7 5747.7 5751.7 5752.0 5662.8 5670.7 5671.1 5675.4 5675.5 5649.0 5694.7 5779.9 5790.4 5862.0 5639.7 5663.9 5667.2 5680.6 5681.5 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#1] ext.html Cycles:180 Average:58588.82 Median:42264.58 stddev:113331.22 (268.1%) stddev-sans-first:113565.49 08:30:42 INFO - PROCESS | 17504 | Values: 591.2 604.0 621.8 640.7 644.1 30824.5 42840.0 43626.3 43702.1 43830.6 44157.6 44428.6 44596.1 44684.6 44738.8 8795.2 9000.7 9013.2 9015.5 9023.3 8801.6 8893.3 8900.6 8901.6 8902.1 8924.4 8954.0 8963.1 8968.2 8970.1 8888.0 8897.0 8918.3 8925.6 8930.4 8838.4 8916.9 8917.2 8917.6 8918.1 42194.8 42580.0 42594.4 42615.8 42741.0 3659.9 3753.2 3767.4 4023.6 4181.4 32313.5 32640.3 33143.3 33196.3 33249.5 4414.4 4494.6 4532.9 4658.9 4659.0 329737.0 329929.0 330105.0 330585.0 331156.0 55585.4 55997.4 56063.0 56591.0 56699.0 59756.0 60024.0 60041.1 60204.7 60229.0 14905.5 15095.7 15119.8 15122.6 15139.8 11257.6 11340.9 11356.1 11360.2 11371.4 14652.3 16590.4 16611.6 16708.7 16801.2 5201.8 6176.5 6184.0 6244.0 6402.9 962.4 1018.3 1039.2 1078.6 1100.9 32240.8 32749.0 32928.0 33038.0 33297.3 1079.7 1089.2 1093.3 1094.4 1121.2 16835.5 17274.0 17389.4 17444.7 17472.6 529828.0 533376.0 537038.0 537189.0 538415.0 57104.0 57525.0 57557.1 57596.1 57672.0 1205.1 1296.2 1303.2 1313.7 1366.2 32132.0 33368.8 33521.7 33757.4 33944.6 49167.0 49759.3 49888.8 49889.3 49907.8 390669.0 391092.0 392810.0 393352.0 393483.0 34734.9 37060.8 44753.6 45260.8 45980.0 47209.0 47825.0 48368.5 48601.8 49015.3 40620.0 41268.8 41333.6 42254.8 42422.8 40359.0 41182.6 41257.8 41376.6 42274.4 39871.8 40427.0 41501.6 41591.6 41642.4 34435.0 36216.6 36413.1 36789.6 37273.4 27398.3 27541.3 28021.6 28192.4 28253.3 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#2] jquery.html Cycles:180 Average:27683.50 Median:12622.47 stddev:72298.85 (572.8%) stddev-sans-first:72472.61 08:30:42 INFO - PROCESS | 17504 | Values: 384.8 385.9 390.3 408.9 413.0 14449.5 16833.6 18166.0 19935.5 20011.0 17645.6 18133.9 18663.6 18800.6 18877.0 5074.1 5171.2 5245.0 5290.8 5321.8 3836.4 5183.9 5219.7 5235.8 5525.3 5751.8 5847.1 5856.6 5870.7 5873.0 5621.2 5768.8 5801.1 5813.8 5847.9 5585.5 5605.4 5607.9 5624.3 5634.6 13809.8 14747.7 22424.0 22572.7 22984.5 2260.4 2319.4 2322.6 2467.7 2892.6 10090.2 10152.4 10471.6 10679.1 10758.5 1848.4 1898.9 1913.4 1937.1 1950.7 82601.6 87193.1 87340.0 87638.6 88559.6 10367.0 10371.8 10408.2 10450.0 10658.4 13846.2 14200.9 14241.9 14274.9 14361.1 7782.6 8074.6 8115.9 8187.0 8263.6 7404.6 7478.2 7526.7 7607.1 7611.1 4934.3 4955.7 4956.6 4963.6 5002.9 1966.6 1991.2 1995.2 2006.2 2012.8 930.1 934.9 954.9 978.8 1027.3 19304.4 19805.9 20021.4 20367.0 20470.6 922.5 956.0 959.0 1014.4 1031.9 10957.8 11238.4 11269.5 11309.9 11397.3 375713.0 376786.0 377472.0 495650.0 518022.0 93622.5 100136.0 102040.2 104147.5 107271.0 1025.2 1025.8 1027.8 1073.2 1080.2 17980.5 18081.0 18450.4 18716.4 18749.3 39873.4 44210.0 45079.8 45186.1 45393.4 53371.0 58278.7 60256.4 60720.0 61171.0 5889.6 8515.0 8775.2 9032.1 9185.9 11946.3 13934.9 14086.6 14244.7 14415.6 11577.1 11911.8 12421.6 12430.4 12587.6 11291.8 11640.9 11826.6 12117.7 12634.4 12201.1 12455.9 12507.1 12521.4 12742.4 8727.8 8943.8 9010.9 9138.6 9324.4 8961.0 11633.7 12107.8 12108.2 12154.8 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#3] mootools.html Cycles:180 Average:5861.29 Median:4566.28 stddev:3326.48 (72.8%) stddev-sans-first:3318.41 08:30:42 INFO - PROCESS | 17504 | Values: 1335.0 1437.0 1466.8 1584.8 1743.5 8365.8 8699.9 8714.0 9075.2 9087.2 8764.0 8985.6 8994.4 9001.6 9006.2 2020.1 2261.5 2321.3 2361.4 2366.0 2347.2 2418.6 2418.6 2419.7 2420.9 2326.2 2347.2 2352.5 2354.0 2358.7 1987.3 2226.8 2242.7 2292.5 2300.0 2291.8 2302.0 2309.8 2310.0 2316.4 8763.9 8847.2 8847.2 8860.2 8871.7 4988.3 5145.9 5180.5 5186.5 5190.1 3254.4 3283.9 3417.9 3435.2 3437.1 1175.7 1190.5 1197.3 1224.5 1232.7 12123.2 12370.8 12376.3 12414.0 12449.4 4556.2 4576.3 4659.0 4663.7 4710.4 10251.9 10279.0 10282.6 10284.1 10315.1 5200.8 5208.3 5208.7 5212.5 5213.1 4402.8 4731.8 4855.6 4857.1 4928.3 3966.2 4015.0 4076.0 4090.2 4099.6 1301.1 1304.6 1331.3 1333.8 1344.0 965.2 984.0 989.8 997.7 1007.8 6195.4 6276.3 6309.1 6426.1 6453.6 1009.4 1043.6 1063.3 1088.0 1091.6 4301.0 4356.1 4380.9 4387.6 4387.9 10473.7 10917.9 11174.1 11247.6 11298.7 10968.5 11293.0 11300.3 11321.3 11325.6 7922.8 8098.7 8110.4 8122.6 8124.8 6194.5 6364.2 6376.6 6442.6 6557.4 9673.2 9986.1 10240.2 10362.1 10369.3 10436.6 10612.0 10636.7 10636.9 10758.4 7898.1 7904.4 7968.6 8005.0 8017.5 8382.7 8434.2 8434.8 8446.0 8450.8 7277.0 7392.0 7435.8 7460.7 7515.8 7502.9 7571.3 7614.6 7719.4 7729.9 6952.8 6958.3 7039.1 7042.3 7043.9 5147.9 5194.7 5277.9 5289.2 5294.0 5070.6 5094.3 5103.5 5195.2 5449.2 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#4] prototype.html Cycles:180 Average:4578.62 Median:5173.43 stddev:1327.37 (25.7%) stddev-sans-first:1292.14 08:30:42 INFO - PROCESS | 17504 | Values: 325.8 329.6 335.5 336.5 339.6 5195.6 5200.3 5255.2 5288.8 5298.7 5151.2 5205.9 5214.1 5215.8 5224.8 4020.6 4130.9 4155.6 4159.8 4169.2 4071.6 4126.4 4127.9 4128.1 4136.2 4085.6 4114.1 4116.1 4133.0 4140.8 3912.2 4033.6 4034.8 4040.6 4123.6 3495.0 3544.8 3657.0 3666.7 3682.9 5065.6 5082.9 5085.1 5093.5 5139.9 4500.4 4669.3 4675.8 4677.8 4680.5 5317.5 5493.6 5496.1 5510.5 5519.5 4037.8 4039.9 4043.4 4049.0 4049.5 5279.6 5444.5 5649.7 5751.2 5754.5 4060.2 4097.6 4108.9 4116.6 4124.6 4098.6 4144.4 4144.5 4147.4 4162.5 4394.5 4671.5 4682.2 4684.4 4691.6 5406.2 5420.3 5422.6 5445.9 5447.7 1387.5 1405.5 1409.1 1409.7 1418.5 882.8 903.4 923.1 923.2 923.9 4675.5 4726.9 4746.7 4769.9 4792.2 4965.9 4993.2 5011.3 5046.8 5056.9 4725.8 4729.4 4741.2 4764.2 4966.4 2962.6 2964.8 2983.3 2991.8 2996.9 5713.5 5768.3 5827.5 5834.4 5840.6 5544.7 5736.5 5758.8 5760.2 5791.9 5733.7 5743.7 5751.5 5759.8 5759.9 5355.9 5580.0 5584.9 5620.8 5633.9 5521.2 5537.1 5540.8 5557.3 5563.2 5418.6 5505.2 5679.9 5714.3 5774.0 4115.4 4128.7 4132.9 4141.6 4148.5 5310.3 5544.5 5569.6 5601.5 5605.4 5465.8 5475.3 5507.9 5541.7 5568.2 5511.9 5540.5 5555.5 5568.5 5579.1 5258.7 5455.5 5471.5 5482.7 5483.4 5471.5 5534.7 5552.1 5568.4 5577.8 5394.5 5397.4 5422.2 5424.5 5429.7 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - PROCESS | 17504 | [#5] yui.html Cycles:180 Average:21183.74 Median:4597.27 stddev:30468.58 (662.8%) stddev-sans-first:30515.52 08:30:42 INFO - PROCESS | 17504 | Values: 777.8 779.4 780.5 794.7 817.5 14672.1 14675.8 14982.8 15022.7 15030.6 14028.4 14482.3 15058.8 15074.3 15095.7 629.8 754.8 761.2 784.7 790.4 755.7 774.5 776.0 776.7 776.8 820.1 823.8 824.0 824.2 824.2 662.7 761.8 774.2 823.2 825.1 580.5 581.6 581.6 582.3 584.1 14539.2 14588.2 14611.6 14615.7 14616.6 13737.0 14343.1 14573.0 14638.9 14712.6 12569.8 12875.1 12948.4 12948.5 13040.7 4450.3 4452.0 4487.9 4516.0 4570.9 76367.0 80587.0 80834.0 81775.0 82081.0 11228.0 11263.5 11265.5 11380.3 11573.3 20767.4 20854.0 20943.5 20961.0 21322.9 8114.8 8443.3 8507.1 8703.1 8807.1 4886.0 4900.6 4933.7 4996.4 5019.9 3198.1 3325.1 3325.6 3337.8 3343.1 574.5 593.1 594.0 598.0 615.6 688.0 694.6 709.5 721.2 728.0 9706.2 9845.3 9850.2 9925.7 9932.2 664.1 676.6 690.5 693.3 697.6 4314.3 4593.6 4601.0 4607.8 4618.3 67937.0 87375.6 116199.0 118579.4 118600.4 103671.0 105086.5 105116.0 105612.5 106013.0 89937.6 93545.0 94695.0 95663.5 96417.0 8645.5 8699.9 8736.8 8756.3 9005.7 42646.6 54622.7 55350.7 55456.7 57587.0 72105.6 79080.2 79437.0 80995.6 81075.6 11726.5 12056.4 12242.4 12335.3 12421.3 14969.6 15188.5 15677.1 15939.3 16570.2 11310.7 11610.2 14604.6 15399.8 15602.5 13717.7 13771.9 14210.5 14812.6 15491.0 14508.9 14540.4 14553.4 14658.0 15548.4 11584.3 11711.2 12008.8 12325.0 12426.4 12049.9 12258.3 12335.7 12456.4 12458.3 08:30:42 INFO - PROCESS | 17504 | -------- Summary: end -------- 08:30:42 INFO - PROCESS | 17504 | 08:30:42 INFO - TEST-INFO | 17504: exit 0 08:30:42 INFO - TEST-OK | dromaeo_css | took 1113226ms 08:30:42 INFO - TEST-START | kraken 08:30:42 INFO - operating with platform_type : linux_ 08:30:42 INFO - Initialising browser for kraken test... 08:30:42 INFO - TEST-INFO | started process 17690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGVTIMk/profile http://localhost:52810/getInfo.html) 08:30:46 INFO - PROCESS | 17690 | __metrics Screen width/height:1600/1200 08:30:46 INFO - PROCESS | 17690 | colorDepth:24 08:30:46 INFO - PROCESS | 17690 | Browser inner width/height: 1024/697 08:30:46 INFO - PROCESS | 17690 | __metrics 08:30:47 INFO - PROCESS | 17690 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:48 INFO - TEST-INFO | 17690: exit 0 08:30:48 INFO - Browser initialized. 08:30:48 INFO - Running cycle 1/1 for kraken test... 08:30:48 INFO - TEST-INFO | started process 17772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGVTIMk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:00 INFO - PROCESS | 17772 | RSS: Main: 174206976 08:31:00 INFO - PROCESS | 17772 | 08:31:02 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:03 INFO - PROCESS | 17772 | RSS: Main: 232767488 08:31:03 INFO - PROCESS | 17772 | 08:31:06 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-dft) 08:31:06 INFO - PROCESS | 17772 | RSS: Main: 217640960 08:31:06 INFO - PROCESS | 17772 | 08:31:09 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-fft) 08:31:10 INFO - PROCESS | 17772 | RSS: Main: 287268864 08:31:10 INFO - PROCESS | 17772 | 08:31:12 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-oscillator) 08:31:13 INFO - PROCESS | 17772 | RSS: Main: 197787648 08:31:13 INFO - PROCESS | 17772 | 08:31:15 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:15 INFO - PROCESS | 17772 | RSS: Main: 202436608 08:31:15 INFO - PROCESS | 17772 | 08:31:18 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:19 INFO - PROCESS | 17772 | RSS: Main: 236687360 08:31:19 INFO - PROCESS | 17772 | 08:31:22 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:23 INFO - PROCESS | 17772 | RSS: Main: 238546944 08:31:23 INFO - PROCESS | 17772 | 08:31:26 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52810/tests/kraken/driver.html?testName=json-parse-financial) 08:31:26 INFO - PROCESS | 17772 | RSS: Main: 238927872 08:31:26 INFO - PROCESS | 17772 | 08:31:28 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:29 INFO - PROCESS | 17772 | RSS: Main: 226914304 08:31:29 INFO - PROCESS | 17772 | 08:31:30 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:31 INFO - PROCESS | 17772 | RSS: Main: 231186432 08:31:31 INFO - PROCESS | 17772 | 08:31:33 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:34 INFO - PROCESS | 17772 | RSS: Main: 239022080 08:31:34 INFO - PROCESS | 17772 | 08:31:36 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:37 INFO - PROCESS | 17772 | RSS: Main: 241184768 08:31:37 INFO - PROCESS | 17772 | 08:31:40 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:40 INFO - PROCESS | 17772 | RSS: Main: 242372608 08:31:40 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52810/tests/kraken/driver.html?testName=ai-astar) 08:31:42 INFO - PROCESS | 17772 | RSS: Main: 285560832 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | __start_tp_report 08:31:42 INFO - PROCESS | 17772 | _x_x_mozilla_page_load 08:31:42 INFO - PROCESS | 17772 | _x_x_mozilla_page_load_details 08:31:42 INFO - PROCESS | 17772 | |i|pagename|runs| 08:31:42 INFO - PROCESS | 17772 | |0;ai-astar;110;104;110;110;110;111;108;109;112;111 08:31:42 INFO - PROCESS | 17772 | |1;audio-beat-detection;153;125;129;177;131;127;156;126;186;125 08:31:42 INFO - PROCESS | 17772 | |2;audio-dft;161;159;160;161;160;159;159;161;160;160 08:31:42 INFO - PROCESS | 17772 | |3;audio-fft;74;75;75;106;75;76;74;74;105;75 08:31:42 INFO - PROCESS | 17772 | |4;audio-oscillator;84;85;110;86;84;86;114;85;85;119 08:31:42 INFO - PROCESS | 17772 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;117;116;116 08:31:42 INFO - PROCESS | 17772 | |6;imaging-darkroom;146;147;146;146;145;147;146;146;146;146 08:31:42 INFO - PROCESS | 17772 | |7;imaging-desaturate;94;95;94;95;94;95;95;95;95;94 08:31:42 INFO - PROCESS | 17772 | |8;json-parse-financial;67;54;55;55;54;54;54;53;54;53 08:31:42 INFO - PROCESS | 17772 | |9;json-stringify-tinderbox;61;62;61;61;62;61;62;62;62;61 08:31:42 INFO - PROCESS | 17772 | |10;stanford-crypto-aes;81;79;79;80;79;80;79;82;124;81 08:31:42 INFO - PROCESS | 17772 | |11;stanford-crypto-ccm;131;125;120;128;123;135;121;121;137;124 08:31:42 INFO - PROCESS | 17772 | |12;stanford-crypto-pbkdf2;164;164;159;158;158;162;167;163;160;162 08:31:42 INFO - PROCESS | 17772 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;63;63;63;62;61 08:31:42 INFO - PROCESS | 17772 | __end_tp_report 08:31:42 INFO - PROCESS | 17772 | __start_cc_report 08:31:42 INFO - PROCESS | 17772 | _x_x_mozilla_cycle_collect,1615 08:31:42 INFO - PROCESS | 17772 | __end_cc_report 08:31:42 INFO - PROCESS | 17772 | __startTimestamp1466436702620__endTimestamp 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | ------- Summary: start ------- 08:31:42 INFO - PROCESS | 17772 | Number of tests: 14 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.22 (2.0%) stddev-sans-first:2.35 08:31:42 INFO - PROCESS | 17772 | Values: 110.0 104.0 110.0 110.0 110.0 111.0 108.0 109.0 112.0 111.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:142.00 stddev:23.10 (16.3%) stddev-sans-first:24.25 08:31:42 INFO - PROCESS | 17772 | Values: 153.0 125.0 129.0 177.0 131.0 127.0 156.0 126.0 186.0 125.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 08:31:42 INFO - PROCESS | 17772 | Values: 161.0 159.0 160.0 161.0 160.0 159.0 159.0 161.0 160.0 160.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.98 (17.3%) stddev-sans-first:13.53 08:31:42 INFO - PROCESS | 17772 | Values: 74.0 75.0 75.0 106.0 75.0 76.0 74.0 74.0 105.0 75.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:85.00 stddev:14.34 (16.9%) stddev-sans-first:14.77 08:31:42 INFO - PROCESS | 17772 | Values: 84.0 85.0 110.0 86.0 84.0 86.0 114.0 85.0 85.0 119.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:31:42 INFO - PROCESS | 17772 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:31:42 INFO - PROCESS | 17772 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:31:42 INFO - PROCESS | 17772 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:4.16 (7.7%) stddev-sans-first:0.71 08:31:42 INFO - PROCESS | 17772 | Values: 67.0 54.0 55.0 55.0 54.0 54.0 54.0 53.0 54.0 53.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:31:42 INFO - PROCESS | 17772 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 62.0 62.0 61.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.00 stddev:13.95 (17.4%) stddev-sans-first:14.75 08:31:42 INFO - PROCESS | 17772 | Values: 81.0 79.0 79.0 80.0 79.0 80.0 79.0 82.0 124.0 81.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.50 stddev:6.04 (4.8%) stddev-sans-first:6.18 08:31:42 INFO - PROCESS | 17772 | Values: 131.0 125.0 120.0 128.0 123.0 135.0 121.0 121.0 137.0 124.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.50 stddev:2.95 (1.8%) stddev-sans-first:3.00 08:31:42 INFO - PROCESS | 17772 | Values: 164.0 164.0 159.0 158.0 158.0 162.0 167.0 163.0 160.0 162.0 08:31:42 INFO - PROCESS | 17772 | 08:31:42 INFO - PROCESS | 17772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 08:31:42 INFO - PROCESS | 17772 | Values: 64.0 63.0 64.0 64.0 63.0 63.0 63.0 63.0 62.0 61.0 08:31:42 INFO - PROCESS | 17772 | -------- Summary: end -------- 08:31:42 INFO - PROCESS | 17772 | 08:31:43 INFO - TEST-INFO | 17772: exit 0 08:31:43 INFO - TEST-OK | kraken | took 60774ms 08:31:43 INFO - SUITE-END | took 1174s 08:31:43 INFO - Completed test suite (00:19:34) 08:31:43 INFO - javascript benchmark 08:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.0480803354976, 3122.2350524121593, 3137.9058628241155, 3147.291859331651, 3160.97268387774, 5305.389880163772, 5368.919466208, 5445.754941027653, 5461.825707472897, 5531.640443371178, 5436.945630543693, 5537.418571050032, 5556.416576259485, 5564.527015203703, 5600.85997850054, 4911.656184067117, 4968.130577149002, 4974.527419895104, 4987.8254261100865, 5158.43257241705, 5074.112030394685, 5075.6447048706605, 5092.821751238707, 5108.259302401149, 5117.692938423688, 4894.804207831682, 4916.631252656065, 4938.037082768861, 4947.579455746266, 4993.151164302078, 4897.951020489821, 4898.534639209305, 4902.3626928499425, 4916.336294600254, 4978.278149668277, 4948.1093403187415, 4965.528274813923, 4971.304017437562, 4972.055309491185, 4995.325631039836, 5298.284731561228, 5389.865253368658, 5449.482299181572, 5459.181122831567, 5541.362743284493, 5840.065589505702, 5880.500157486619, 5884.440978107073, 5887.823365299005, 5892.145638882381, 5862.179294898718, 5902.144189092601, 5942.3760505146765, 5949.791757288517, 5952.285725712899, 5323.44103869092, 5409.350877894639, 5473.972630136824, 5477.233187353773, 5551.861203469945, 6059.971166748962, 6061.058892093405, 6062.354796503716, 6101.664408457489, 6111.786087487006, 5594.496495315441, 5789.218455508537, 5835.533157347402, 5841.620294680833, 5842.328132264844, 5761.452661997104, 5794.768209271582, 5813.12803079533, 5844.240248767718, 5845.88308233833, 5822.883542329129, 5826.941730582725, 5832.0, 5834.358220595731, 5837.708114594253, 5609.859753506195, 5742.13867919807, 5777.0, 5832.88334233313, 5852.0, 4405.669574781904, 4421.270490369117, 4425.645948324126, 4454.621357184611, 4469.150861336336, 3932.8230229639735, 3946.5264168299414, 3956.090099277182, 3959.7030222732833, 3984.5816189300285, 5395.757190926418, 5456.208849716769, 5464.836054918359, 5543.279373681396, 5543.944560554342, 5851.473367396869, 5858.414158584107, 5905.822825315161, 5941.346451890288, 5961.940380596226, 5566.304211973504, 5585.3297604287745, 5586.190002449622, 5588.888222235532, 5590.860228494239, 4957.157283261854, 4987.102321582078, 5107.055194788902, 5112.846614601568, 5161.974190129025, 5947.31605865331, 5969.074793407029, 6012.518998480111, 6024.277086749706, 6079.787207447718, 5847.298324201123, 5858.326292476419, 5858.355580886185, 5861.325947515919, 5894.086416605433, 5912.172295878494, 5956.0, 5960.0, 6000.849978750566, 6035.728392222449, 5771.307443106686, 5794.82615521535, 5802.5357971361345, 5803.564732645153, 5854.356020837789, 5908.231929849092, 5910.674912879833, 5915.08316210988, 5917.556183286185, 5927.436893495111, 5549.278593782782, 5644.802431915027, 5684.772609095755, 5694.658320500783, 5721.027425337619, 5745.626534275259, 5745.6552606843725, 5747.655140691572, 5751.74117164737, 5751.971240143773, 5662.8301150965535, 5670.744816483186, 5671.149327600893, 5675.404082571271, 5675.517581005495, 5649.039663257338, 5694.743736531783, 5779.8555036124435, 5790.39200883918, 5862.032764593794, 5639.689817060101, 5663.915041274302, 5667.2349232854685, 5680.630759000652, 5681.488666020078], "value": 5394.684461517194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1930215256176, 604.0214851939855, 621.7979156774048, 640.6860638287241, 644.0596728775986, 30824.53763193551, 42840.0, 43626.34560481588, 43702.12595748083, 43830.56169438309, 44157.55842441574, 44428.555714442846, 44596.10807783842, 44684.55315446845, 44738.77630611842, 8795.208431241186, 9000.729978100635, 9013.188813006827, 9015.504147271897, 9023.323250756186, 8801.559922003906, 8893.28853691703, 8900.554972251393, 8901.599428025755, 8902.109789021111, 8924.419912705653, 8953.955230223839, 8963.058878817728, 8968.192862642361, 8970.102989701043, 8887.95556022219, 8897.0, 8918.331125165607, 8925.553722313858, 8930.419522731067, 8838.381313308071, 8916.910830891673, 8917.197452229331, 8917.643294268222, 8918.063603321623, 42194.78902605498, 42580.0, 42594.361084583754, 42615.7869210652, 42741.0, 3659.8902032939054, 3753.174301653632, 3767.416050512175, 4023.577524359929, 4181.435506206684, 32313.51529727056, 32640.347193056004, 33143.33713325744, 33196.3360732784, 33249.501257481155, 4414.4040554525045, 4494.617957473619, 4532.88667783308, 4658.930116048262, 4659.0, 329737.0, 329929.0, 330105.0, 330585.0, 331156.0, 55585.44414555884, 55997.44002560004, 56063.0, 56591.0, 56699.0, 59756.0, 60024.0, 60041.09527404317, 60204.698976504835, 60229.0, 14905.478308259158, 15095.698086038217, 15119.848801512064, 15122.621934451727, 15139.848601514064, 11257.605983790692, 11340.886591134147, 11356.148288878201, 11360.20478566509, 11371.431428428545, 14652.267386630625, 16590.419335323204, 16611.584710382336, 16708.6658266834, 16801.24394402255, 5201.803585175431, 6176.474999624992, 6183.96908015457, 6244.0, 6402.871942561216, 962.3888830592624, 1018.3279035836313, 1039.184240371305, 1078.5955266774959, 1100.9284396514201, 32240.83879580587, 32749.0, 32928.0, 33038.0, 33297.334053318795, 1079.7030816525362, 1089.2048804372853, 1093.2620481175175, 1094.370736826328, 1121.170333952869, 16835.494935151964, 17274.0, 17389.391371301943, 17444.738328925076, 17472.611820528702, 529828.0, 533376.0, 537038.0, 537189.0, 538415.0, 57104.0, 57525.0, 57557.13664295039, 57596.136057959164, 57672.0, 1205.0781152418408, 1296.2352212194662, 1303.2376060004813, 1313.7175507265983, 1366.1666383506251, 32132.0, 33368.833155834065, 33521.66478335283, 33757.35505700487, 33944.60553944586, 49167.0, 49759.253611195134, 49888.75055624699, 49889.251661224385, 49907.75046124746, 390669.0, 391092.0, 392810.0, 393352.0, 393483.0, 34734.87770285382, 37060.81469592635, 44753.55246447494, 45260.773696131306, 45980.0, 47209.0, 47825.0, 48368.51631483781, 48601.75699121482, 49015.26477102775, 40620.0, 41268.79365603153, 41333.58666413297, 42254.78872605618, 42422.787886060374, 40359.0, 41182.588174117875, 41257.793711031256, 41376.621039264704, 42274.36588451237, 39871.80064099777, 40427.0, 41501.58498415098, 41591.58408415877, 41642.375364370164, 34435.0, 36216.63783362238, 36413.08967275839, 36789.63210367862, 37273.440898386005, 27398.315042124108, 27541.31146721348, 28021.579676304464, 28192.436151276448, 28253.293667658472], "value": 20019.376471003477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.7691385168897, 385.863018628387, 390.30720471163664, 408.88142438692773, 412.97728624925634, 14449.494267700633, 16833.579160520963, 18166.0, 19935.501612459695, 20011.0, 17645.647087058253, 18133.909330453364, 18663.626727465442, 18800.62398752024, 18877.0, 5074.086664400406, 5171.224316352549, 5244.973775131138, 5290.761915713783, 5321.840344789663, 3836.4245363195605, 5183.896322073556, 5219.739013049351, 5235.79056837728, 5525.336959564858, 5751.827445176651, 5847.122931560258, 5856.648601083927, 5870.73581688825, 5873.030949893263, 5621.156826476041, 5768.769249230026, 5801.071828507461, 5813.825585232428, 5847.912281315784, 5585.497305242548, 5605.383407825136, 5607.915881261784, 5624.268845050158, 5634.577406694473, 13809.792853107212, 14747.705045899129, 22423.99092040862, 22572.661410078697, 22984.54030919389, 2260.4059545322853, 2319.431739223884, 2322.605157123276, 2467.6915385576804, 2892.6239588853314, 10090.19278457729, 10152.441615711134, 10471.63349282779, 10679.145668346591, 10758.462076896123, 1848.3900312896712, 1898.8955607441585, 1913.4068438784022, 1937.060525645061, 1950.6878899376175, 82601.58699206526, 87193.12806871913, 87340.0, 87638.56180719056, 88559.55720221357, 10367.0, 10371.792564148825, 10408.167346612252, 10450.0, 10658.413787241621, 13846.238456884766, 14200.928995354958, 14241.857581424054, 14274.857251427353, 14361.066530675473, 7782.571958542221, 8074.636641351153, 8115.8782618260775, 8187.017557893091, 8263.628136733862, 7404.592747398837, 7478.2147874473485, 7526.6989320427665, 7607.087149542091, 7611.086669599684, 4934.284528743384, 4955.72743499111, 4956.553910148104, 4963.553280204799, 5002.924956125588, 1966.557524556992, 1991.2333751505485, 1995.1520603743352, 2006.187494064906, 2012.759457273788, 930.1489137439303, 934.8971613122551, 954.9092836180552, 978.7553111722069, 1027.2860362048455, 19304.420867374, 19805.900970495055, 20021.399358019284, 20367.0, 20470.59058818815, 922.4511415707643, 956.0, 958.9664361747306, 1014.4116412480744, 1031.9071283584362, 10957.83563246552, 11238.438078096062, 11269.492872820743, 11309.94345028286, 11397.259178153394, 375713.0, 376786.0, 377472.0, 495650.0, 518022.0, 93622.53188734013, 100136.0, 102040.22788510255, 104147.4792626032, 107271.0, 1025.1696126137704, 1025.8153532364097, 1027.8098551767798, 1073.2487258918788, 1080.206048554312, 17980.460586182435, 18081.0, 18450.35423760162, 18716.377950404552, 18749.34377296788, 39873.401898972115, 44210.0, 45079.77460112678, 45186.09627807491, 45393.36853051682, 53371.0, 58278.70860645839, 60256.39743602683, 60720.0, 61171.0, 5889.587728858939, 8514.957425212835, 8775.210231078978, 9032.136611561878, 9185.908140918506, 11946.342951137423, 13934.860651393356, 14086.577402677936, 14244.71510569762, 14415.639609009859, 11577.07383409342, 11911.76176476483, 12421.565245216374, 12430.440630171483, 12587.559435420082, 11291.830622540832, 11640.88359116398, 11826.586069487526, 12117.667056623588, 12634.368281586068, 12201.14591978553, 12455.93772031134, 12507.124501284823, 12521.37393130358, 12742.362881856056, 8727.781805454915, 8943.776405589912, 9010.90989090127, 9138.634454622006, 9324.393914395543, 8961.0, 11633.6509904703, 12107.818382724443, 12108.21296615717, 12154.817677734663], "value": 9179.53502246343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.9666258343545, 1437.0, 1466.794648749175, 1584.8335924727903, 1743.5205318537392, 8365.790855228615, 8699.913000869989, 8714.041455439896, 9075.183233508982, 9087.227585655211, 8763.956180219106, 8985.640574377034, 8994.4153630014, 9001.594928228229, 9006.234470070052, 2020.05057622917, 2261.502469456717, 2321.3036089173265, 2361.4332560185517, 2365.9763402366016, 2347.190219374313, 2418.6372044193336, 2418.6492958521003, 2419.697537807774, 2420.8668523231304, 2326.150954901457, 2347.190219374313, 2352.529494101178, 2354.0113152476, 2358.6815779869758, 1987.3441764217846, 2226.832987525942, 2242.674812152237, 2292.495650956787, 2300.033985725999, 2291.7822806833324, 2302.033146078634, 2309.7574754650686, 2310.0413328468667, 2316.3514216019544, 8763.912360876373, 8847.20375166238, 8847.247983921374, 8860.158284962918, 8871.689490867853, 4988.251762235657, 5145.871353216162, 5180.533751962342, 5186.455422180692, 5190.11767999441, 3254.3979363817534, 3283.9014829555153, 3417.8974630761118, 3435.175557866119, 3437.071990562559, 1175.670812172593, 1190.4761904761876, 1197.3235122155954, 1224.4918358881055, 1232.6856651553885, 12123.151379403445, 12370.75258494834, 12376.267322574757, 12413.999999999909, 12449.439775210047, 4556.248219043887, 4576.313552967082, 4658.976705116453, 4663.673542852036, 4710.387649605529, 10251.897481025095, 10279.0, 10282.640107596348, 10284.125849302744, 10315.12321452685, 5200.817971370984, 5208.322918020633, 5208.713520756395, 5212.50481204285, 5213.113770658997, 4402.757848318309, 4731.810727570927, 4855.611551075976, 4857.125717370907, 4928.310036594879, 3966.206758648224, 4014.959850401517, 4075.9796201018803, 4090.1819636072905, 4099.590040995936, 1301.076235872541, 1304.5694920676153, 1331.2877610478347, 1333.8199343088752, 1344.0, 965.2181732796457, 983.9704808855746, 989.8020395920845, 997.7056768253383, 1007.8236308645958, 6195.4424101831055, 6276.309605943343, 6309.116723658692, 6426.068220108058, 6453.580517266362, 1009.3943633819649, 1043.5669197283194, 1063.2557209952909, 1087.9619213327496, 1091.6288461922984, 4301.0322677397335, 4356.106998065389, 4380.890477738082, 4387.6270517006415, 4387.934180987288, 10473.68578942633, 10917.890821091687, 11174.10607151426, 11247.550097996153, 11298.7175320616, 10968.506417211245, 11293.0, 11300.265482743594, 11321.264117832314, 11325.603603873826, 7922.762317130495, 8098.676052957816, 8110.43226974118, 8122.553259570662, 8124.796880078045, 6194.473469755121, 6364.172657554488, 6376.585521941244, 6442.613443193423, 6557.442617377576, 9673.226141908772, 9986.051325124101, 10240.231982601186, 10362.119219866396, 10369.325993810378, 10436.63471778484, 10612.0, 10636.734081648021, 10636.89363106359, 10758.354498729788, 7898.091719452107, 7904.407169462428, 7968.601569921597, 8004.959975200087, 8017.518948862854, 8382.664693412195, 8434.24091831738, 8434.831303374021, 8445.957770211355, 8450.830983380421, 7277.0, 7391.963040184764, 7435.776926692208, 7460.738874139379, 7515.774526764206, 7502.887456688045, 7571.280728330799, 7614.5811980339395, 7719.421043421654, 7729.884051739116, 6952.791416257521, 6958.269381714847, 7039.120109986252, 7042.295770423121, 7043.859122817617, 5147.948520514747, 5194.714290713896, 5277.868053298698, 5289.20661900718, 5294.020606187868, 5070.645054846273, 5094.2867998479505, 5103.464136265788, 5195.220716892345, 5449.23710680513], "value": 4703.013083904232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.79637726420987, 329.615997363072, 335.53528363216947, 336.5254990463447, 339.58061793684794, 5195.636305458619, 5200.323957885475, 5255.185446255827, 5288.805145864467, 5298.7350632468415, 5151.227315902616, 5205.869853253661, 5214.06146893559, 5215.791368345271, 5224.817131400392, 4020.6381425671684, 4130.917381652365, 4155.62599366057, 4159.835246131088, 4169.207850508394, 4071.5928407159345, 4126.360414135814, 4127.917441651165, 4128.050548373876, 4136.21411931732, 4085.632293093621, 4114.136031433402, 4116.094459218967, 4132.995497183863, 4140.834366625331, 3912.158885839544, 4033.576474470168, 4034.789563131049, 4040.636342729139, 4123.649489793371, 3495.0, 3544.769589976643, 3657.0491672165163, 3666.6883314918264, 3682.913540505557, 5065.620078494091, 5082.872928176788, 5085.084684756743, 5093.465186155438, 5139.897202055975, 4500.44734566574, 4669.32294817253, 4675.812967481296, 4677.766111694402, 4680.531946805292, 5317.494837990384, 5493.560515158778, 5496.108463467517, 5510.476504732044, 5519.503244707956, 4037.777922214277, 4039.8890305166315, 4043.433919251307, 4048.9595104048876, 4049.514058312992, 5279.63042587019, 5444.50999410055, 5649.745761440704, 5751.223584816038, 5754.539636829044, 4060.2488539620263, 4097.631213190827, 4108.938365924513, 4116.629503344713, 4124.587541245852, 4098.590140985937, 4144.378343248537, 4144.48193975753, 4147.3986271991, 4162.501499460192, 4394.494633117232, 4671.462781780071, 4682.204025315705, 4684.414448193976, 4691.601213896857, 5406.162044883049, 5420.322459692538, 5422.593305502024, 5445.863853403696, 5447.700376479332, 1387.5074348606302, 1405.4940221520244, 1409.1474657832068, 1409.7180563887264, 1418.453895250336, 882.803800849852, 903.4353529044347, 923.1276443760581, 923.2291036984193, 923.8752768376183, 4675.509071547439, 4726.905461890812, 4746.670932139006, 4769.856904292877, 4792.209285467929, 4965.875853103701, 4993.226049962262, 5011.323471331397, 5046.823361182341, 5056.91276375581, 4725.763711814396, 4729.43246810385, 4741.202690412673, 4764.190087685102, 4966.404031516241, 2962.563156868917, 2964.8221106733236, 2983.34366439383, 2991.7756168287465, 2996.895108671186, 5713.514351280188, 5768.307803063575, 5827.533797296206, 5834.3745314608595, 5840.561957853178, 5544.667319960815, 5736.541076713853, 5758.798442054592, 5760.164776107441, 5791.913121303184, 5733.713314334266, 5743.712814359265, 5751.453611906779, 5759.761651245002, 5759.94240057594, 5355.902040081696, 5579.972100139474, 5584.86037849057, 5620.831375058755, 5633.943660563342, 5521.199426083276, 5537.086380747131, 5540.833774986596, 5557.3331200256225, 5563.221149039056, 5418.566514678738, 5505.229267902577, 5679.864027194661, 5714.257146570919, 5774.0, 4115.36211887158, 4128.690348223835, 4132.896677583084, 4141.585841415835, 4148.460700109087, 5310.2831117798605, 5544.473275038865, 5569.577233903103, 5601.5238704710555, 5605.439456054525, 5465.808696695596, 5475.342958844804, 5507.917381239205, 5541.667499950016, 5568.220449137043, 5511.889762204653, 5540.501354878081, 5555.50000499957, 5568.470995255444, 5579.107342825128, 5258.684478931276, 5455.454454554513, 5471.480209380103, 5482.697267147728, 5483.396826349019, 5471.507564319071, 5534.723263836872, 5552.111662134201, 5568.415316391721, 5577.8047768327915, 5394.460553944731, 5397.3552959049, 5422.240886275846, 5424.477617907534, 5429.701366424884], "value": 4156.673854754409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.7938846205756, 779.407650185859, 780.4575819805237, 794.7417089445928, 817.4849844597902, 14672.11967281964, 14675.779863302045, 14982.775258371106, 15022.699546009087, 15030.624234394145, 14028.438862445515, 14482.275886205674, 15058.849411505882, 15074.3216555255, 15095.698086038272, 629.766986215101, 754.781113477091, 761.2007392238141, 784.6978913118462, 790.4190420041265, 755.7392699518684, 774.4965772248056, 775.9650815713278, 776.6582703610421, 776.8174478997431, 820.1306614988102, 823.7611092783086, 823.9958800205991, 824.1675907333577, 824.2046425199682, 662.6885363878945, 761.8362052158757, 774.2373761844578, 823.2138307915926, 825.1336097098053, 580.4891695308102, 581.5870731780441, 581.6190395291048, 582.2925145947652, 584.0975692555013, 14539.200343981076, 14588.197649129293, 14611.63470913225, 14615.707685846224, 14616.561503154817, 13737.0, 14343.067700599531, 14573.0, 14638.853611463855, 14712.55862324132, 12569.811452828215, 12875.098743087987, 12948.352582370939, 12948.48206071756, 13040.673983150402, 4450.287953927356, 4451.977740111279, 4487.865364039051, 4515.977420112911, 4570.9314360284625, 76367.0, 80587.0, 80834.0, 81775.0, 82081.0, 11228.0, 11263.549458021751, 11265.493052812642, 11380.322688372013, 11573.305601663758, 20767.376978690663, 20854.0, 20943.47641308949, 20961.0, 21322.893385532974, 8114.756557303291, 8443.282321002784, 8507.149285071444, 8703.086175951561, 8807.119288071142, 4886.047220791911, 4900.558949694545, 4933.703977761345, 4996.425411077773, 5019.899602007939, 3198.0885447647775, 3325.0523600773663, 3325.617553981323, 3337.7997320160866, 3343.114074770188, 574.5432381256911, 593.0748033068427, 594.028762972543, 598.0282041682266, 615.5814046448459, 687.9749173731204, 694.5936627073219, 709.4537206351081, 721.1814590439784, 728.0389885351285, 9706.174975127193, 9845.310828241954, 9850.162736167362, 9925.702228933143, 9932.155766759906, 664.1266734244454, 676.577139287945, 690.4545409126835, 693.3309356471029, 697.6197972105215, 4314.266574682311, 4593.563611456906, 4600.976995115003, 4607.815687372467, 4618.330342100444, 67937.0, 87375.56312218399, 116199.0, 118579.40710296393, 118600.40699796446, 103671.0, 105086.4745676282, 105116.0, 105612.47193763981, 106013.0, 89937.55031224932, 93545.0, 94695.0, 95663.52168239115, 96417.0, 8645.524496152771, 8699.91300086991, 8736.825263494822, 8756.25571826402, 9005.684801031932, 42646.57353426426, 54622.726886365315, 55350.72324638351, 55456.72271638616, 57587.0, 72105.63947180231, 79080.20919790959, 79437.0, 80995.59502202451, 81075.59462202652, 11726.530938762695, 12056.397180141134, 12242.387880606113, 12335.321557314433, 12421.254724716546, 14969.625759356104, 15188.544343669708, 15677.05937643745, 15939.282732276843, 16570.17149142514, 11310.660680179608, 11610.187286889837, 14604.561863144123, 15399.846001539841, 15602.531924042298, 13717.725645486835, 13771.931140344233, 14210.502632407815, 14812.62968425798, 15491.0, 14508.85491145075, 14540.41838326455, 14553.417863285773, 14658.0, 15548.378064877279, 11584.304941703525, 11711.238769479956, 12008.75982480363, 12325.0, 12426.440810163384, 12049.939750301193, 12258.325792081521, 12335.734000129853, 12456.377181140726, 12458.252504849375], "value": 7581.256478519895, "unit": "score"}], "name": "dromaeo_css", "value": 7264.252251275672, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 110.0, 110.0, 111.0, 108.0, 109.0, 112.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 129.0, 177.0, 131.0, 127.0, 156.0, 126.0, 186.0, 125.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 160.0, 159.0, 159.0, 161.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 75.0, 76.0, 74.0, 74.0, 105.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 86.0, 84.0, 86.0, 114.0, 85.0, 85.0, 119.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 53.0, 54.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 80.0, 79.0, 80.0, 79.0, 82.0, 124.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 125.0, 120.0, 128.0, 123.0, 135.0, 121.0, 121.0, 137.0, 124.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 159.0, 158.0, 158.0, 162.0, 167.0, 163.0, 160.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1497.6000000000001, "alertThreshold": 2.0}]} 08:31:43 INFO - Return code: 0 08:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:43 INFO - # TBPL SUCCESS # 08:31:43 INFO - Running post-action listener: _resource_record_post_action 08:31:43 INFO - ##### 08:31:43 INFO - ##### Finished run-tests step (success) 08:31:43 INFO - ##### 08:31:43 INFO - Running post-run listener: _resource_record_post_run 08:31:43 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554483712; Read time: 96; Write time: 538976 08:31:43 INFO - TinderboxPrint: CPU usage
13.2% 08:31:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 96 08:31:43 INFO - TinderboxPrint: I/O write bytes / time
554,483,712 / 538,976 08:31:43 INFO - TinderboxPrint: CPU idle
8,258.7 (86.8%) 08:31:43 INFO - TinderboxPrint: CPU user
1,205.2 (12.7%) 08:31:43 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 262549504; Read time: 96; Write time: 309848 08:31:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291934208; Read time: 0; Write time: 229128 08:31:44 INFO - Running post-run listener: _upload_blobber_files 08:31:44 INFO - Blob upload gear active. 08:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:44 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:31:44 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:31:44 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:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:45 INFO - (blobuploader) - INFO - Done attempting. 08:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:53 INFO - (blobuploader) - INFO - Done attempting. 08:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:54 INFO - (blobuploader) - INFO - Done attempting. 08:31:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:54 INFO - Return code: 0 08:31:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ff8c067eaf427999f454057b7d42939c86cff7309ca57b4e253973ff8cf3a934b8baf3b332798194586a0e6501a5ed982cafd84cbfa85da7dc46d0af625ef28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/602d777fb92bb42d8cdb672edcda7b565475f848cdeee50ba0d90ee201b2213c1781ecce819461f9f383db6fe0ec8329f1085a4c74c2e9ab9fe2a99d6ec75b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f840368c9dd4c68fd488beabf2dff08a01ac795289cc9c3c4b786194ef03948640380b9f97a34e579561c33fd13b637bbbb7244e342247bc57193915728bfdb9"} 08:31:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:54 INFO - Contents: 08:31:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ff8c067eaf427999f454057b7d42939c86cff7309ca57b4e253973ff8cf3a934b8baf3b332798194586a0e6501a5ed982cafd84cbfa85da7dc46d0af625ef28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/602d777fb92bb42d8cdb672edcda7b565475f848cdeee50ba0d90ee201b2213c1781ecce819461f9f383db6fe0ec8329f1085a4c74c2e9ab9fe2a99d6ec75b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f840368c9dd4c68fd488beabf2dff08a01ac795289cc9c3c4b786194ef03948640380b9f97a34e579561c33fd13b637bbbb7244e342247bc57193915728bfdb9"} 08:31:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:54 INFO - Copying logs to upload dir... 08:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.582726 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-20 08:31:53.786154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:31:53.789524) ========= 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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 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/3ff8c067eaf427999f454057b7d42939c86cff7309ca57b4e253973ff8cf3a934b8baf3b332798194586a0e6501a5ed982cafd84cbfa85da7dc46d0af625ef28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/602d777fb92bb42d8cdb672edcda7b565475f848cdeee50ba0d90ee201b2213c1781ecce819461f9f383db6fe0ec8329f1085a4c74c2e9ab9fe2a99d6ec75b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f840368c9dd4c68fd488beabf2dff08a01ac795289cc9c3c4b786194ef03948640380b9f97a34e579561c33fd13b637bbbb7244e342247bc57193915728bfdb9"} build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/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/3ff8c067eaf427999f454057b7d42939c86cff7309ca57b4e253973ff8cf3a934b8baf3b332798194586a0e6501a5ed982cafd84cbfa85da7dc46d0af625ef28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/602d777fb92bb42d8cdb672edcda7b565475f848cdeee50ba0d90ee201b2213c1781ecce819461f9f383db6fe0ec8329f1085a4c74c2e9ab9fe2a99d6ec75b71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f840368c9dd4c68fd488beabf2dff08a01ac795289cc9c3c4b786194ef03948640380b9f97a34e579561c33fd13b637bbbb7244e342247bc57193915728bfdb9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:31:53.818039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:31:53.818370) ========= 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=826874ccc97bd7bf541b4875000001d5-1466435438.452652-963374261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:31:53.902376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:31:53.902743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:31:53.903050) ========= ========= Total master_lag: 0.18 =========