builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1461628745.44 results: success (0) buildid: 20160425143034 builduid: 366a54cca043417c9640caa5b943b539 revision: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.438278) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.438916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.439256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.464871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.465216) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 16:59:06-- 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% 38.7M=0s 2016-04-25 16:59:07 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.601040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.601805) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019302 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:05.657453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 16:59:05.657933) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 86e0ea42f55c34fc90dd9e32439783a9929f28f4 --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 86e0ea42f55c34fc90dd9e32439783a9929f28f4 --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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 16:59:07,165 truncating revision to first 12 chars 2016-04-25 16:59:07,165 Setting DEBUG logging. 2016-04-25 16:59:07,165 attempt 1/10 2016-04-25 16:59:07,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/86e0ea42f55c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 16:59:08,286 unpacking tar archive at: fx-team-86e0ea42f55c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 16:59:07.079408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:07.079746) ========= script_repo_revision: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:07.080182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:07.080489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 16:59:07.089908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-25 16:59:07.090382) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:08 INFO - MultiFileLogger online at 20160425 16:59:08 in /builds/slave/test 16:59:08 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 16:59:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:08 INFO - {'append_to_log': False, 16:59:08 INFO - 'base_work_dir': '/builds/slave/test', 16:59:08 INFO - 'blob_upload_branch': 'Fx-Team', 16:59:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:08 INFO - 'branch': 'Fx-Team', 16:59:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:08 INFO - 'config_files': ('talos/linux_config.py',), 16:59:08 INFO - 'default_actions': ('clobber', 16:59:08 INFO - 'read-buildbot-config', 16:59:08 INFO - 'download-and-extract', 16:59:08 INFO - 'populate-webroot', 16:59:08 INFO - 'create-virtualenv', 16:59:08 INFO - 'install', 16:59:08 INFO - 'run-tests'), 16:59:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:08 INFO - 'download_minidump_stackwalk': True, 16:59:08 INFO - 'download_symbols': 'ondemand', 16:59:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:08 INFO - 'installer_path': 'installer.exe', 16:59:08 INFO - 'log_level': 'info', 16:59:08 INFO - 'log_name': 'talos', 16:59:08 INFO - 'log_to_console': True, 16:59:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:08 INFO - 'opt_config_files': (), 16:59:08 INFO - 'pip_index': False, 16:59:08 INFO - 'sps_profile': False, 16:59:08 INFO - 'sps_profile_interval': 0, 16:59:08 INFO - 'suite': 'dromaeojs', 16:59:08 INFO - 'system_bits': '32', 16:59:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:08 INFO - 'title': 'talos-linux64-ix-066', 16:59:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:08 INFO - 'use_talos_json': True, 16:59:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:08 INFO - 'work_dir': 'build'} 16:59:08 INFO - ##### 16:59:08 INFO - ##### Running clobber step. 16:59:08 INFO - ##### 16:59:08 INFO - Running pre-action listener: _resource_record_pre_action 16:59:08 INFO - Running main action method: clobber 16:59:08 INFO - rmtree: /builds/slave/test/build 16:59:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:09 INFO - Running post-action listener: _resource_record_post_action 16:59:09 INFO - ##### 16:59:09 INFO - ##### Running read-buildbot-config step. 16:59:09 INFO - ##### 16:59:09 INFO - Running pre-action listener: _resource_record_pre_action 16:59:09 INFO - Running main action method: read_buildbot_config 16:59:09 INFO - Using buildbot properties: 16:59:09 INFO - { 16:59:09 INFO - "project": "", 16:59:09 INFO - "product": "firefox", 16:59:09 INFO - "script_repo_revision": "production", 16:59:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:59:09 INFO - "repository": "", 16:59:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:59:09 INFO - "buildid": "20160425143034", 16:59:09 INFO - "pgo_build": "True", 16:59:09 INFO - "basedir": "/builds/slave/test", 16:59:09 INFO - "buildnumber": 61, 16:59:09 INFO - "slavename": "talos-linux64-ix-066", 16:59:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:59:09 INFO - "platform": "ubuntu64_hw", 16:59:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:59:09 INFO - "branch": "fx-team", 16:59:09 INFO - "repo_path": "integration/fx-team", 16:59:09 INFO - "revision": "86e0ea42f55c34fc90dd9e32439783a9929f28f4", 16:59:09 INFO - "stage_platform": "linux64-pgo", 16:59:09 INFO - "builduid": "366a54cca043417c9640caa5b943b539", 16:59:09 INFO - "slavebuilddir": "test" 16:59:09 INFO - } 16:59:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:59:09 INFO - Running post-action listener: _resource_record_post_action 16:59:09 INFO - ##### 16:59:09 INFO - ##### Running download-and-extract step. 16:59:09 INFO - ##### 16:59:09 INFO - Running pre-action listener: _resource_record_pre_action 16:59:09 INFO - Running main action method: download_and_extract 16:59:09 INFO - mkdir: /builds/slave/test/build/tests 16:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:09 INFO - https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:59:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:59:11 INFO - Downloaded 1361 bytes. 16:59:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:59:11 INFO - Using the following test package requirements: 16:59:11 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:59:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'jsshell-linux-x86_64.zip'], 16:59:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:11 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:11 INFO - https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:59:14 INFO - Downloaded 23860699 bytes. 16:59:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:59:15 INFO - Return code: 0 16:59:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:15 INFO - https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:59:19 INFO - Downloaded 23860699 bytes. 16:59:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:59:21 INFO - Return code: 0 16:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:21 INFO - https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:59:22 INFO - Downloaded 10840145 bytes. 16:59:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:59:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:59:22 INFO - Return code: 0 16:59:22 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')]} 16:59:22 INFO - https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:59:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:59:23 INFO - Downloaded 58346997 bytes. 16:59:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:23 INFO - mkdir: /builds/slave/test/properties 16:59:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:23 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:23 INFO - Contents: 16:59:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:59:24 INFO - Running post-action listener: _resource_record_post_action 16:59:24 INFO - Running post-action listener: set_extra_try_arguments 16:59:24 INFO - ##### 16:59:24 INFO - ##### Running populate-webroot step. 16:59:24 INFO - ##### 16:59:24 INFO - Running pre-action listener: _resource_record_pre_action 16:59:24 INFO - Running main action method: populate_webroot 16:59:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:24 INFO - '--tppagecycles', 16:59:24 INFO - '7'], 16:59:24 INFO - 'tests': ['tsvgm']}}, 16:59:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['damp', 'tps']}, 16:59:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'tests': ['damp', 'tps']}, 16:59:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['dromaeo_dom']}, 16:59:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['a11yr', 16:59:24 INFO - 'ts_paint', 16:59:24 INFO - 'tpaint', 16:59:24 INFO - 'sessionrestore', 16:59:24 INFO - 'sessionrestore_no_auto_restore', 16:59:24 INFO - 'tabpaint']}, 16:59:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['tsvgx', 16:59:24 INFO - 'tsvgr_opacity', 16:59:24 INFO - 'tart', 16:59:24 INFO - 'tscrollx', 16:59:24 INFO - 'cart']}, 16:59:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:24 INFO - 'tsvgr_opacity', 16:59:24 INFO - 'tart', 16:59:24 INFO - 'tscrollx', 16:59:24 INFO - 'cart']}, 16:59:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'talos_options': ['--disable-e10s'], 16:59:24 INFO - 'tests': ['tp5o']}, 16:59:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'tests': ['tp5o']}, 16:59:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'talos_options': ['--disable-e10s', 16:59:24 INFO - '--xperf_path', 16:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:24 INFO - 'tests': ['tp5n']}, 16:59:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:24 INFO - 'talos_options': ['--xperf_path', 16:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:24 INFO - 'tests': ['tp5n']}}, 16:59:24 INFO - 'talos.zip': {'path': '', 16:59:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:24 INFO - Running post-action listener: _resource_record_post_action 16:59:24 INFO - ##### 16:59:24 INFO - ##### Running create-virtualenv step. 16:59:24 INFO - ##### 16:59:24 INFO - Running pre-action listener: _resource_record_pre_action 16:59:24 INFO - Running main action method: create_virtualenv 16:59:24 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:24 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 16:59:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:24 INFO - Using real prefix '/usr' 16:59:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:27 INFO - Installing pip.................done. 16:59:27 INFO - Return code: 0 16:59:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:27 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 16:59:27 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 16:59:27 INFO - Using env: {'DISPLAY': ':0', 16:59:27 INFO - 'HOME': '/home/cltbld', 16:59:27 INFO - 'LANG': 'en_US.UTF-8', 16:59:27 INFO - 'LANGUAGE': 'en_US:en', 16:59:27 INFO - 'LOGNAME': 'cltbld', 16:59:27 INFO - 'MAIL': '/var/mail/cltbld', 16:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:27 INFO - 'MOZ_NO_REMOTE': '1', 16:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:27 INFO - 'NO_EM_RESTART': '1', 16:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:27 INFO - 'PWD': '/builds/slave/test', 16:59:27 INFO - 'SHELL': '/bin/bash', 16:59:27 INFO - 'SHLVL': '1', 16:59:27 INFO - 'TERM': 'linux', 16:59:27 INFO - 'TMOUT': '86400', 16:59:27 INFO - 'USER': 'cltbld', 16:59:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:27 INFO - '_': '/tools/buildbot/bin/python'} 16:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:27 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 16:59:27 INFO - Cleaning up... 16:59:27 INFO - Return code: 0 16:59:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:27 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>=0.7.1'] in /builds/slave/test/build 16:59:27 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>=0.7.1 16:59:27 INFO - Using env: {'DISPLAY': ':0', 16:59:27 INFO - 'HOME': '/home/cltbld', 16:59:27 INFO - 'LANG': 'en_US.UTF-8', 16:59:27 INFO - 'LANGUAGE': 'en_US:en', 16:59:27 INFO - 'LOGNAME': 'cltbld', 16:59:27 INFO - 'MAIL': '/var/mail/cltbld', 16:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:27 INFO - 'MOZ_NO_REMOTE': '1', 16:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:27 INFO - 'NO_EM_RESTART': '1', 16:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:27 INFO - 'PWD': '/builds/slave/test', 16:59:27 INFO - 'SHELL': '/bin/bash', 16:59:27 INFO - 'SHLVL': '1', 16:59:27 INFO - 'TERM': 'linux', 16:59:27 INFO - 'TMOUT': '86400', 16:59:27 INFO - 'USER': 'cltbld', 16:59:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:27 INFO - '_': '/tools/buildbot/bin/python'} 16:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:27 INFO - Downloading/unpacking psutil>=0.7.1 16:59:27 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 16:59:27 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 16:59:27 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 16:59:27 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 16:59:27 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 16:59:27 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 16:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:29 INFO - Installing collected packages: psutil 16:59:29 INFO - Running setup.py install for psutil 16:59:29 INFO - building 'psutil._psutil_linux' extension 16:59:29 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 16:59:29 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 16:59:29 INFO - building 'psutil._psutil_posix' extension 16:59:29 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 16:59:29 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 16:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:30 INFO - Successfully installed psutil 16:59:30 INFO - Cleaning up... 16:59:30 INFO - Return code: 0 16:59:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:59:30 INFO - Using env: {'DISPLAY': ':0', 16:59:30 INFO - 'HOME': '/home/cltbld', 16:59:30 INFO - 'LANG': 'en_US.UTF-8', 16:59:30 INFO - 'LANGUAGE': 'en_US:en', 16:59:30 INFO - 'LOGNAME': 'cltbld', 16:59:30 INFO - 'MAIL': '/var/mail/cltbld', 16:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:30 INFO - 'MOZ_NO_REMOTE': '1', 16:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:30 INFO - 'NO_EM_RESTART': '1', 16:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:30 INFO - 'PWD': '/builds/slave/test', 16:59:30 INFO - 'SHELL': '/bin/bash', 16:59:30 INFO - 'SHLVL': '1', 16:59:30 INFO - 'TERM': 'linux', 16:59:30 INFO - 'TMOUT': '86400', 16:59:30 INFO - 'USER': 'cltbld', 16:59:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:30 INFO - '_': '/tools/buildbot/bin/python'} 16:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:59:32 INFO - Installing collected packages: mozsystemmonitor 16:59:32 INFO - Running setup.py install for mozsystemmonitor 16:59:32 INFO - Successfully installed mozsystemmonitor 16:59:32 INFO - Cleaning up... 16:59:32 INFO - Return code: 0 16:59:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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', '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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:59: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 blobuploader==1.2.4 16:59:32 INFO - Using env: {'DISPLAY': ':0', 16:59:32 INFO - 'HOME': '/home/cltbld', 16:59:32 INFO - 'LANG': 'en_US.UTF-8', 16:59:32 INFO - 'LANGUAGE': 'en_US:en', 16:59:32 INFO - 'LOGNAME': 'cltbld', 16:59:32 INFO - 'MAIL': '/var/mail/cltbld', 16:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:32 INFO - 'MOZ_NO_REMOTE': '1', 16:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:32 INFO - 'NO_EM_RESTART': '1', 16:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:32 INFO - 'PWD': '/builds/slave/test', 16:59:32 INFO - 'SHELL': '/bin/bash', 16:59:32 INFO - 'SHLVL': '1', 16:59:32 INFO - 'TERM': 'linux', 16:59:32 INFO - 'TMOUT': '86400', 16:59:32 INFO - 'USER': 'cltbld', 16:59:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:32 INFO - '_': '/tools/buildbot/bin/python'} 16:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:32 INFO - Downloading/unpacking blobuploader==1.2.4 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:34 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:35 INFO - Downloading docopt-0.6.1.tar.gz 16:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:35 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:35 INFO - Running setup.py install for blobuploader 16:59:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:35 INFO - Running setup.py install for requests 16:59:35 INFO - Running setup.py install for docopt 16:59:35 INFO - Successfully installed blobuploader requests docopt 16:59:35 INFO - Cleaning up... 16:59:35 INFO - Return code: 0 16:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:35 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:35 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 16:59:35 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 16:59:35 INFO - Using env: {'DISPLAY': ':0', 16:59:35 INFO - 'HOME': '/home/cltbld', 16:59:35 INFO - 'LANG': 'en_US.UTF-8', 16:59:35 INFO - 'LANGUAGE': 'en_US:en', 16:59:35 INFO - 'LOGNAME': 'cltbld', 16:59:35 INFO - 'MAIL': '/var/mail/cltbld', 16:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:35 INFO - 'MOZ_NO_REMOTE': '1', 16:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:35 INFO - 'NO_EM_RESTART': '1', 16:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:35 INFO - 'PWD': '/builds/slave/test', 16:59:35 INFO - 'SHELL': '/bin/bash', 16:59:35 INFO - 'SHLVL': '1', 16:59:35 INFO - 'TERM': 'linux', 16:59:35 INFO - 'TMOUT': '86400', 16:59:35 INFO - 'USER': 'cltbld', 16:59:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:35 INFO - '_': '/tools/buildbot/bin/python'} 16:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:36 INFO - Running setup.py (path:/tmp/pip-q1Zh41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:36 INFO - Running setup.py (path:/tmp/pip-VZFraR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:36 INFO - Running setup.py (path:/tmp/pip-XDXNVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:36 INFO - Running setup.py (path:/tmp/pip-dTQnBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:36 INFO - Running setup.py (path:/tmp/pip-dP4r8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:36 INFO - Running setup.py (path:/tmp/pip-hTyOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:36 INFO - Running setup.py (path:/tmp/pip-SV4pLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:36 INFO - Running setup.py (path:/tmp/pip-CHZR3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:36 INFO - Running setup.py (path:/tmp/pip-sEu4DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:36 INFO - Running setup.py (path:/tmp/pip-6SKfMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:36 INFO - Running setup.py (path:/tmp/pip-EKAyZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:36 INFO - Running setup.py (path:/tmp/pip-vJJdQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:36 INFO - Running setup.py (path:/tmp/pip-5wwWrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:37 INFO - Running setup.py (path:/tmp/pip-PEFid3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:37 INFO - Running setup.py (path:/tmp/pip-dHnrOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:37 INFO - Running setup.py (path:/tmp/pip-QurpMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:37 INFO - Running setup.py (path:/tmp/pip-Kznscx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:37 INFO - Running setup.py install for manifestparser 16:59:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:37 INFO - Running setup.py install for mozcrash 16:59:37 INFO - Running setup.py install for mozdebug 16:59:37 INFO - Running setup.py install for mozdevice 16:59:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:59:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:37 INFO - Running setup.py install for mozfile 16:59:37 INFO - Running setup.py install for mozhttpd 16:59:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:37 INFO - Running setup.py install for mozinfo 16:59:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for mozInstall 16:59:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for mozleak 16:59:38 INFO - Running setup.py install for mozlog 16:59:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for moznetwork 16:59:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for mozprocess 16:59:38 INFO - Running setup.py install for mozprofile 16:59:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for mozrunner 16:59:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:59:38 INFO - Running setup.py install for mozscreenshot 16:59:38 INFO - Running setup.py install for moztest 16:59:38 INFO - Running setup.py install for mozversion 16:59:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:59:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:39 INFO - Cleaning up... 16:59:39 INFO - Return code: 0 16:59:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:39 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:39 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 16:59:39 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 16:59:39 INFO - Using env: {'DISPLAY': ':0', 16:59:39 INFO - 'HOME': '/home/cltbld', 16:59:39 INFO - 'LANG': 'en_US.UTF-8', 16:59:39 INFO - 'LANGUAGE': 'en_US:en', 16:59:39 INFO - 'LOGNAME': 'cltbld', 16:59:39 INFO - 'MAIL': '/var/mail/cltbld', 16:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:39 INFO - 'MOZ_NO_REMOTE': '1', 16:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:39 INFO - 'NO_EM_RESTART': '1', 16:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:39 INFO - 'PWD': '/builds/slave/test', 16:59:39 INFO - 'SHELL': '/bin/bash', 16:59:39 INFO - 'SHLVL': '1', 16:59:39 INFO - 'TERM': 'linux', 16:59:39 INFO - 'TMOUT': '86400', 16:59:39 INFO - 'USER': 'cltbld', 16:59:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:39 INFO - '_': '/tools/buildbot/bin/python'} 16:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:39 INFO - Running setup.py (path:/tmp/pip-rdh1S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:39 INFO - Running setup.py (path:/tmp/pip-oN_GtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:39 INFO - Running setup.py (path:/tmp/pip-3Litjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:39 INFO - Running setup.py (path:/tmp/pip-3ADra9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:39 INFO - Running setup.py (path:/tmp/pip-L_9pNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:39 INFO - Running setup.py (path:/tmp/pip-oxizZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:39 INFO - Running setup.py (path:/tmp/pip-DW3osN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:39 INFO - Running setup.py (path:/tmp/pip-J54Niu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:39 INFO - Running setup.py (path:/tmp/pip-rpUIWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:39 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)) 16:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:39 INFO - Running setup.py (path:/tmp/pip-swb0vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:40 INFO - Running setup.py (path:/tmp/pip-JclvkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:40 INFO - Running setup.py (path:/tmp/pip-7DeW2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:40 INFO - Running setup.py (path:/tmp/pip-d4dAdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:40 INFO - Running setup.py (path:/tmp/pip-qgj4Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:40 INFO - Running setup.py (path:/tmp/pip-oJLnxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:40 INFO - Running setup.py (path:/tmp/pip-Jj0Vq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:40 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)) 16:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:40 INFO - Running setup.py (path:/tmp/pip-k7MLTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:40 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)) 16:59:40 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)) 16:59:40 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)) 16:59:40 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)) 16:59:40 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)) 16:59:40 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)) 16:59:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:42 INFO - Downloading blessings-1.6.tar.gz 16:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:42 INFO - Installing collected packages: blessings 16:59:42 INFO - Running setup.py install for blessings 16:59:42 INFO - Successfully installed blessings 16:59:42 INFO - Cleaning up... 16:59:42 INFO - Return code: 0 16:59:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:42 INFO - Reading from file tmpfile_stdout 16:59:42 INFO - Current package versions: 16:59:42 INFO - argparse == 1.2.1 16:59:42 INFO - blessings == 1.6 16:59:42 INFO - blobuploader == 1.2.4 16:59:42 INFO - docopt == 0.6.1 16:59:42 INFO - manifestparser == 1.1 16:59:42 INFO - mozInstall == 1.12 16:59:42 INFO - mozcrash == 0.17 16:59:42 INFO - mozdebug == 0.1 16:59:42 INFO - mozdevice == 0.48 16:59:42 INFO - mozfile == 1.2 16:59:42 INFO - mozhttpd == 0.7 16:59:42 INFO - mozinfo == 0.9 16:59:42 INFO - mozleak == 0.1 16:59:42 INFO - mozlog == 3.1 16:59:42 INFO - moznetwork == 0.27 16:59:42 INFO - mozprocess == 0.22 16:59:42 INFO - mozprofile == 0.28 16:59:42 INFO - mozrunner == 6.11 16:59:42 INFO - mozscreenshot == 0.1 16:59:42 INFO - mozsystemmonitor == 0.0 16:59:42 INFO - moztest == 0.7 16:59:42 INFO - mozversion == 1.4 16:59:42 INFO - psutil == 3.1.1 16:59:42 INFO - requests == 1.2.3 16:59:42 INFO - wsgiref == 0.1.2 16:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:42 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')]} 16:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:42 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')]} 16:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:42 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:42 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 16:59:42 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 16:59:42 INFO - Using env: {'DISPLAY': ':0', 16:59:42 INFO - 'HOME': '/home/cltbld', 16:59:42 INFO - 'LANG': 'en_US.UTF-8', 16:59:42 INFO - 'LANGUAGE': 'en_US:en', 16:59:42 INFO - 'LOGNAME': 'cltbld', 16:59:42 INFO - 'MAIL': '/var/mail/cltbld', 16:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:42 INFO - 'MOZ_NO_REMOTE': '1', 16:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:42 INFO - 'NO_EM_RESTART': '1', 16:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:42 INFO - 'PWD': '/builds/slave/test', 16:59:42 INFO - 'SHELL': '/bin/bash', 16:59:42 INFO - 'SHLVL': '1', 16:59:42 INFO - 'TERM': 'linux', 16:59:42 INFO - 'TMOUT': '86400', 16:59:42 INFO - 'USER': 'cltbld', 16:59:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:42 INFO - '_': '/tools/buildbot/bin/python'} 16:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 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)) 16:59:43 INFO - Cleaning up... 16:59:43 INFO - Return code: 0 16:59:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:43 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:43 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 16:59:43 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 16:59:43 INFO - Using env: {'DISPLAY': ':0', 16:59:43 INFO - 'HOME': '/home/cltbld', 16:59:43 INFO - 'LANG': 'en_US.UTF-8', 16:59:43 INFO - 'LANGUAGE': 'en_US:en', 16:59:43 INFO - 'LOGNAME': 'cltbld', 16:59:43 INFO - 'MAIL': '/var/mail/cltbld', 16:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:43 INFO - 'MOZ_NO_REMOTE': '1', 16:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:43 INFO - 'NO_EM_RESTART': '1', 16:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:43 INFO - 'PWD': '/builds/slave/test', 16:59:43 INFO - 'SHELL': '/bin/bash', 16:59:43 INFO - 'SHLVL': '1', 16:59:43 INFO - 'TERM': 'linux', 16:59:43 INFO - 'TMOUT': '86400', 16:59:43 INFO - 'USER': 'cltbld', 16:59:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:43 INFO - '_': '/tools/buildbot/bin/python'} 16:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:43 INFO - Downloading/unpacking jsonschema 16:59:43 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 16:59:43 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 16:59:43 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 16:59:43 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 16:59:43 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 16:59:43 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 16:59:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:45 INFO - Downloading/unpacking functools32 (from jsonschema) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:45 INFO - warning: no files found matching '*.txt' 16:59:45 INFO - no previously-included directories found matching 'build' 16:59:45 INFO - no previously-included directories found matching 'dist' 16:59:45 INFO - no previously-included directories found matching '.git*' 16:59:45 INFO - Installing collected packages: jsonschema, functools32 16:59:45 INFO - Running setup.py install for functools32 16:59:45 INFO - warning: no files found matching '*.txt' 16:59:45 INFO - no previously-included directories found matching 'build' 16:59:45 INFO - no previously-included directories found matching 'dist' 16:59:45 INFO - no previously-included directories found matching '.git*' 16:59:45 INFO - Successfully installed jsonschema functools32 16:59:45 INFO - Cleaning up... 16:59:45 INFO - Return code: 0 16:59:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:59:45 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')]} 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:45 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')]} 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:45 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 0x7f3415631f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', '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 16:59:45 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 16:59:45 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 16:59:45 INFO - Using env: {'DISPLAY': ':0', 16:59:45 INFO - 'HOME': '/home/cltbld', 16:59:45 INFO - 'LANG': 'en_US.UTF-8', 16:59:45 INFO - 'LANGUAGE': 'en_US:en', 16:59:45 INFO - 'LOGNAME': 'cltbld', 16:59:45 INFO - 'MAIL': '/var/mail/cltbld', 16:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:45 INFO - 'MOZ_NO_REMOTE': '1', 16:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:45 INFO - 'NO_EM_RESTART': '1', 16:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:45 INFO - 'PWD': '/builds/slave/test', 16:59:45 INFO - 'SHELL': '/bin/bash', 16:59:45 INFO - 'SHLVL': '1', 16:59:45 INFO - 'TERM': 'linux', 16:59:45 INFO - 'TMOUT': '86400', 16:59:45 INFO - 'USER': 'cltbld', 16:59:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 16:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:45 INFO - '_': '/tools/buildbot/bin/python'} 16:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:45 INFO - Downloading/unpacking flake8 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:47 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 16:59:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:48 INFO - no previously-included directories found matching 'docs/_build' 16:59:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:48 INFO - Running setup.py install for pep8 16:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:48 INFO - no previously-included directories found matching 'docs/_build' 16:59:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:59:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:48 INFO - Cleaning up... 16:59:48 INFO - Return code: 0 16:59:48 INFO - Running post-action listener: _resource_record_post_action 16:59:48 INFO - Running post-action listener: _start_resource_monitoring 16:59:48 INFO - Starting resource monitoring. 16:59:48 INFO - ##### 16:59:48 INFO - ##### Running install step. 16:59:48 INFO - ##### 16:59:48 INFO - Running pre-action listener: _resource_record_pre_action 16:59:48 INFO - Running main action method: install 16:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:48 INFO - Reading from file tmpfile_stdout 16:59:48 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:59:48 INFO - Reading from file tmpfile_stdout 16:59:48 INFO - Output received: 16:59:48 INFO - Usage: mozinstall [options] installer 16:59:48 INFO - Options: 16:59:48 INFO - -h, --help show this help message and exit 16:59:48 INFO - -d DEST, --destination=DEST 16:59:48 INFO - Directory to install application into. [default: 16:59:48 INFO - "/builds/slave/test"] 16:59:48 INFO - --app=APP Application being installed. [default: firefox] 16:59:48 INFO - mkdir: /builds/slave/test/build/application 16:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:00:05 INFO - Reading from file tmpfile_stdout 17:00:05 INFO - Output received: 17:00:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:05 INFO - Running post-action listener: _resource_record_post_action 17:00:05 INFO - ##### 17:00:05 INFO - ##### Running run-tests step. 17:00:05 INFO - ##### 17:00:05 INFO - Running pre-action listener: _resource_record_pre_action 17:00:05 INFO - Running main action method: run_tests 17:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:05 INFO - Python 2.7.3 17:00:05 INFO - Return code: 0 17:00:05 INFO - grabbing minidump binary from tooltool 17:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:05 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a59810>, '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 0x1a5a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5aba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:05 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 17:00:05 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 17:00:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:05 INFO - Return code: 0 17:00:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:00:06 INFO - Return code: 0 17:00:06 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/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:00:06 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/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:00:06 INFO - Using env: {'DISPLAY': ':0', 17:00:06 INFO - 'HOME': '/home/cltbld', 17:00:06 INFO - 'LANG': 'en_US.UTF-8', 17:00:06 INFO - 'LANGUAGE': 'en_US:en', 17:00:06 INFO - 'LOGNAME': 'cltbld', 17:00:06 INFO - 'MAIL': '/var/mail/cltbld', 17:00:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:06 INFO - 'MOZ_NO_REMOTE': '1', 17:00:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:06 INFO - 'NO_EM_RESTART': '1', 17:00:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:06 INFO - 'PWD': '/builds/slave/test', 17:00:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:06 INFO - 'SHELL': '/bin/bash', 17:00:06 INFO - 'SHLVL': '1', 17:00:06 INFO - 'TERM': 'linux', 17:00:06 INFO - 'TMOUT': '86400', 17:00:06 INFO - 'USER': 'cltbld', 17:00:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967', 17:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:06 INFO - '_': '/tools/buildbot/bin/python'} 17:00:06 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/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:00:06 INFO - mozversion application_buildid: 20160425143034 17:00:06 INFO - mozversion application_changeset: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 17:00:06 INFO - mozversion application_display_name: Nightly 17:00:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:06 INFO - mozversion application_name: Firefox 17:00:06 INFO - mozversion application_remotingname: firefox 17:00:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:00:06 INFO - mozversion application_vendor: Mozilla 17:00:06 INFO - mozversion application_version: 48.0a1 17:00:06 INFO - mozversion platform_buildid: 20160425143034 17:00:06 INFO - mozversion platform_changeset: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 17:00:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:00:06 INFO - mozversion platform_version: 48.0a1 17:00:06 INFO - using testdate: 1461628806 17:00:06 INFO - actual date: 1461628806 17:00:06 INFO - starting webserver on 'localhost:57953' 17:00:06 INFO - SUITE-START | Running 2 tests 17:00:06 INFO - TEST-START | dromaeo_css 17:00:06 INFO - operating with platform_type : linux_ 17:00:06 INFO - Initialising browser for dromaeo_css test... 17:00:06 INFO - TEST-INFO | started process 17507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfG1VH/profile http://localhost:57953/getInfo.html) 17:00:11 INFO - PROCESS | 17507 | __metrics Screen width/height:1600/1200 17:00:11 INFO - PROCESS | 17507 | colorDepth:24 17:00:11 INFO - PROCESS | 17507 | Browser inner width/height: 1024/697 17:00:11 INFO - PROCESS | 17507 | __metrics 17:00:12 ERROR - PROCESS | 17507 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:00:13 INFO - TEST-INFO | 17507: exit 0 17:00:13 INFO - Browser initialized. 17:00:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:13 INFO - TEST-INFO | started process 17589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfG1VH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:24 INFO - PROCESS | 17589 | RSS: Main: 153997312 17:00:24 INFO - PROCESS | 17589 | 17:01:16 INFO - PROCESS | 17589 | 1461628876140 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] 17:03:23 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57953/tests/dromaeo/cssquery-ext.html) 17:03:24 INFO - PROCESS | 17589 | RSS: Main: 237080576 17:03:24 INFO - PROCESS | 17589 | 17:06:27 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-ext.html (next: http://localhost:57953/tests/dromaeo/cssquery-jquery.html) 17:06:27 INFO - PROCESS | 17589 | RSS: Main: 238256128 17:06:27 INFO - PROCESS | 17589 | 17:09:29 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57953/tests/dromaeo/cssquery-mootools.html) 17:09:30 INFO - PROCESS | 17589 | RSS: Main: 234176512 17:09:30 INFO - PROCESS | 17589 | 17:12:32 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57953/tests/dromaeo/cssquery-prototype.html) 17:12:32 INFO - PROCESS | 17589 | RSS: Main: 230830080 17:12:32 INFO - PROCESS | 17589 | 17:15:35 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57953/tests/dromaeo/cssquery-yui.html) 17:15:35 INFO - PROCESS | 17589 | RSS: Main: 219193344 17:15:35 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | Cycle 1(1): loaded http://localhost:57953/tests/dromaeo/cssquery-yui.html (next: http://localhost:57953/tests/dromaeo/cssquery-dojo.html) 17:18:38 INFO - PROCESS | 17589 | RSS: Main: 270708736 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | __start_tp_report 17:18:38 INFO - PROCESS | 17589 | _x_x_mozilla_page_load 17:18:38 INFO - PROCESS | 17589 | _x_x_mozilla_page_load_details 17:18:38 INFO - PROCESS | 17589 | |i|pagename|runs| 17:18:38 INFO - PROCESS | 17589 | |0;dojo.html;3087.475129228031;3108.2850944282827;3148.3073723780776;3148.4175427545892;3182.2044488877773;5133.512316329952;5220.556252718524;5251.553617942474;5266.683998960065;5298.0728372534795;5153.1754919212935;5243.239730239113;5245.4754524547625;5265.65773224741;5304.893902121965;4744.667873248874;4745.928811067828;4757.1437141314545;4770.856874293777;4883.487233840449;4811;4860.05228980349;4878.34142390778;4885.218365061591;4894.975525122387;4635.096156249533;4704.129735998834;4754.786034628415;4767.094252092092;4838.080764654722;4816.349792778;4827.879303017417;4830.975845120752;4843.636727245471;4884.755762211911;4803.903921921542;4811.566958973674;4813.831515896927;4823.541763532458;4823.831165909176;5105.2086926526445;5117.130087885069;5184.637075404723;5224.216367544861;5231.424543300234;5474.671519708831;5488.396276409631;5492.286002819648;5497.752601132958;5502.119660854244;5526.806561770359;5550.056490396642;5555.722213889289;5558.194061861048;5577.191307260465;5269.972355390701;5288.021715982594;5303.840884773463;5349.679019258818;5354.143337066051;5637.605367624227;5641.041023026095;5643.379228284885;5644.096944488862;5645.181448689917;5439.211314359475;5444.50999410055;5447.618666693294;5448.291722076105;5451.04606693827;5619.831405057855;5641.2384328116;5645.830625081254;5676.205331253628;5700.116481945305;5592.217089607459;5599.60802743804;5607.355154157242;5607.80372686954;5609.49514543693;5459.645123066988;5553.139263414178;5614.1859430382365;5615.634983726045;5617.747201375948;4260.339647354665;4261.446012018418;4273.850415235452;4298.849540266138;4303.634191093792;3822.445745366906;3833.923321533554;3845.0964023454467;3880.3015457217407;3880.476135721698;5209.088409528317;5240.816571419982;5269.815556455583;5289.841304760864;5290.867728306746;5592.3009623797025;5610.467005634539;5611.2144299798065;5622.409646987089;5634.6337488063145;5245.10833158364;5254.553362964114;5258.368995720538;5258.947410525846;5308.283381743415;4771.976140119346;4792.017636384533;4801.95198048022;4805.27920811874;4848.951510484921;5785.768569257267;5790.131480277908;5795.159701843209;5801.274840644919;5837.88324233513;5627.915581266284;5639.266895303748;5643.661380317194;5643.943560564342;5646.887062258814;5703.857403564778;5734;5774.913376299275;5798.043322851682;5892.705364731832;5575.609707320448;5600.047991841316;5604.495595396434;5608.355039170385;5626.831195064155;5614.69119198448;5659.462351076806;5674.602777805514;5682;5685.857853553694;5396.487333703292;5425.941941321405;5472.972635136799;5500.642458240201;5502.119660854244;5473.31583552056;5485.75314110858;5486.917696234639;5496.697681627389;5496.780128794803;5391.29913111293;5402.783888644411;5409.323834520685;5416.350037995466;5426.294581704353;5354;5468.507834294933;5476.342838859362;5552.250446189712;5571.944280557304;5370.489803468664;5370.704611246419;5373.919391209213;5374.704391258519;5411.567074633941 17:18:38 INFO - PROCESS | 17589 | |1;ext.html;599.9220101386819;625.749700119952;638.4828289085841;645.1838424393146;646.2309851276977;30082.398352032946;30646.241838234553;30720;38237.617623823826;39493.210135797264;40965.7951710241;41494.58505414945;41516;41772.791136044354;41799.79100104495;8480.32157427406;8697.434666746673;8698.652053917836;8698.956505217497;8702.260307873838;8403.579821008956;8506.404551681384;8531;8538.829223415529;8541.530215838126;8773.42972706772;8810.207081362676;8812.38313318068;8832;8837.646494140226;8725.520096394695;8745.737627871174;8764.079771623952;8765.693200737975;8768.605412756377;8643.35174861888;8777.868331975025;8782.516961567111;8797.164269394398;8799.736007919773;41575.1684966302;42096;42193.36709949353;42240;42245;3345.6152542457444;3468.809215493147;3521.5245941798044;3542.4863394807867;3551.254236610315;31340.529892051636;31665.8416707915;31967;32180.517292240635;32361.51457728136;3990.700697447674;4026.697997650188;4030.9395359069636;4055.959440405617;4109.91780164398;311655;311847;313991;314583;315565;46240;49851;58565;59544.70227648921;59609.403905961255;53581.73209133929;53612.46387536153;53918;53918.73040634772;54011.729941350044;15776.211189440482;16047.197640117947;16059.197040147947;16060.75908861368;16120.838791612168;10845.078168355778;11759.706007349885;11993.64019079429;12104.15270931044;12106.697332566757;17566.91216543909;17594.560135996704;17733;17801.821981780016;17820.55448613795;5797.768089276382;6039.909401358983;6111.236095488064;6170.136180934673;6196.428482179935;1059.6026490066224;1061.5276202089997;1070.8768491623407;1075.2365820267698;1089.4716062709579;32762.508562371582;32836.507452388236;32935;33146.83426582852;33578.16054598606;1085.9249343150382;1112.5772206561455;1120.3166068698088;1133.982990255147;1196.9825648199135;17052.2326495308;17460;17599.296028158988;17651.55871103233;17719.468415947544;482263;488018;489241;489651;489920;57654.4234557649;58108.41891581115;58216;58227.41772582305;58273;1281.6923938254938;1370.3833275026277;1388.8958328125432;1393.7351903138372;1512.553796629997;27966.440671186054;29271;29370.55944160882;30547.694523054484;32019.839900800347;46339.30491042569;46461.53538464572;46819;46839.06321873475;46964;281286.8713128671;282642;282765;283272;283359;32542.34915301728;38866.222675546895;39764.620007298545;40130;40502.392464113655;43424.34863476987;44663.33005004862;44669;45362.546374535836;45657.31514027359;39704.80147599243;41174;42151.36772948347;42443.5755642452;42782.358264625436;40769;40863.387049194884;41204.38193427041;41291.7935410321;42301;42554;43074;43180;44126.779366102965;44253.77873110614;35690;36292.45561316635;36732.632673672924;37021.44467833039;37278.6272137286;27566;28052.43895122127;28690;28945.56581651235;29012.27469313284 17:18:38 INFO - PROCESS | 17589 | |2;jquery.html;388.9066624010238;389.143883456396;389.5092183848351;402.0872619154519;402.4848194311281;13914.165150091001;16408.425705100322;19126.52183695408;19528.609427811454;19630.803691963076;14010;17431.82568174318;17585.296588136458;17800.64398712025;17815.91092044541;5487.368952570456;5514.724263786815;5571.721413929307;5608.663480191181;5622.91565626516;4025.1144748155357;5442.265294185274;5607.439256074401;5632.436756324376;5918.58569900105;6114.571979961404;6132.356102609228;6138.907916381258;6148.169997050408;6160.445559899608;6032.607880487754;6097.634141951475;6132.325444201112;6294.024426213944;6294.905576416311;5500.532454741312;5500.80747173851;5511.559075273968;5523.4200408956885;5540.141278101901;21377.67933480999;21871.67192492114;22083.227087051877;22540.09839606414;22554.88722556377;2321.129576408847;2345.835791494596;2375.655529948165;2387.2599494156693;2388.140269502995;9407.858882116774;9642.75893102671;9981.051800079054;13366.33168341579;14479.058861174095;1913.167772019176;1969.202472998438;1971.9112639931238;1988.135161204866;2021.9696704549444;51137.744311278206;83952.58023709903;85497.99999999937;85819;87533.56233218857;10133.442660653587;10279.074883260393;10284.125849302893;10397.220208484394;10886.67339979802;13976.580702578938;14018.719625607431;14035.649108772159;14037.649058773408;14077.859221407654;6953.582785032914;7283.817904552428;7780.922190778133;8154.8776768348525;8274.338052955749;7171.89242161368;7232.493725439169;7410.11078670563;7599.050118735158;7637.732679356196;4545.204589196944;4640.86077417678;4653.813847446132;4706.1999460091865;4708.293755936637;1800.2349001674236;1916.5400303926958;1934.429343343717;1956.6673665476903;1963.59746252018;889.8798662180523;1003.3127307794184;1019.4902548725637;1059.655611926127;1066.2962444786403;17971.910140449214;18593.814061859477;18595.721064184047;18656.160472778487;18710.25158993652;997.3766396002499;1003.2626019875386;1039.1167507618463;1044.5769463367349;1104.2270410712533;10051.346662466916;10314.27800054004;10551.577936882439;10589.57641694339;10606.469676516142;487230;496618;506416;511850;525498;93522.53238733899;93663.53168234116;93709;94802.52598736962;94867;1013.2906965124442;1018.1956254558963;1044.2846650044744;1046.9319494233002;1047.7799662070897;16021.8397816025;16068.437604684248;16187.595310117342;16219.594510137342;16356.427525036566;37487.43768843415;37743;37743.62256377401;37977.81011094927;38585.421218682306;50018.74990625024;50926.74536627293;54042.729786350814;55767.442325577846;56002.43997559972;8172.5913704315735;8339.041010283652;8469;8585.484870907765;8586.098459661895;11545.826812597987;13052.738945221232;13102.410391532594;13180.143290686075;13523.797143042666;11462.312261264351;11772.646820595395;11805.114616403976;11822.82265765997;11925.105617078927;11265.605703800655;11584.247023943417;11624.535018599161;11699.707507312385;11963.521459141537;6538.803835884931;10409.739756506147;10922.58006459187;11648;12230.633081007229;8631.87052194205;8747.30021598258;8761.605727742395;8824.911750882666;8853.114688531095;8825.602847871733;11139.944300278446;11491.065927295027;11497.712557186138;11562.595309164139 17:18:38 INFO - PROCESS | 17589 | |3;mootools.html;1308.6270412932315;1438.6762978329873;1464.7656374980002;1603.703314886746;1764.0033381139663;7607.733729319475;7810.726624568141;7812.492188007775;7824.882626760596;7914.881276780853;7695.422843286748;7858.253465920729;7860.331871790904;7873.173316801739;7883.8423231535335;1949.1813438355925;2005.1778770704013;2008.538036251663;2134.4877229464896;2163.350994701591;2192.243675931801;2265.9320220393415;2272.3978145791298;2273.3407311879537;2276.7723227677184;2169.837262205333;2189.540196558725;2203.592335417945;2203.603351396748;2215.3353993801793;1935.8257756801816;2114.7990940860595;2178.6187417201927;2178.716766820311;2182.5853087913324;2205.790449907256;2231.364061242538;2236.0608544411384;2238.4292005538646;2240.697505836724;7628.122765881939;7685.692572297102;7690.077190737092;7692.4615276930635;7699.807504812368;4342.109867477159;4507.887302817423;4510.797014134339;4532.864014079583;4533.229351010304;2844.975808708863;3062.3262882165886;3105.4410206162884;3118.7193152616373;3130.4834702274097;963.3689933093834;979.4710856137677;991.5438898106879;1025.487256371814;1026.1636766035658;11271.887281127249;11278.097752179807;11280.605178818701;11317.943410282896;11326.830097548544;4144.48193975753;4182.1844740275355;4268.423762792046;4288.163808057461;4290.678199135077;9521.571529281198;9535.713928582154;9556.092171243721;9560.856587151198;9565.378250413702;4854.417469903564;4858.878528036827;4860.73265970368;4866.805327786919;4869.318295438641;3945.723799334019;4186.81159347824;4301.763403012802;4381.38660587518;4487;3648.4709717090873;3713.9257214856093;3779.074126838942;3802.9809850951124;3805.448210009533;1168.6435637130758;1183.3846399872018;1203.3381640097912;1208.5769980506927;1223.700193452592;958.8993155718689;970.0590427285522;975.9170470509944;977.3451787302524;993.2153598657125;5492.91760623583;5593.244911936837;5667.234923285304;5673.631213971079;5717.514011309002;362.64460828388326;398.8125580976936;400.20958606752015;401.67865707433936;402.28594245214975;3959.604039596017;3978.2640211560374;4144.8134833932545;4177.394277829759;4193.916121677549;9560.856587151198;9800.31397802147;9889.752756181153;9925.15636170919;9928.950355248178;9631.325807193569;9679.128878400978;9801.705948821404;9822.508874556244;9857.11285984265;7331.706731730777;7340.706371745177;7392.223816499298;7468.3942952265525;7514.47398682087;5668.433156684464;5723.942760572341;5796.62321949072;5805.593608447368;5857.264146231697;8643.265322447662;8736.825263494822;8803.515806630698;8842.381033327863;9131.634734610541;8469.195426434479;8809.779755506164;8854.734357969272;8887.688930887389;8894.155055269997;6474.5791523550815;6878.209005964178;7018.789436316919;7065.434765218667;7100.538464999759;7516.24837516244;7524.924750752422;7545.547267163988;7608.16310205888;7613.809654758676;6860.211075726355;7091.255418181223;7136.215016348094;7179.533330333512;7250.274972502708;6984.580925144304;6999.4050505705545;7018.157821061505;7073.221945586084;7144.24985376528;6397.744090236339;6546.934530654823;6587.242467116343;6619.404253617197;6621.5364924454825;4965.4786247444945;5016.573591244785;5044.47033061538;5052.570531504716;5057.31726216956;4949.876253093557;4963;4969.279454479008;4969.627277954096;4989.675671081368 17:18:38 INFO - PROCESS | 17589 | |4;prototype.html;324.6315431984697;327.21958129860275;330.84781000739656;332.6407479921683;334.99497507537376;5124.873826965552;5168.948310516894;5197.610179236558;5198;5205.115130427826;5159.148740457829;5162.535371816536;5172.327597412331;5178.870528236796;5211.348581427322;3887.300285948528;3972.165845172517;4086.2440448516973;4098.262312783712;4099.733517321364;4049.6557792587664;4071.3689378146287;4076.408920706496;4084.8978775530554;4090.9590904090874;3876.8836934891856;4048.7368321059184;4060.330045542482;4061.6344528992386;4080.9387859182134;3975.7614543127506;4057.97971010146;4069.450624165759;4073.8370465181356;4076.7961601920083;3604.2070744436182;3635.2547727715755;3639.3085313790293;3652.196516766307;3653.4702468142236;5016.54851063406;5021.824236151754;5024.949750502485;5036.974815125901;5048.747562621854;4552.567506086916;4680.555347242007;4685.88285292867;4690.835820746292;4717.080169366975;5367.946320536784;5390.811321603765;5392.352917649868;5408.4050754416985;5440.265564148868;4007.438958545806;4010.0977280112033;4021.617946295097;4038.2125485530332;4038.414429907676;5548.77804887804;5655.660660360391;5672.624788250984;5675.262215911905;5685.317761868602;4071.3689378146437;4083.2037752638544;4097.85657501986;4098.836046558164;4098.979505102456;4139.068709540329;4154.605312495308;4157.792110394468;4158.771267580251;4172.874813755531;4580.129775342674;4603.102395032936;4632.652551058684;4658.880209504668;4726.787294571753;5450.836474905759;5456.91814622781;5483.561315094783;5494.977762230757;5505.394406615269;1502.9248537573078;1521.7945577346916;1522.619345163709;1522.710684969852;1524.2378810594703;976.6386437018207;984.4634674102631;1037.678319720889;1051.264115119404;1055.6991257491577;5519.199716041152;5529.640573362719;5540.972295138498;5581;5582.441755824385;5850.3272123705465;5863.794767183128;5880.294364676266;5906.438888305604;5927.110933359944;5387.919181212285;5490.505854473116;5521.69630670317;5531.612787104864;5554.527865131428;3127.7341425978593;3132.6084239470065;3149.2441813964483;3150.212446888278;3160.3995240904155;5971.462568368867;6030.497343602444;6076.574639775174;6077.544184186204;6101.420365065312;5956.821295361146;5962.910556341659;5996.4003599640555;5996.970015149896;6006.279246490361;6004.849878752979;6028.739222791541;6045.153678485103;6061.151438798572;6077.997130473423;5411.675299482044;5712.25740653729;5712.8571785704025;5736.282964629421;5837.6497410155525;5599.944000559943;5629.943700563106;5633.971830140823;5651.378348381757;5656.915146272891;5678;5827.766889324549;5837.708114594338;5846.889091072682;5850.882982340415;3944.1322908959983;3952.4268980998168;3991.980040099781;3993.940090898697;3999.8000099995465;5640.802571909963;5681.147827825694;5693.686847223443;5697.4587414195585;5712.228849105318;5225.3990791057995;5353.036453438419;5463.918041229305;5477.1510415885605;5513.173024046425;5392.325959255093;5400.459954004568;5459.344878614592;5466.91799623014;5511.751971161227;5179.896402071862;5363.329583802025;5364.114921038141;5378.462153784591;5389.407165211745;5427;5474.671519708831;5476.726163691879;5484.561235101262;5497.47773961473;5325.786968521371;5347.759350829144;5401.594880383908;5426.864328391822;5432.483914028161 17:18:38 INFO - PROCESS | 17589 | |5;yui.html;713.953593016454;735.0664655887024;735.3639102176619;801.5150833745583;811.3509192645881;12228;12382;12383.257004579731;12405.813912791304;12668.176568523051;11826.940865295683;12270.202436841599;12275.202111862724;12283.754324913518;12301.3234272115;662.9535932484728;776.9339606133485;793.3811626930989;805.432170319926;808.9231523005305;801.4069588504523;805.5046146619816;805.875089361147;808.8624933761246;809.7732634862218;848.0459483081534;848.3043903998723;850.196564246787;850.3494826457734;850.7320194138827;690.8721886451023;813.6582635293191;833.4624167412046;835.5070508400073;835.6740871060291;613.3804857094323;613.5214532664529;614.0758158970765;614.2935624032353;614.3487902823022;12436.875631243662;12467.625971220878;12499.625011249676;12518.06114541413;12522.248665080124;11628.302301861831;11951.581694640732;12322.445489952885;12494.500219991189;12669.166964321092;9717;9778.168855647278;10127.746806329827;10153.187744980383;10231;3778.452124441968;3786.8863934082024;3833.7124715646437;3867.1878905429894;3935.527736671589;56111.43888561103;56232;56256.43743562553;56598.434015659725;57152.428475715125;9232;9448.050655091372;9455.385399948982;9586.281028922858;9687.66093186735;16415.83584164143;16502.092384918706;16531.83468165303;16539.338426463048;16563.08903010322;7225.963870180721;7440.665170067252;7445.367143792838;7515.736949206861;7652.502587331805;4002.599740026032;4041.6943181761762;4051;4065.5324637666454;4090.775007374623;2985.2984548631052;3050.42042012017;3055.144559523337;3062.8774849006236;3063.7702172336717;545.9317585301837;564.6499170514307;588.8998870192078;592.165047283337;623.1182876230174;680.8774420604339;732.9743458979017;754.705664790732;761.1133030020076;774.1097737601802;8812.51531165792;8991.235744961621;9013.369064165576;9106.071046928544;9228.215601673799;645.5061877663591;706.5760543673857;731.5756861020595;739.9123288765506;756.1380026769488;4234.491860976703;4311.547287534827;4408.382826404306;4451.421315228999;4496.123255965055;57038.714806425705;57961;58351.41648583545;58674;58696;54883;54914.450855491734;56128.43871561314;58820.7058964711;60066.39933600696;50094;50155.74922125366;52754.73622631862;55198;55286.72356638191;8867.423617464845;8955.552222388986;8959.372843900865;9077.90922090797;9090.954545227232;32181.03456896297;32715;33132;34062.148446289044;34806.65193348034;42825.14349712926;47062.52937470582;47227.52772472231;47855.28217076677;48450.5154948446;11249.718757030812;11467.713307167054;11605.825912611148;11621.88378116208;11628;12006.699832504257;12214.450349734461;12306.569270075504;12619.432125554189;13026.934865325613;11636.650900473;11653.825192621947;11752.823707644222;11913.821292680443;11990.700232493908;11147.777044459228;11461;11591.6522504325;11594.76810463803;11758.882411175779;11362.938759344719;11414.313280982515;11624.88375116238;11670.276595215113;11720.765584688088;9934.354266972623;10037.498125093862;10109.14072303833;10352.482375881327;10367.118794902517;9832.803343933225;10311.381317120997;10409.167266618804;10412.583496660049;10429.374237545468 17:18:38 INFO - PROCESS | 17589 | __end_tp_report 17:18:38 INFO - PROCESS | 17589 | __start_cc_report 17:18:38 INFO - PROCESS | 17589 | _x_x_mozilla_cycle_collect,991 17:18:38 INFO - PROCESS | 17589 | __end_cc_report 17:18:38 INFO - PROCESS | 17589 | __startTimestamp1461629918736__endTimestamp 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | ------- Summary: start ------- 17:18:38 INFO - PROCESS | 17589 | Number of tests: 6 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#0] dojo.html Cycles:165 Average:5208.82 Median:5402.78 stddev:569.80 (10.5%) stddev-sans-first:546.70 17:18:38 INFO - PROCESS | 17589 | Values: 3087.5 3108.3 3148.3 3148.4 3182.2 5133.5 5220.6 5251.6 5266.7 5298.1 5153.2 5243.2 5245.5 5265.7 5304.9 4744.7 4745.9 4757.1 4770.9 4883.5 4811.0 4860.1 4878.3 4885.2 4895.0 4635.1 4704.1 4754.8 4767.1 4838.1 4816.3 4827.9 4831.0 4843.6 4884.8 4803.9 4811.6 4813.8 4823.5 4823.8 5105.2 5117.1 5184.6 5224.2 5231.4 5474.7 5488.4 5492.3 5497.8 5502.1 5526.8 5550.1 5555.7 5558.2 5577.2 5270.0 5288.0 5303.8 5349.7 5354.1 5637.6 5641.0 5643.4 5644.1 5645.2 5439.2 5444.5 5447.6 5448.3 5451.0 5619.8 5641.2 5645.8 5676.2 5700.1 5592.2 5599.6 5607.4 5607.8 5609.5 5459.6 5553.1 5614.2 5615.6 5617.7 4260.3 4261.4 4273.9 4298.8 4303.6 3822.4 3833.9 3845.1 3880.3 3880.5 5209.1 5240.8 5269.8 5289.8 5290.9 5592.3 5610.5 5611.2 5622.4 5634.6 5245.1 5254.6 5258.4 5258.9 5308.3 4772.0 4792.0 4802.0 4805.3 4849.0 5785.8 5790.1 5795.2 5801.3 5837.9 5627.9 5639.3 5643.7 5643.9 5646.9 5703.9 5734.0 5774.9 5798.0 5892.7 5575.6 5600.0 5604.5 5608.4 5626.8 5614.7 5659.5 5674.6 5682.0 5685.9 5396.5 5425.9 5473.0 5500.6 5502.1 5473.3 5485.8 5486.9 5496.7 5496.8 5391.3 5402.8 5409.3 5416.4 5426.3 5354.0 5468.5 5476.3 5552.3 5571.9 5370.5 5370.7 5373.9 5374.7 5411.6 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#1] ext.html Cycles:180 Average:53010.87 Median:40816.19 stddev:98391.39 (241.1%) stddev-sans-first:98588.71 17:18:38 INFO - PROCESS | 17589 | Values: 599.9 625.7 638.5 645.2 646.2 30082.4 30646.2 30720.0 38237.6 39493.2 40965.8 41494.6 41516.0 41772.8 41799.8 8480.3 8697.4 8698.7 8699.0 8702.3 8403.6 8506.4 8531.0 8538.8 8541.5 8773.4 8810.2 8812.4 8832.0 8837.6 8725.5 8745.7 8764.1 8765.7 8768.6 8643.4 8777.9 8782.5 8797.2 8799.7 41575.2 42096.0 42193.4 42240.0 42245.0 3345.6 3468.8 3521.5 3542.5 3551.3 31340.5 31665.8 31967.0 32180.5 32361.5 3990.7 4026.7 4030.9 4056.0 4109.9 311655.0 311847.0 313991.0 314583.0 315565.0 46240.0 49851.0 58565.0 59544.7 59609.4 53581.7 53612.5 53918.0 53918.7 54011.7 15776.2 16047.2 16059.2 16060.8 16120.8 10845.1 11759.7 11993.6 12104.2 12106.7 17566.9 17594.6 17733.0 17801.8 17820.6 5797.8 6039.9 6111.2 6170.1 6196.4 1059.6 1061.5 1070.9 1075.2 1089.5 32762.5 32836.5 32935.0 33146.8 33578.2 1085.9 1112.6 1120.3 1134.0 1197.0 17052.2 17460.0 17599.3 17651.6 17719.5 482263.0 488018.0 489241.0 489651.0 489920.0 57654.4 58108.4 58216.0 58227.4 58273.0 1281.7 1370.4 1388.9 1393.7 1512.6 27966.4 29271.0 29370.6 30547.7 32019.8 46339.3 46461.5 46819.0 46839.1 46964.0 281286.9 282642.0 282765.0 283272.0 283359.0 32542.3 38866.2 39764.6 40130.0 40502.4 43424.3 44663.3 44669.0 45362.5 45657.3 39704.8 41174.0 42151.4 42443.6 42782.4 40769.0 40863.4 41204.4 41291.8 42301.0 42554.0 43074.0 43180.0 44126.8 44253.8 35690.0 36292.5 36732.6 37021.4 37278.6 27566.0 28052.4 28690.0 28945.6 29012.3 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#2] jquery.html Cycles:180 Average:28894.95 Median:2381.46 stddev:83331.21 (3499.2%) stddev-sans-first:83537.48 17:18:38 INFO - PROCESS | 17589 | Values: 388.9 389.1 389.5 402.1 402.5 13914.2 16408.4 19126.5 19528.6 19630.8 14010.0 17431.8 17585.3 17800.6 17815.9 5487.4 5514.7 5571.7 5608.7 5622.9 4025.1 5442.3 5607.4 5632.4 5918.6 6114.6 6132.4 6138.9 6148.2 6160.4 6032.6 6097.6 6132.3 6294.0 6294.9 5500.5 5500.8 5511.6 5523.4 5540.1 21377.7 21871.7 22083.2 22540.1 22554.9 2321.1 2345.8 2375.7 2387.3 2388.1 9407.9 9642.8 9981.1 13366.3 14479.1 1913.2 1969.2 1971.9 1988.1 2022.0 51137.7 83952.6 85498.0 85819.0 87533.6 10133.4 10279.1 10284.1 10397.2 10886.7 13976.6 14018.7 14035.6 14037.6 14077.9 6953.6 7283.8 7780.9 8154.9 8274.3 7171.9 7232.5 7410.1 7599.1 7637.7 4545.2 4640.9 4653.8 4706.2 4708.3 1800.2 1916.5 1934.4 1956.7 1963.6 889.9 1003.3 1019.5 1059.7 1066.3 17971.9 18593.8 18595.7 18656.2 18710.3 997.4 1003.3 1039.1 1044.6 1104.2 10051.3 10314.3 10551.6 10589.6 10606.5 487230.0 496618.0 506416.0 511850.0 525498.0 93522.5 93663.5 93709.0 94802.5 94867.0 1013.3 1018.2 1044.3 1046.9 1047.8 16021.8 16068.4 16187.6 16219.6 16356.4 37487.4 37743.0 37743.6 37977.8 38585.4 50018.7 50926.7 54042.7 55767.4 56002.4 8172.6 8339.0 8469.0 8585.5 8586.1 11545.8 13052.7 13102.4 13180.1 13523.8 11462.3 11772.6 11805.1 11822.8 11925.1 11265.6 11584.2 11624.5 11699.7 11963.5 6538.8 10409.7 10922.6 11648.0 12230.6 8631.9 8747.3 8761.6 8824.9 8853.1 8825.6 11139.9 11491.1 11497.7 11562.6 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#3] mootools.html Cycles:180 Average:5277.45 Median:5054.94 stddev:2949.55 (58.3%) stddev-sans-first:2942.74 17:18:38 INFO - PROCESS | 17589 | Values: 1308.6 1438.7 1464.8 1603.7 1764.0 7607.7 7810.7 7812.5 7824.9 7914.9 7695.4 7858.3 7860.3 7873.2 7883.8 1949.2 2005.2 2008.5 2134.5 2163.4 2192.2 2265.9 2272.4 2273.3 2276.8 2169.8 2189.5 2203.6 2203.6 2215.3 1935.8 2114.8 2178.6 2178.7 2182.6 2205.8 2231.4 2236.1 2238.4 2240.7 7628.1 7685.7 7690.1 7692.5 7699.8 4342.1 4507.9 4510.8 4532.9 4533.2 2845.0 3062.3 3105.4 3118.7 3130.5 963.4 979.5 991.5 1025.5 1026.2 11271.9 11278.1 11280.6 11317.9 11326.8 4144.5 4182.2 4268.4 4288.2 4290.7 9521.6 9535.7 9556.1 9560.9 9565.4 4854.4 4858.9 4860.7 4866.8 4869.3 3945.7 4186.8 4301.8 4381.4 4487.0 3648.5 3713.9 3779.1 3803.0 3805.4 1168.6 1183.4 1203.3 1208.6 1223.7 958.9 970.1 975.9 977.3 993.2 5492.9 5593.2 5667.2 5673.6 5717.5 362.6 398.8 400.2 401.7 402.3 3959.6 3978.3 4144.8 4177.4 4193.9 9560.9 9800.3 9889.8 9925.2 9929.0 9631.3 9679.1 9801.7 9822.5 9857.1 7331.7 7340.7 7392.2 7468.4 7514.5 5668.4 5723.9 5796.6 5805.6 5857.3 8643.3 8736.8 8803.5 8842.4 9131.6 8469.2 8809.8 8854.7 8887.7 8894.2 6474.6 6878.2 7018.8 7065.4 7100.5 7516.2 7524.9 7545.5 7608.2 7613.8 6860.2 7091.3 7136.2 7179.5 7250.3 6984.6 6999.4 7018.2 7073.2 7144.2 6397.7 6546.9 6587.2 6619.4 6621.5 4965.5 5016.6 5044.5 5052.6 5057.3 4949.9 4963.0 4969.3 4969.6 4989.7 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#4] prototype.html Cycles:180 Average:4671.20 Median:5336.77 stddev:1366.95 (25.6%) stddev-sans-first:1331.28 17:18:38 INFO - PROCESS | 17589 | Values: 324.6 327.2 330.8 332.6 335.0 5124.9 5168.9 5197.6 5198.0 5205.1 5159.1 5162.5 5172.3 5178.9 5211.3 3887.3 3972.2 4086.2 4098.3 4099.7 4049.7 4071.4 4076.4 4084.9 4091.0 3876.9 4048.7 4060.3 4061.6 4080.9 3975.8 4058.0 4069.5 4073.8 4076.8 3604.2 3635.3 3639.3 3652.2 3653.5 5016.5 5021.8 5024.9 5037.0 5048.7 4552.6 4680.6 4685.9 4690.8 4717.1 5367.9 5390.8 5392.4 5408.4 5440.3 4007.4 4010.1 4021.6 4038.2 4038.4 5548.8 5655.7 5672.6 5675.3 5685.3 4071.4 4083.2 4097.9 4098.8 4099.0 4139.1 4154.6 4157.8 4158.8 4172.9 4580.1 4603.1 4632.7 4658.9 4726.8 5450.8 5456.9 5483.6 5495.0 5505.4 1502.9 1521.8 1522.6 1522.7 1524.2 976.6 984.5 1037.7 1051.3 1055.7 5519.2 5529.6 5541.0 5581.0 5582.4 5850.3 5863.8 5880.3 5906.4 5927.1 5387.9 5490.5 5521.7 5531.6 5554.5 3127.7 3132.6 3149.2 3150.2 3160.4 5971.5 6030.5 6076.6 6077.5 6101.4 5956.8 5962.9 5996.4 5997.0 6006.3 6004.8 6028.7 6045.2 6061.2 6078.0 5411.7 5712.3 5712.9 5736.3 5837.6 5599.9 5629.9 5634.0 5651.4 5656.9 5678.0 5827.8 5837.7 5846.9 5850.9 3944.1 3952.4 3992.0 3993.9 3999.8 5640.8 5681.1 5693.7 5697.5 5712.2 5225.4 5353.0 5463.9 5477.2 5513.2 5392.3 5400.5 5459.3 5466.9 5511.8 5179.9 5363.3 5364.1 5378.5 5389.4 5427.0 5474.7 5476.7 5484.6 5497.5 5325.8 5347.8 5401.6 5426.9 5432.5 17:18:38 INFO - PROCESS | 17589 | 17:18:38 INFO - PROCESS | 17589 | [#5] yui.html Cycles:180 Average:14342.17 Median:49272.26 stddev:17328.36 (35.2%) stddev-sans-first:17346.75 17:18:38 INFO - PROCESS | 17589 | Values: 714.0 735.1 735.4 801.5 811.4 12228.0 12382.0 12383.3 12405.8 12668.2 11826.9 12270.2 12275.2 12283.8 12301.3 663.0 776.9 793.4 805.4 808.9 801.4 805.5 805.9 808.9 809.8 848.0 848.3 850.2 850.3 850.7 690.9 813.7 833.5 835.5 835.7 613.4 613.5 614.1 614.3 614.3 12436.9 12467.6 12499.6 12518.1 12522.2 11628.3 11951.6 12322.4 12494.5 12669.2 9717.0 9778.2 10127.7 10153.2 10231.0 3778.5 3786.9 3833.7 3867.2 3935.5 56111.4 56232.0 56256.4 56598.4 57152.4 9232.0 9448.1 9455.4 9586.3 9687.7 16415.8 16502.1 16531.8 16539.3 16563.1 7226.0 7440.7 7445.4 7515.7 7652.5 4002.6 4041.7 4051.0 4065.5 4090.8 2985.3 3050.4 3055.1 3062.9 3063.8 545.9 564.6 588.9 592.2 623.1 680.9 733.0 754.7 761.1 774.1 8812.5 8991.2 9013.4 9106.1 9228.2 645.5 706.6 731.6 739.9 756.1 4234.5 4311.5 4408.4 4451.4 4496.1 57038.7 57961.0 58351.4 58674.0 58696.0 54883.0 54914.5 56128.4 58820.7 60066.4 50094.0 50155.7 52754.7 55198.0 55286.7 8867.4 8955.6 8959.4 9077.9 9091.0 32181.0 32715.0 33132.0 34062.1 34806.7 42825.1 47062.5 47227.5 47855.3 48450.5 11249.7 11467.7 11605.8 11621.9 11628.0 12006.7 12214.5 12306.6 12619.4 13026.9 11636.7 11653.8 11752.8 11913.8 11990.7 11147.8 11461.0 11591.7 11594.8 11758.9 11362.9 11414.3 11624.9 11670.3 11720.8 9934.4 10037.5 10109.1 10352.5 10367.1 9832.8 10311.4 10409.2 10412.6 10429.4 17:18:38 INFO - PROCESS | 17589 | -------- Summary: end -------- 17:18:38 INFO - PROCESS | 17589 | 17:18:39 INFO - TEST-INFO | 17589: exit 0 17:18:39 INFO - TEST-OK | dromaeo_css | took 1112646ms 17:18:39 INFO - TEST-START | kraken 17:18:39 INFO - operating with platform_type : linux_ 17:18:39 INFO - Initialising browser for kraken test... 17:18:39 INFO - TEST-INFO | started process 17771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaTR60/profile http://localhost:57953/getInfo.html) 17:18:43 INFO - PROCESS | 17771 | __metrics Screen width/height:1600/1200 17:18:43 INFO - PROCESS | 17771 | colorDepth:24 17:18:43 INFO - PROCESS | 17771 | Browser inner width/height: 1024/697 17:18:43 INFO - PROCESS | 17771 | __metrics 17:18:44 ERROR - PROCESS | 17771 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:45 INFO - TEST-INFO | 17771: exit 0 17:18:45 INFO - Browser initialized. 17:18:45 INFO - Running cycle 1/1 for kraken test... 17:18:45 INFO - TEST-INFO | started process 17855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaTR60/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:57 INFO - PROCESS | 17855 | RSS: Main: 154357760 17:18:57 INFO - PROCESS | 17855 | 17:18:59 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57953/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:00 INFO - PROCESS | 17855 | RSS: Main: 209686528 17:19:00 INFO - PROCESS | 17855 | 17:19:03 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57953/tests/kraken/driver.html?testName=audio-dft) 17:19:03 INFO - PROCESS | 17855 | RSS: Main: 195121152 17:19:03 INFO - PROCESS | 17855 | 17:19:07 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57953/tests/kraken/driver.html?testName=audio-fft) 17:19:07 INFO - PROCESS | 17855 | RSS: Main: 266350592 17:19:07 INFO - PROCESS | 17855 | 17:19:09 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57953/tests/kraken/driver.html?testName=audio-oscillator) 17:19:10 INFO - PROCESS | 17855 | RSS: Main: 174129152 17:19:10 INFO - PROCESS | 17855 | 17:19:12 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:13 INFO - PROCESS | 17855 | RSS: Main: 178872320 17:19:13 INFO - PROCESS | 17855 | 17:19:16 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57953/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:16 INFO - PROCESS | 17855 | RSS: Main: 214888448 17:19:16 INFO - PROCESS | 17855 | 17:19:20 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57953/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:20 INFO - PROCESS | 17855 | RSS: Main: 215699456 17:19:20 INFO - PROCESS | 17855 | 17:19:23 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57953/tests/kraken/driver.html?testName=json-parse-financial) 17:19:24 INFO - PROCESS | 17855 | RSS: Main: 215900160 17:19:24 INFO - PROCESS | 17855 | 17:19:25 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:26 INFO - PROCESS | 17855 | RSS: Main: 204320768 17:19:26 INFO - PROCESS | 17855 | 17:19:27 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:28 INFO - PROCESS | 17855 | RSS: Main: 206204928 17:19:28 INFO - PROCESS | 17855 | 17:19:30 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:31 INFO - PROCESS | 17855 | RSS: Main: 215965696 17:19:31 INFO - PROCESS | 17855 | 17:19:33 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:34 INFO - PROCESS | 17855 | RSS: Main: 224313344 17:19:34 INFO - PROCESS | 17855 | 17:19:37 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:37 INFO - PROCESS | 17855 | RSS: Main: 221487104 17:19:37 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | Cycle 1(1): loaded http://localhost:57953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57953/tests/kraken/driver.html?testName=ai-astar) 17:19:39 INFO - PROCESS | 17855 | RSS: Main: 285437952 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | __start_tp_report 17:19:39 INFO - PROCESS | 17855 | _x_x_mozilla_page_load 17:19:39 INFO - PROCESS | 17855 | _x_x_mozilla_page_load_details 17:19:39 INFO - PROCESS | 17855 | |i|pagename|runs| 17:19:39 INFO - PROCESS | 17855 | |0;ai-astar;113;111;108;110;111;111;99;112;113;112 17:19:39 INFO - PROCESS | 17855 | |1;audio-beat-detection;156;128;155;188;130;159;156;130;186;131 17:19:39 INFO - PROCESS | 17855 | |2;audio-dft;161;161;161;160;161;160;162;162;162;161 17:19:39 INFO - PROCESS | 17855 | |3;audio-fft;77;73;107;115;74;77;76;119;102;77 17:19:39 INFO - PROCESS | 17855 | |4;audio-oscillator;92;94;157;93;92;93;149;94;94;153 17:19:39 INFO - PROCESS | 17855 | |5;imaging-gaussian-blur;117;116;116;118;117;116;117;117;116;116 17:19:39 INFO - PROCESS | 17855 | |6;imaging-darkroom;145;145;145;146;145;146;145;144;146;145 17:19:39 INFO - PROCESS | 17855 | |7;imaging-desaturate;95;95;95;94;95;95;94;96;95;95 17:19:39 INFO - PROCESS | 17855 | |8;json-parse-financial;57;57;59;57;56;60;58;76;56;53 17:19:39 INFO - PROCESS | 17855 | |9;json-stringify-tinderbox;62;62;62;62;62;63;62;63;62;61 17:19:39 INFO - PROCESS | 17855 | |10;stanford-crypto-aes;76;75;75;83;76;77;77;77;76;76 17:19:39 INFO - PROCESS | 17855 | |11;stanford-crypto-ccm;131;131;124;122;120;120;123;139;162;122 17:19:39 INFO - PROCESS | 17855 | |12;stanford-crypto-pbkdf2;168;174;163;161;164;168;168;161;163;167 17:19:39 INFO - PROCESS | 17855 | |13;stanford-crypto-sha256-iterative;69;68;68;69;69;67;67;67;68;67 17:19:39 INFO - PROCESS | 17855 | __end_tp_report 17:19:39 INFO - PROCESS | 17855 | __start_cc_report 17:19:39 INFO - PROCESS | 17855 | _x_x_mozilla_cycle_collect,1655 17:19:39 INFO - PROCESS | 17855 | __end_cc_report 17:19:39 INFO - PROCESS | 17855 | __startTimestamp1461629979656__endTimestamp 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | ------- Summary: start ------- 17:19:39 INFO - PROCESS | 17855 | Number of tests: 14 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.14 (3.7%) stddev-sans-first:4.24 17:19:39 INFO - PROCESS | 17855 | Values: 113.0 111.0 108.0 110.0 111.0 111.0 99.0 112.0 113.0 112.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:22.43 (14.4%) stddev-sans-first:23.74 17:19:39 INFO - PROCESS | 17855 | Values: 156.0 128.0 155.0 188.0 130.0 159.0 156.0 130.0 186.0 131.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 17:19:39 INFO - PROCESS | 17855 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 162.0 162.0 162.0 161.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.00 stddev:18.70 (24.9%) stddev-sans-first:19.26 17:19:39 INFO - PROCESS | 17855 | Values: 77.0 73.0 107.0 115.0 74.0 77.0 76.0 119.0 102.0 77.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:93.00 stddev:28.98 (31.2%) stddev-sans-first:29.91 17:19:39 INFO - PROCESS | 17855 | Values: 92.0 94.0 157.0 93.0 92.0 93.0 149.0 94.0 94.0 153.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:19:39 INFO - PROCESS | 17855 | Values: 117.0 116.0 116.0 118.0 117.0 116.0 117.0 117.0 116.0 116.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:19:39 INFO - PROCESS | 17855 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 144.0 146.0 145.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:19:39 INFO - PROCESS | 17855 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 96.0 95.0 95.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.50 stddev:6.30 (11.0%) stddev-sans-first:6.64 17:19:39 INFO - PROCESS | 17855 | Values: 57.0 57.0 59.0 57.0 56.0 60.0 58.0 76.0 56.0 53.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:19:39 INFO - PROCESS | 17855 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 61.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:2.30 (3.0%) stddev-sans-first:2.42 17:19:39 INFO - PROCESS | 17855 | Values: 76.0 75.0 75.0 83.0 76.0 77.0 77.0 77.0 76.0 76.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:127.50 stddev:12.98 (10.2%) stddev-sans-first:13.75 17:19:39 INFO - PROCESS | 17855 | Values: 131.0 131.0 124.0 122.0 120.0 120.0 123.0 139.0 162.0 122.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:167.50 stddev:4.06 (2.4%) stddev-sans-first:4.22 17:19:39 INFO - PROCESS | 17855 | Values: 168.0 174.0 163.0 161.0 164.0 168.0 168.0 161.0 163.0 167.0 17:19:39 INFO - PROCESS | 17855 | 17:19:39 INFO - PROCESS | 17855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 17:19:39 INFO - PROCESS | 17855 | Values: 69.0 68.0 68.0 69.0 69.0 67.0 67.0 67.0 68.0 67.0 17:19:39 INFO - PROCESS | 17855 | -------- Summary: end -------- 17:19:39 INFO - PROCESS | 17855 | 17:19:40 INFO - TEST-INFO | 17855: exit 0 17:19:40 INFO - TEST-OK | kraken | took 61164ms 17:19:40 INFO - SUITE-END | took 1173s 17:19:40 INFO - Completed test suite (00:19:34) 17:19:40 INFO - javascript benchmark 17:19:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.475129228031, 3108.2850944282827, 3148.3073723780776, 3148.4175427545892, 3182.2044488877773, 5133.512316329952, 5220.556252718524, 5251.553617942474, 5266.683998960065, 5298.0728372534795, 5153.1754919212935, 5243.239730239113, 5245.4754524547625, 5265.65773224741, 5304.893902121965, 4744.667873248874, 4745.928811067828, 4757.1437141314545, 4770.856874293777, 4883.487233840449, 4811.0, 4860.05228980349, 4878.34142390778, 4885.218365061591, 4894.975525122387, 4635.096156249533, 4704.129735998834, 4754.786034628415, 4767.094252092092, 4838.080764654722, 4816.349792778, 4827.879303017417, 4830.975845120752, 4843.636727245471, 4884.755762211911, 4803.903921921542, 4811.566958973674, 4813.831515896927, 4823.541763532458, 4823.831165909176, 5105.2086926526445, 5117.130087885069, 5184.637075404723, 5224.216367544861, 5231.424543300234, 5474.671519708831, 5488.396276409631, 5492.286002819648, 5497.752601132958, 5502.119660854244, 5526.806561770359, 5550.056490396642, 5555.722213889289, 5558.194061861048, 5577.191307260465, 5269.972355390701, 5288.021715982594, 5303.840884773463, 5349.679019258818, 5354.143337066051, 5637.605367624227, 5641.041023026095, 5643.379228284885, 5644.096944488862, 5645.181448689917, 5439.211314359475, 5444.50999410055, 5447.618666693294, 5448.291722076105, 5451.04606693827, 5619.831405057855, 5641.2384328116, 5645.830625081254, 5676.205331253628, 5700.116481945305, 5592.217089607459, 5599.60802743804, 5607.355154157242, 5607.80372686954, 5609.49514543693, 5459.645123066988, 5553.139263414178, 5614.1859430382365, 5615.634983726045, 5617.747201375948, 4260.339647354665, 4261.446012018418, 4273.850415235452, 4298.849540266138, 4303.634191093792, 3822.445745366906, 3833.923321533554, 3845.0964023454467, 3880.3015457217407, 3880.476135721698, 5209.088409528317, 5240.816571419982, 5269.815556455583, 5289.841304760864, 5290.867728306746, 5592.3009623797025, 5610.467005634539, 5611.2144299798065, 5622.409646987089, 5634.6337488063145, 5245.10833158364, 5254.553362964114, 5258.368995720538, 5258.947410525846, 5308.283381743415, 4771.976140119346, 4792.017636384533, 4801.95198048022, 4805.27920811874, 4848.951510484921, 5785.768569257267, 5790.131480277908, 5795.159701843209, 5801.274840644919, 5837.88324233513, 5627.915581266284, 5639.266895303748, 5643.661380317194, 5643.943560564342, 5646.887062258814, 5703.857403564778, 5734.0, 5774.913376299275, 5798.043322851682, 5892.705364731832, 5575.609707320448, 5600.047991841316, 5604.495595396434, 5608.355039170385, 5626.831195064155, 5614.69119198448, 5659.462351076806, 5674.602777805514, 5682.0, 5685.857853553694, 5396.487333703292, 5425.941941321405, 5472.972635136799, 5500.642458240201, 5502.119660854244, 5473.31583552056, 5485.75314110858, 5486.917696234639, 5496.697681627389, 5496.780128794803, 5391.29913111293, 5402.783888644411, 5409.323834520685, 5416.350037995466, 5426.294581704353, 5354.0, 5468.507834294933, 5476.342838859362, 5552.250446189712, 5571.944280557304, 5370.489803468664, 5370.704611246419, 5373.919391209213, 5374.704391258519, 5411.567074633941], "value": 5172.044063477167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9220101386819, 625.749700119952, 638.4828289085841, 645.1838424393146, 646.2309851276977, 30082.398352032946, 30646.241838234553, 30720.0, 38237.617623823826, 39493.210135797264, 40965.7951710241, 41494.58505414945, 41516.0, 41772.791136044354, 41799.79100104495, 8480.32157427406, 8697.434666746673, 8698.652053917836, 8698.956505217497, 8702.260307873838, 8403.579821008956, 8506.404551681384, 8531.0, 8538.829223415529, 8541.530215838126, 8773.42972706772, 8810.207081362676, 8812.38313318068, 8832.0, 8837.646494140226, 8725.520096394695, 8745.737627871174, 8764.079771623952, 8765.693200737975, 8768.605412756377, 8643.35174861888, 8777.868331975025, 8782.516961567111, 8797.164269394398, 8799.736007919773, 41575.1684966302, 42096.0, 42193.36709949353, 42240.0, 42245.0, 3345.6152542457444, 3468.809215493147, 3521.5245941798044, 3542.4863394807867, 3551.254236610315, 31340.529892051636, 31665.8416707915, 31967.0, 32180.517292240635, 32361.51457728136, 3990.700697447674, 4026.697997650188, 4030.9395359069636, 4055.959440405617, 4109.91780164398, 311655.0, 311847.0, 313991.0, 314583.0, 315565.0, 46240.0, 49851.0, 58565.0, 59544.70227648921, 59609.403905961255, 53581.73209133929, 53612.46387536153, 53918.0, 53918.73040634772, 54011.729941350044, 15776.211189440482, 16047.197640117947, 16059.197040147947, 16060.75908861368, 16120.838791612168, 10845.078168355778, 11759.706007349885, 11993.64019079429, 12104.15270931044, 12106.697332566757, 17566.91216543909, 17594.560135996704, 17733.0, 17801.821981780016, 17820.55448613795, 5797.768089276382, 6039.909401358983, 6111.236095488064, 6170.136180934673, 6196.428482179935, 1059.6026490066224, 1061.5276202089997, 1070.8768491623407, 1075.2365820267698, 1089.4716062709579, 32762.508562371582, 32836.507452388236, 32935.0, 33146.83426582852, 33578.16054598606, 1085.9249343150382, 1112.5772206561455, 1120.3166068698088, 1133.982990255147, 1196.9825648199135, 17052.2326495308, 17460.0, 17599.296028158988, 17651.55871103233, 17719.468415947544, 482263.0, 488018.0, 489241.0, 489651.0, 489920.0, 57654.4234557649, 58108.41891581115, 58216.0, 58227.41772582305, 58273.0, 1281.6923938254938, 1370.3833275026277, 1388.8958328125432, 1393.7351903138372, 1512.553796629997, 27966.440671186054, 29271.0, 29370.55944160882, 30547.694523054484, 32019.839900800347, 46339.30491042569, 46461.53538464572, 46819.0, 46839.06321873475, 46964.0, 281286.8713128671, 282642.0, 282765.0, 283272.0, 283359.0, 32542.34915301728, 38866.222675546895, 39764.620007298545, 40130.0, 40502.392464113655, 43424.34863476987, 44663.33005004862, 44669.0, 45362.546374535836, 45657.31514027359, 39704.80147599243, 41174.0, 42151.36772948347, 42443.5755642452, 42782.358264625436, 40769.0, 40863.387049194884, 41204.38193427041, 41291.7935410321, 42301.0, 42554.0, 43074.0, 43180.0, 44126.779366102965, 44253.77873110614, 35690.0, 36292.45561316635, 36732.632673672924, 37021.44467833039, 37278.6272137286, 27566.0, 28052.43895122127, 28690.0, 28945.56581651235, 29012.27469313284], "value": 19393.473462294845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.9066624010238, 389.143883456396, 389.5092183848351, 402.0872619154519, 402.4848194311281, 13914.165150091001, 16408.425705100322, 19126.52183695408, 19528.609427811454, 19630.803691963076, 14010.0, 17431.82568174318, 17585.296588136458, 17800.64398712025, 17815.91092044541, 5487.368952570456, 5514.724263786815, 5571.721413929307, 5608.663480191181, 5622.91565626516, 4025.1144748155357, 5442.265294185274, 5607.439256074401, 5632.436756324376, 5918.58569900105, 6114.571979961404, 6132.356102609228, 6138.907916381258, 6148.169997050408, 6160.445559899608, 6032.607880487754, 6097.634141951475, 6132.325444201112, 6294.024426213944, 6294.905576416311, 5500.532454741312, 5500.80747173851, 5511.559075273968, 5523.4200408956885, 5540.141278101901, 21377.67933480999, 21871.67192492114, 22083.227087051877, 22540.09839606414, 22554.88722556377, 2321.129576408847, 2345.835791494596, 2375.655529948165, 2387.2599494156693, 2388.140269502995, 9407.858882116774, 9642.75893102671, 9981.051800079054, 13366.33168341579, 14479.058861174095, 1913.167772019176, 1969.202472998438, 1971.9112639931238, 1988.135161204866, 2021.9696704549444, 51137.744311278206, 83952.58023709903, 85497.99999999937, 85819.0, 87533.56233218857, 10133.442660653587, 10279.074883260393, 10284.125849302893, 10397.220208484394, 10886.67339979802, 13976.580702578938, 14018.719625607431, 14035.649108772159, 14037.649058773408, 14077.859221407654, 6953.582785032914, 7283.817904552428, 7780.922190778133, 8154.8776768348525, 8274.338052955749, 7171.89242161368, 7232.493725439169, 7410.11078670563, 7599.050118735158, 7637.732679356196, 4545.204589196944, 4640.86077417678, 4653.813847446132, 4706.1999460091865, 4708.293755936637, 1800.2349001674236, 1916.5400303926958, 1934.429343343717, 1956.6673665476903, 1963.59746252018, 889.8798662180523, 1003.3127307794184, 1019.4902548725637, 1059.655611926127, 1066.2962444786403, 17971.910140449214, 18593.814061859477, 18595.721064184047, 18656.160472778487, 18710.25158993652, 997.3766396002499, 1003.2626019875386, 1039.1167507618463, 1044.5769463367349, 1104.2270410712533, 10051.346662466916, 10314.27800054004, 10551.577936882439, 10589.57641694339, 10606.469676516142, 487230.0, 496618.0, 506416.0, 511850.0, 525498.0, 93522.53238733899, 93663.53168234116, 93709.0, 94802.52598736962, 94867.0, 1013.2906965124442, 1018.1956254558963, 1044.2846650044744, 1046.9319494233002, 1047.7799662070897, 16021.8397816025, 16068.437604684248, 16187.595310117342, 16219.594510137342, 16356.427525036566, 37487.43768843415, 37743.0, 37743.62256377401, 37977.81011094927, 38585.421218682306, 50018.74990625024, 50926.74536627293, 54042.729786350814, 55767.442325577846, 56002.43997559972, 8172.5913704315735, 8339.041010283652, 8469.0, 8585.484870907765, 8586.098459661895, 11545.826812597987, 13052.738945221232, 13102.410391532594, 13180.143290686075, 13523.797143042666, 11462.312261264351, 11772.646820595395, 11805.114616403976, 11822.82265765997, 11925.105617078927, 11265.605703800655, 11584.247023943417, 11624.535018599161, 11699.707507312385, 11963.521459141537, 6538.803835884931, 10409.739756506147, 10922.58006459187, 11648.0, 12230.633081007229, 8631.87052194205, 8747.30021598258, 8761.605727742395, 8824.911750882666, 8853.114688531095, 8825.602847871733, 11139.944300278446, 11491.065927295027, 11497.712557186138, 11562.595309164139], "value": 9015.389512215072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.6270412932315, 1438.6762978329873, 1464.7656374980002, 1603.703314886746, 1764.0033381139663, 7607.733729319475, 7810.726624568141, 7812.492188007775, 7824.882626760596, 7914.881276780853, 7695.422843286748, 7858.253465920729, 7860.331871790904, 7873.173316801739, 7883.8423231535335, 1949.1813438355925, 2005.1778770704013, 2008.538036251663, 2134.4877229464896, 2163.350994701591, 2192.243675931801, 2265.9320220393415, 2272.3978145791298, 2273.3407311879537, 2276.7723227677184, 2169.837262205333, 2189.540196558725, 2203.592335417945, 2203.603351396748, 2215.3353993801793, 1935.8257756801816, 2114.7990940860595, 2178.6187417201927, 2178.716766820311, 2182.5853087913324, 2205.790449907256, 2231.364061242538, 2236.0608544411384, 2238.4292005538646, 2240.697505836724, 7628.122765881939, 7685.692572297102, 7690.077190737092, 7692.4615276930635, 7699.807504812368, 4342.109867477159, 4507.887302817423, 4510.797014134339, 4532.864014079583, 4533.229351010304, 2844.975808708863, 3062.3262882165886, 3105.4410206162884, 3118.7193152616373, 3130.4834702274097, 963.3689933093834, 979.4710856137677, 991.5438898106879, 1025.487256371814, 1026.1636766035658, 11271.887281127249, 11278.097752179807, 11280.605178818701, 11317.943410282896, 11326.830097548544, 4144.48193975753, 4182.1844740275355, 4268.423762792046, 4288.163808057461, 4290.678199135077, 9521.571529281198, 9535.713928582154, 9556.092171243721, 9560.856587151198, 9565.378250413702, 4854.417469903564, 4858.878528036827, 4860.73265970368, 4866.805327786919, 4869.318295438641, 3945.723799334019, 4186.81159347824, 4301.763403012802, 4381.38660587518, 4487.0, 3648.4709717090873, 3713.9257214856093, 3779.074126838942, 3802.9809850951124, 3805.448210009533, 1168.6435637130758, 1183.3846399872018, 1203.3381640097912, 1208.5769980506927, 1223.700193452592, 958.8993155718689, 970.0590427285522, 975.9170470509944, 977.3451787302524, 993.2153598657125, 5492.91760623583, 5593.244911936837, 5667.234923285304, 5673.631213971079, 5717.514011309002, 362.64460828388326, 398.8125580976936, 400.20958606752015, 401.67865707433936, 402.28594245214975, 3959.604039596017, 3978.2640211560374, 4144.8134833932545, 4177.394277829759, 4193.916121677549, 9560.856587151198, 9800.31397802147, 9889.752756181153, 9925.15636170919, 9928.950355248178, 9631.325807193569, 9679.128878400978, 9801.705948821404, 9822.508874556244, 9857.11285984265, 7331.706731730777, 7340.706371745177, 7392.223816499298, 7468.3942952265525, 7514.47398682087, 5668.433156684464, 5723.942760572341, 5796.62321949072, 5805.593608447368, 5857.264146231697, 8643.265322447662, 8736.825263494822, 8803.515806630698, 8842.381033327863, 9131.634734610541, 8469.195426434479, 8809.779755506164, 8854.734357969272, 8887.688930887389, 8894.155055269997, 6474.5791523550815, 6878.209005964178, 7018.789436316919, 7065.434765218667, 7100.538464999759, 7516.24837516244, 7524.924750752422, 7545.547267163988, 7608.16310205888, 7613.809654758676, 6860.211075726355, 7091.255418181223, 7136.215016348094, 7179.533330333512, 7250.274972502708, 6984.580925144304, 6999.4050505705545, 7018.157821061505, 7073.221945586084, 7144.24985376528, 6397.744090236339, 6546.934530654823, 6587.242467116343, 6619.404253617197, 6621.5364924454825, 4965.4786247444945, 5016.573591244785, 5044.47033061538, 5052.570531504716, 5057.31726216956, 4949.876253093557, 4963.0, 4969.279454479008, 4969.627277954096, 4989.675671081368], "value": 4184.177082638942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.6315431984697, 327.21958129860275, 330.84781000739656, 332.6407479921683, 334.99497507537376, 5124.873826965552, 5168.948310516894, 5197.610179236558, 5198.0, 5205.115130427826, 5159.148740457829, 5162.535371816536, 5172.327597412331, 5178.870528236796, 5211.348581427322, 3887.300285948528, 3972.165845172517, 4086.2440448516973, 4098.262312783712, 4099.733517321364, 4049.6557792587664, 4071.3689378146287, 4076.408920706496, 4084.8978775530554, 4090.9590904090874, 3876.8836934891856, 4048.7368321059184, 4060.330045542482, 4061.6344528992386, 4080.9387859182134, 3975.7614543127506, 4057.97971010146, 4069.450624165759, 4073.8370465181356, 4076.7961601920083, 3604.2070744436182, 3635.2547727715755, 3639.3085313790293, 3652.196516766307, 3653.4702468142236, 5016.54851063406, 5021.824236151754, 5024.949750502485, 5036.974815125901, 5048.747562621854, 4552.567506086916, 4680.555347242007, 4685.88285292867, 4690.835820746292, 4717.080169366975, 5367.946320536784, 5390.811321603765, 5392.352917649868, 5408.4050754416985, 5440.265564148868, 4007.438958545806, 4010.0977280112033, 4021.617946295097, 4038.2125485530332, 4038.414429907676, 5548.77804887804, 5655.660660360391, 5672.624788250984, 5675.262215911905, 5685.317761868602, 4071.3689378146437, 4083.2037752638544, 4097.85657501986, 4098.836046558164, 4098.979505102456, 4139.068709540329, 4154.605312495308, 4157.792110394468, 4158.771267580251, 4172.874813755531, 4580.129775342674, 4603.102395032936, 4632.652551058684, 4658.880209504668, 4726.787294571753, 5450.836474905759, 5456.91814622781, 5483.561315094783, 5494.977762230757, 5505.394406615269, 1502.9248537573078, 1521.7945577346916, 1522.619345163709, 1522.710684969852, 1524.2378810594703, 976.6386437018207, 984.4634674102631, 1037.678319720889, 1051.264115119404, 1055.6991257491577, 5519.199716041152, 5529.640573362719, 5540.972295138498, 5581.0, 5582.441755824385, 5850.3272123705465, 5863.794767183128, 5880.294364676266, 5906.438888305604, 5927.110933359944, 5387.919181212285, 5490.505854473116, 5521.69630670317, 5531.612787104864, 5554.527865131428, 3127.7341425978593, 3132.6084239470065, 3149.2441813964483, 3150.212446888278, 3160.3995240904155, 5971.462568368867, 6030.497343602444, 6076.574639775174, 6077.544184186204, 6101.420365065312, 5956.821295361146, 5962.910556341659, 5996.4003599640555, 5996.970015149896, 6006.279246490361, 6004.849878752979, 6028.739222791541, 6045.153678485103, 6061.151438798572, 6077.997130473423, 5411.675299482044, 5712.25740653729, 5712.8571785704025, 5736.282964629421, 5837.6497410155525, 5599.944000559943, 5629.943700563106, 5633.971830140823, 5651.378348381757, 5656.915146272891, 5678.0, 5827.766889324549, 5837.708114594338, 5846.889091072682, 5850.882982340415, 3944.1322908959983, 3952.4268980998168, 3991.980040099781, 3993.940090898697, 3999.8000099995465, 5640.802571909963, 5681.147827825694, 5693.686847223443, 5697.4587414195585, 5712.228849105318, 5225.3990791057995, 5353.036453438419, 5463.918041229305, 5477.1510415885605, 5513.173024046425, 5392.325959255093, 5400.459954004568, 5459.344878614592, 5466.91799623014, 5511.751971161227, 5179.896402071862, 5363.329583802025, 5364.114921038141, 5378.462153784591, 5389.407165211745, 5427.0, 5474.671519708831, 5476.726163691879, 5484.561235101262, 5497.47773961473, 5325.786968521371, 5347.759350829144, 5401.594880383908, 5426.864328391822, 5432.483914028161], "value": 4244.91219630027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.953593016454, 735.0664655887024, 735.3639102176619, 801.5150833745583, 811.3509192645881, 12228.0, 12382.0, 12383.257004579731, 12405.813912791304, 12668.176568523051, 11826.940865295683, 12270.202436841599, 12275.202111862724, 12283.754324913518, 12301.3234272115, 662.9535932484728, 776.9339606133485, 793.3811626930989, 805.432170319926, 808.9231523005305, 801.4069588504523, 805.5046146619816, 805.875089361147, 808.8624933761246, 809.7732634862218, 848.0459483081534, 848.3043903998723, 850.196564246787, 850.3494826457734, 850.7320194138827, 690.8721886451023, 813.6582635293191, 833.4624167412046, 835.5070508400073, 835.6740871060291, 613.3804857094323, 613.5214532664529, 614.0758158970765, 614.2935624032353, 614.3487902823022, 12436.875631243662, 12467.625971220878, 12499.625011249676, 12518.06114541413, 12522.248665080124, 11628.302301861831, 11951.581694640732, 12322.445489952885, 12494.500219991189, 12669.166964321092, 9717.0, 9778.168855647278, 10127.746806329827, 10153.187744980383, 10231.0, 3778.452124441968, 3786.8863934082024, 3833.7124715646437, 3867.1878905429894, 3935.527736671589, 56111.43888561103, 56232.0, 56256.43743562553, 56598.434015659725, 57152.428475715125, 9232.0, 9448.050655091372, 9455.385399948982, 9586.281028922858, 9687.66093186735, 16415.83584164143, 16502.092384918706, 16531.83468165303, 16539.338426463048, 16563.08903010322, 7225.963870180721, 7440.665170067252, 7445.367143792838, 7515.736949206861, 7652.502587331805, 4002.599740026032, 4041.6943181761762, 4051.0, 4065.5324637666454, 4090.775007374623, 2985.2984548631052, 3050.42042012017, 3055.144559523337, 3062.8774849006236, 3063.7702172336717, 545.9317585301837, 564.6499170514307, 588.8998870192078, 592.165047283337, 623.1182876230174, 680.8774420604339, 732.9743458979017, 754.705664790732, 761.1133030020076, 774.1097737601802, 8812.51531165792, 8991.235744961621, 9013.369064165576, 9106.071046928544, 9228.215601673799, 645.5061877663591, 706.5760543673857, 731.5756861020595, 739.9123288765506, 756.1380026769488, 4234.491860976703, 4311.547287534827, 4408.382826404306, 4451.421315228999, 4496.123255965055, 57038.714806425705, 57961.0, 58351.41648583545, 58674.0, 58696.0, 54883.0, 54914.450855491734, 56128.43871561314, 58820.7058964711, 60066.39933600696, 50094.0, 50155.74922125366, 52754.73622631862, 55198.0, 55286.72356638191, 8867.423617464845, 8955.552222388986, 8959.372843900865, 9077.90922090797, 9090.954545227232, 32181.03456896297, 32715.0, 33132.0, 34062.148446289044, 34806.65193348034, 42825.14349712926, 47062.52937470582, 47227.52772472231, 47855.28217076677, 48450.5154948446, 11249.718757030812, 11467.713307167054, 11605.825912611148, 11621.88378116208, 11628.0, 12006.699832504257, 12214.450349734461, 12306.569270075504, 12619.432125554189, 13026.934865325613, 11636.650900473, 11653.825192621947, 11752.823707644222, 11913.821292680443, 11990.700232493908, 11147.777044459228, 11461.0, 11591.6522504325, 11594.76810463803, 11758.882411175779, 11362.938759344719, 11414.313280982515, 11624.88375116238, 11670.276595215113, 11720.765584688088, 9934.354266972623, 10037.498125093862, 10109.14072303833, 10352.482375881327, 10367.118794902517, 9832.803343933225, 10311.381317120997, 10409.167266618804, 10412.583496660049, 10429.374237545468], "value": 6391.722917419903, "unit": "score"}], "name": "dromaeo_css", "value": 6842.91479640228, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 108.0, 110.0, 111.0, 111.0, 99.0, 112.0, 113.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 155.0, 188.0, 130.0, 159.0, 156.0, 130.0, 186.0, 131.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 107.0, 115.0, 74.0, 77.0, 76.0, 119.0, 102.0, 77.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 157.0, 93.0, 92.0, 93.0, 149.0, 94.0, 94.0, 153.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 57.0, 56.0, 60.0, 58.0, 76.0, 56.0, 53.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 83.0, 76.0, 77.0, 77.0, 77.0, 76.0, 76.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 124.0, 122.0, 120.0, 120.0, 123.0, 139.0, 162.0, 122.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 174.0, 163.0, 161.0, 164.0, 168.0, 168.0, 161.0, 163.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1541.3000000000002, "alertThreshold": 2.0}]} 17:19:40 INFO - Return code: 0 17:19:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:40 ERROR - # TBPL SUCCESS # 17:19:40 INFO - Running post-action listener: _resource_record_post_action 17:19:40 INFO - Running post-run listener: _resource_record_post_run 17:19:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 533934080; Read time: 0; Write time: 469448 17:19:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244572160; Read time: 0; Write time: 291036 17:19:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289361920; Read time: 0; Write time: 178412 17:19:42 INFO - Running post-run listener: _upload_blobber_files 17:19:42 INFO - Blob upload gear active. 17:19:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:19:42 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 17:19:42 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'] 17:19:42 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 17:19:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:44 INFO - (blobuploader) - INFO - Done attempting. 17:19:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:19:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:44 INFO - (blobuploader) - INFO - Done attempting. 17:19:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:44 INFO - Return code: 0 17:19:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:19:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57a06cfc99574a55704eea89dab3f89e29a4fda6c20dc568d74a3078beaa83005e55381bc2e292341d3d2e26cdad0ee5c0663f6781bcdc800d19e6a8be0eec03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a833f1616837e99dd18f4aaa8e2d644fab29cb904043a1eb359e5a8de767ffac6e38c253e0fb15f6896d361eea017784064427eda2a2a61961ce721e89acd37"} 17:19:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:19:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:19:44 INFO - Contents: 17:19:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57a06cfc99574a55704eea89dab3f89e29a4fda6c20dc568d74a3078beaa83005e55381bc2e292341d3d2e26cdad0ee5c0663f6781bcdc800d19e6a8be0eec03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a833f1616837e99dd18f4aaa8e2d644fab29cb904043a1eb359e5a8de767ffac6e38c253e0fb15f6896d361eea017784064427eda2a2a61961ce721e89acd37"} 17:19:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:19:44 INFO - Copying logs to upload dir... 17:19:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:19:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.462637 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-25 17:19:43.544777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:19:43.548165) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 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/57a06cfc99574a55704eea89dab3f89e29a4fda6c20dc568d74a3078beaa83005e55381bc2e292341d3d2e26cdad0ee5c0663f6781bcdc800d19e6a8be0eec03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a833f1616837e99dd18f4aaa8e2d644fab29cb904043a1eb359e5a8de767ffac6e38c253e0fb15f6896d361eea017784064427eda2a2a61961ce721e89acd37"} build_url:https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011556 build_url: 'https://queue.taskcluster.net/v1/task/VZhVK6KxQIWwoR8QU8pQMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57a06cfc99574a55704eea89dab3f89e29a4fda6c20dc568d74a3078beaa83005e55381bc2e292341d3d2e26cdad0ee5c0663f6781bcdc800d19e6a8be0eec03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a833f1616837e99dd18f4aaa8e2d644fab29cb904043a1eb359e5a8de767ffac6e38c253e0fb15f6896d361eea017784064427eda2a2a61961ce721e89acd37"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:19:43.572801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:19:43.573125) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461621022.128778-1520688967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:19:43.657571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:19:43.657946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:19:43.658237) ========= ========= Total master_lag: 0.16 =========