builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1469112964.71 results: success (0) buildid: 20160721051621 builduid: bf131c21c7b14185b0b77d876625dce3 revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.705929) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.706620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.706916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.725590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.726007) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 07:56:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.1M=0s 2016-07-21 07:56:04 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089501 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.830144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.830492) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016188 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.880503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:04.880876) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 07:56:04,990 truncating revision to first 12 chars 2016-07-21 07:56:04,991 Setting DEBUG logging. 2016-07-21 07:56:04,991 attempt 1/10 2016-07-21 07:56:04,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/512d3ff7151c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 07:56:05,286 unpacking tar archive at: mozilla-beta-512d3ff7151c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717003 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:05.612091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:05.612468) ========= script_repo_revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:05.612890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:05.613171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:56:05.624602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-21 07:56:05.625023) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:05 INFO - MultiFileLogger online at 20160721 07:56:05 in /builds/slave/test 07:56:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:56:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:05 INFO - {'append_to_log': False, 07:56:05 INFO - 'base_work_dir': '/builds/slave/test', 07:56:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:56:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:05 INFO - 'branch': 'Mozilla-Beta', 07:56:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:05 INFO - 'config_files': ('talos/linux_config.py',), 07:56:05 INFO - 'default_actions': ('clobber', 07:56:05 INFO - 'read-buildbot-config', 07:56:05 INFO - 'download-and-extract', 07:56:05 INFO - 'populate-webroot', 07:56:05 INFO - 'create-virtualenv', 07:56:05 INFO - 'install', 07:56:05 INFO - 'run-tests'), 07:56:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:05 INFO - 'download_minidump_stackwalk': True, 07:56:05 INFO - 'download_symbols': 'ondemand', 07:56:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:05 INFO - 'installer_path': 'installer.exe', 07:56:05 INFO - 'log_level': 'info', 07:56:05 INFO - 'log_name': 'talos', 07:56:05 INFO - 'log_to_console': True, 07:56:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:05 INFO - 'opt_config_files': (), 07:56:05 INFO - 'pip_index': False, 07:56:05 INFO - 'sps_profile': False, 07:56:05 INFO - 'sps_profile_interval': 0, 07:56:05 INFO - 'suite': 'dromaeojs', 07:56:05 INFO - 'system_bits': '32', 07:56:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:05 INFO - 'title': 'talos-linux64-ix-015', 07:56:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:05 INFO - 'use_talos_json': True, 07:56:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:05 INFO - 'work_dir': 'build'} 07:56:05 INFO - ##### 07:56:05 INFO - ##### Running clobber step. 07:56:05 INFO - ##### 07:56:05 INFO - Running pre-action listener: _resource_record_pre_action 07:56:05 INFO - Running main action method: clobber 07:56:05 INFO - rmtree: /builds/slave/test/build 07:56:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:06 INFO - Running post-action listener: _resource_record_post_action 07:56:06 INFO - ##### 07:56:06 INFO - ##### Running read-buildbot-config step. 07:56:06 INFO - ##### 07:56:06 INFO - Running pre-action listener: _resource_record_pre_action 07:56:06 INFO - Running main action method: read_buildbot_config 07:56:06 INFO - Using buildbot properties: 07:56:06 INFO - { 07:56:06 INFO - "project": "", 07:56:06 INFO - "product": "firefox", 07:56:06 INFO - "script_repo_revision": "production", 07:56:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:56:06 INFO - "repository": "", 07:56:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:56:06 INFO - "buildid": "20160721051621", 07:56:06 INFO - "pgo_build": "True", 07:56:06 INFO - "basedir": "/builds/slave/test", 07:56:06 INFO - "buildnumber": 309, 07:56:06 INFO - "slavename": "talos-linux64-ix-015", 07:56:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:56:06 INFO - "platform": "ubuntu64_hw", 07:56:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:56:06 INFO - "branch": "mozilla-beta", 07:56:06 INFO - "repo_path": "releases/mozilla-beta", 07:56:06 INFO - "revision": "512d3ff7151c16f30ea8f93414d048c708815110", 07:56:06 INFO - "stage_platform": "linux64-pgo", 07:56:06 INFO - "builduid": "bf131c21c7b14185b0b77d876625dce3", 07:56:06 INFO - "slavebuilddir": "test" 07:56:06 INFO - } 07:56:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 07:56:06 INFO - Running post-action listener: _resource_record_post_action 07:56:06 INFO - ##### 07:56:06 INFO - ##### Running download-and-extract step. 07:56:06 INFO - ##### 07:56:06 INFO - Running pre-action listener: _resource_record_pre_action 07:56:06 INFO - Running main action method: download_and_extract 07:56:06 INFO - mkdir: /builds/slave/test/build/tests 07:56:06 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')]} 07:56:06 INFO - https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:56:11 INFO - Downloaded 1327 bytes. 07:56:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:56:11 INFO - Using the following test package requirements: 07:56:11 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 07:56:11 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:11 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 07:56:11 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'jsshell-linux-x86_64.zip'], 07:56:11 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:11 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 07:56:11 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 07:56:11 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 07:56:11 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:11 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:56:11 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:11 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56: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')]} 07:56:11 INFO - https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:14 INFO - Downloaded 24199589 bytes. 07:56:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:16 INFO - Return code: 0 07:56:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:56:16 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')]} 07:56:16 INFO - https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:56:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:17 INFO - Downloaded 24199589 bytes. 07:56:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:18 INFO - Return code: 0 07:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:18 INFO - https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:56:19 INFO - Downloaded 10840145 bytes. 07:56:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:56:19 INFO - Return code: 0 07:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:19 INFO - https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:56:20 INFO - Downloaded 56023485 bytes. 07:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:56:20 INFO - mkdir: /builds/slave/test/properties 07:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:20 INFO - Contents: 07:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - Running post-action listener: set_extra_try_arguments 07:56:21 INFO - ##### 07:56:21 INFO - ##### Running populate-webroot step. 07:56:21 INFO - ##### 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: populate_webroot 07:56:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:21 INFO - '--tppagecycles', 07:56:21 INFO - '7'], 07:56:21 INFO - 'tests': ['tsvgm']}}, 07:56:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s', 07:56:21 INFO - '--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}, 07:56:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}}, 07:56:21 INFO - 'talos.zip': {'path': '', 07:56:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - ##### 07:56:21 INFO - ##### Running create-virtualenv step. 07:56:21 INFO - ##### 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: create_virtualenv 07:56:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:21 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 07:56:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:21 INFO - Using real prefix '/usr' 07:56:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:24 INFO - Installing pip.................done. 07:56:24 INFO - Return code: 0 07:56:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:24 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 07:56:24 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 07:56:24 INFO - Using env: {'DISPLAY': ':0', 07:56:24 INFO - 'HOME': '/home/cltbld', 07:56:24 INFO - 'LANG': 'en_US.UTF-8', 07:56:24 INFO - 'LANGUAGE': 'en_US:en', 07:56:24 INFO - 'LOGNAME': 'cltbld', 07:56:24 INFO - 'MAIL': '/var/mail/cltbld', 07:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:24 INFO - 'MOZ_NO_REMOTE': '1', 07:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:24 INFO - 'NO_EM_RESTART': '1', 07:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:24 INFO - 'PWD': '/builds/slave/test', 07:56:24 INFO - 'SHELL': '/bin/bash', 07:56:24 INFO - 'SHLVL': '1', 07:56:24 INFO - 'TERM': 'linux', 07:56:24 INFO - 'TMOUT': '86400', 07:56:24 INFO - 'USER': 'cltbld', 07:56:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:24 INFO - '_': '/tools/buildbot/bin/python'} 07:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:24 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 07:56:24 INFO - Cleaning up... 07:56:24 INFO - Return code: 0 07:56:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:24 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 07:56:24 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 07:56:24 INFO - Using env: {'DISPLAY': ':0', 07:56:24 INFO - 'HOME': '/home/cltbld', 07:56:24 INFO - 'LANG': 'en_US.UTF-8', 07:56:24 INFO - 'LANGUAGE': 'en_US:en', 07:56:24 INFO - 'LOGNAME': 'cltbld', 07:56:24 INFO - 'MAIL': '/var/mail/cltbld', 07:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:24 INFO - 'MOZ_NO_REMOTE': '1', 07:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:24 INFO - 'NO_EM_RESTART': '1', 07:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:24 INFO - 'PWD': '/builds/slave/test', 07:56:24 INFO - 'SHELL': '/bin/bash', 07:56:24 INFO - 'SHLVL': '1', 07:56:24 INFO - 'TERM': 'linux', 07:56:24 INFO - 'TMOUT': '86400', 07:56:24 INFO - 'USER': 'cltbld', 07:56:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:24 INFO - '_': '/tools/buildbot/bin/python'} 07:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:24 INFO - Downloading/unpacking psutil>=0.7.1 07:56:24 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 07:56:24 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 07:56:24 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 07:56:24 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 07:56:24 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 07:56:24 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 07:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:26 INFO - Installing collected packages: psutil 07:56:26 INFO - Running setup.py install for psutil 07:56:26 INFO - building 'psutil._psutil_linux' extension 07:56:26 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 07:56:26 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 07:56:26 INFO - building 'psutil._psutil_posix' extension 07:56:26 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 07:56:26 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 07:56:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:27 INFO - Successfully installed psutil 07:56:27 INFO - Cleaning up... 07:56:27 INFO - Return code: 0 07:56:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', '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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:56: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 mozsystemmonitor==0.0.0 07:56:27 INFO - Using env: {'DISPLAY': ':0', 07:56:27 INFO - 'HOME': '/home/cltbld', 07:56:27 INFO - 'LANG': 'en_US.UTF-8', 07:56:27 INFO - 'LANGUAGE': 'en_US:en', 07:56:27 INFO - 'LOGNAME': 'cltbld', 07:56:27 INFO - 'MAIL': '/var/mail/cltbld', 07:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:27 INFO - 'MOZ_NO_REMOTE': '1', 07:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:27 INFO - 'NO_EM_RESTART': '1', 07:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:27 INFO - 'PWD': '/builds/slave/test', 07:56:27 INFO - 'SHELL': '/bin/bash', 07:56:27 INFO - 'SHLVL': '1', 07:56:27 INFO - 'TERM': 'linux', 07:56:27 INFO - 'TMOUT': '86400', 07:56:27 INFO - 'USER': 'cltbld', 07:56:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:27 INFO - '_': '/tools/buildbot/bin/python'} 07:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:56:29 INFO - Installing collected packages: mozsystemmonitor 07:56:29 INFO - Running setup.py install for mozsystemmonitor 07:56:29 INFO - Successfully installed mozsystemmonitor 07:56:29 INFO - Cleaning up... 07:56:29 INFO - Return code: 0 07:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:56:29 INFO - Using env: {'DISPLAY': ':0', 07:56:29 INFO - 'HOME': '/home/cltbld', 07:56:29 INFO - 'LANG': 'en_US.UTF-8', 07:56:29 INFO - 'LANGUAGE': 'en_US:en', 07:56:29 INFO - 'LOGNAME': 'cltbld', 07:56:29 INFO - 'MAIL': '/var/mail/cltbld', 07:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:29 INFO - 'MOZ_NO_REMOTE': '1', 07:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:29 INFO - 'NO_EM_RESTART': '1', 07:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:29 INFO - 'PWD': '/builds/slave/test', 07:56:29 INFO - 'SHELL': '/bin/bash', 07:56:29 INFO - 'SHLVL': '1', 07:56:29 INFO - 'TERM': 'linux', 07:56:29 INFO - 'TMOUT': '86400', 07:56:29 INFO - 'USER': 'cltbld', 07:56:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:29 INFO - '_': '/tools/buildbot/bin/python'} 07:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:31 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 07:56:31 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 07:56:31 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 07:56:31 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 07:56:31 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 07:56:31 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 07:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:56:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:32 INFO - Downloading docopt-0.6.1.tar.gz 07:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:32 INFO - Running setup.py install for blobuploader 07:56:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:56:32 INFO - Running setup.py install for requests 07:56:32 INFO - Running setup.py install for docopt 07:56:32 INFO - Successfully installed blobuploader requests docopt 07:56:32 INFO - Cleaning up... 07:56:32 INFO - Return code: 0 07:56:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:32 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 07:56:32 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 07:56:32 INFO - Using env: {'DISPLAY': ':0', 07:56:32 INFO - 'HOME': '/home/cltbld', 07:56:32 INFO - 'LANG': 'en_US.UTF-8', 07:56:32 INFO - 'LANGUAGE': 'en_US:en', 07:56:32 INFO - 'LOGNAME': 'cltbld', 07:56:32 INFO - 'MAIL': '/var/mail/cltbld', 07:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:32 INFO - 'MOZ_NO_REMOTE': '1', 07:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:32 INFO - 'NO_EM_RESTART': '1', 07:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:32 INFO - 'PWD': '/builds/slave/test', 07:56:32 INFO - 'SHELL': '/bin/bash', 07:56:32 INFO - 'SHLVL': '1', 07:56:32 INFO - 'TERM': 'linux', 07:56:32 INFO - 'TMOUT': '86400', 07:56:32 INFO - 'USER': 'cltbld', 07:56:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:32 INFO - '_': '/tools/buildbot/bin/python'} 07:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:33 INFO - Running setup.py (path:/tmp/pip-EtUmNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:33 INFO - Running setup.py (path:/tmp/pip-KF0ANv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:33 INFO - Running setup.py (path:/tmp/pip-1Dlmjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:33 INFO - Running setup.py (path:/tmp/pip-zBHBgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:33 INFO - Running setup.py (path:/tmp/pip-BjoHmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:33 INFO - Running setup.py (path:/tmp/pip-330l8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:33 INFO - Running setup.py (path:/tmp/pip-D2_3Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:33 INFO - Running setup.py (path:/tmp/pip-UtWcJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:33 INFO - Running setup.py (path:/tmp/pip-d3ojEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:33 INFO - Running setup.py (path:/tmp/pip-59hzkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:33 INFO - Running setup.py (path:/tmp/pip-Zxxskx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:33 INFO - Running setup.py (path:/tmp/pip-iJFPiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:33 INFO - Running setup.py (path:/tmp/pip-1mVLUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:34 INFO - Running setup.py (path:/tmp/pip-eTFEjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:34 INFO - Running setup.py (path:/tmp/pip-fraDbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:34 INFO - Running setup.py (path:/tmp/pip-5LC264-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:34 INFO - Running setup.py (path:/tmp/pip-pk_X4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:34 INFO - Running setup.py install for manifestparser 07:56:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:56:34 INFO - Running setup.py install for mozcrash 07:56:34 INFO - Running setup.py install for mozdebug 07:56:34 INFO - Running setup.py install for mozdevice 07:56:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:56:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:56:34 INFO - Running setup.py install for mozfile 07:56:34 INFO - Running setup.py install for mozhttpd 07:56:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:56:34 INFO - Running setup.py install for mozinfo 07:56:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for mozInstall 07:56:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for mozleak 07:56:35 INFO - Running setup.py install for mozlog 07:56:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for moznetwork 07:56:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for mozprocess 07:56:35 INFO - Running setup.py install for mozprofile 07:56:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for mozrunner 07:56:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:56:35 INFO - Running setup.py install for mozscreenshot 07:56:35 INFO - Running setup.py install for moztest 07:56:35 INFO - Running setup.py install for mozversion 07:56:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:56:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:36 INFO - Cleaning up... 07:56:36 INFO - Return code: 0 07:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:36 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:36 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 07:56:36 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 07:56:36 INFO - Using env: {'DISPLAY': ':0', 07:56:36 INFO - 'HOME': '/home/cltbld', 07:56:36 INFO - 'LANG': 'en_US.UTF-8', 07:56:36 INFO - 'LANGUAGE': 'en_US:en', 07:56:36 INFO - 'LOGNAME': 'cltbld', 07:56:36 INFO - 'MAIL': '/var/mail/cltbld', 07:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:36 INFO - 'MOZ_NO_REMOTE': '1', 07:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:36 INFO - 'NO_EM_RESTART': '1', 07:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:36 INFO - 'PWD': '/builds/slave/test', 07:56:36 INFO - 'SHELL': '/bin/bash', 07:56:36 INFO - 'SHLVL': '1', 07:56:36 INFO - 'TERM': 'linux', 07:56:36 INFO - 'TMOUT': '86400', 07:56:36 INFO - 'USER': 'cltbld', 07:56:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:36 INFO - '_': '/tools/buildbot/bin/python'} 07:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:36 INFO - Running setup.py (path:/tmp/pip-DNeEdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:36 INFO - Running setup.py (path:/tmp/pip-WGCFju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:36 INFO - Running setup.py (path:/tmp/pip-rfOUZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:36 INFO - Running setup.py (path:/tmp/pip-odpEAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:36 INFO - Running setup.py (path:/tmp/pip-B3wpbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:36 INFO - Running setup.py (path:/tmp/pip-sW27Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:36 INFO - Running setup.py (path:/tmp/pip-f9rZZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:36 INFO - Running setup.py (path:/tmp/pip-i6yU1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:36 INFO - Running setup.py (path:/tmp/pip-eyNxaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:36 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)) 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:36 INFO - Running setup.py (path:/tmp/pip-bC_yrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:37 INFO - Running setup.py (path:/tmp/pip-CamJEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:37 INFO - Running setup.py (path:/tmp/pip-CgcxOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:37 INFO - Running setup.py (path:/tmp/pip-YTZN5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:37 INFO - Running setup.py (path:/tmp/pip-nJDq4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:37 INFO - Running setup.py (path:/tmp/pip-veoz2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:37 INFO - Running setup.py (path:/tmp/pip-Uu0VtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:37 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)) 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:37 INFO - Running setup.py (path:/tmp/pip-0q1CsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:37 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)) 07:56:37 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)) 07:56:37 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)) 07:56:37 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)) 07:56:37 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)) 07:56:37 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)) 07:56:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:39 INFO - Downloading blessings-1.6.tar.gz 07:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:39 INFO - Installing collected packages: blessings 07:56:39 INFO - Running setup.py install for blessings 07:56:39 INFO - Successfully installed blessings 07:56:39 INFO - Cleaning up... 07:56:39 INFO - Return code: 0 07:56:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:39 INFO - Reading from file tmpfile_stdout 07:56:39 INFO - Current package versions: 07:56:39 INFO - argparse == 1.2.1 07:56:39 INFO - blessings == 1.6 07:56:39 INFO - blobuploader == 1.2.4 07:56:39 INFO - docopt == 0.6.1 07:56:39 INFO - manifestparser == 1.1 07:56:39 INFO - mozInstall == 1.12 07:56:39 INFO - mozcrash == 0.17 07:56:39 INFO - mozdebug == 0.1 07:56:39 INFO - mozdevice == 0.48 07:56:39 INFO - mozfile == 1.2 07:56:39 INFO - mozhttpd == 0.7 07:56:39 INFO - mozinfo == 0.9 07:56:39 INFO - mozleak == 0.1 07:56:39 INFO - mozlog == 3.1 07:56:39 INFO - moznetwork == 0.27 07:56:39 INFO - mozprocess == 0.22 07:56:39 INFO - mozprofile == 0.28 07:56:39 INFO - mozrunner == 6.11 07:56:39 INFO - mozscreenshot == 0.1 07:56:39 INFO - mozsystemmonitor == 0.0 07:56:39 INFO - moztest == 0.7 07:56:39 INFO - mozversion == 1.4 07:56:39 INFO - psutil == 3.1.1 07:56:39 INFO - requests == 1.2.3 07:56:39 INFO - wsgiref == 0.1.2 07:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:39 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:39 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 07:56:39 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 07:56:39 INFO - Using env: {'DISPLAY': ':0', 07:56:39 INFO - 'HOME': '/home/cltbld', 07:56:39 INFO - 'LANG': 'en_US.UTF-8', 07:56:39 INFO - 'LANGUAGE': 'en_US:en', 07:56:39 INFO - 'LOGNAME': 'cltbld', 07:56:39 INFO - 'MAIL': '/var/mail/cltbld', 07:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:39 INFO - 'MOZ_NO_REMOTE': '1', 07:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:39 INFO - 'NO_EM_RESTART': '1', 07:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:39 INFO - 'PWD': '/builds/slave/test', 07:56:39 INFO - 'SHELL': '/bin/bash', 07:56:39 INFO - 'SHLVL': '1', 07:56:39 INFO - 'TERM': 'linux', 07:56:39 INFO - 'TMOUT': '86400', 07:56:39 INFO - 'USER': 'cltbld', 07:56:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:39 INFO - '_': '/tools/buildbot/bin/python'} 07:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 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)) 07:56:40 INFO - Cleaning up... 07:56:40 INFO - Return code: 0 07:56:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:40 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:40 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 07:56:40 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 07:56:40 INFO - Using env: {'DISPLAY': ':0', 07:56:40 INFO - 'HOME': '/home/cltbld', 07:56:40 INFO - 'LANG': 'en_US.UTF-8', 07:56:40 INFO - 'LANGUAGE': 'en_US:en', 07:56:40 INFO - 'LOGNAME': 'cltbld', 07:56:40 INFO - 'MAIL': '/var/mail/cltbld', 07:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:40 INFO - 'MOZ_NO_REMOTE': '1', 07:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:40 INFO - 'NO_EM_RESTART': '1', 07:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:40 INFO - 'PWD': '/builds/slave/test', 07:56:40 INFO - 'SHELL': '/bin/bash', 07:56:40 INFO - 'SHLVL': '1', 07:56:40 INFO - 'TERM': 'linux', 07:56:40 INFO - 'TMOUT': '86400', 07:56:40 INFO - 'USER': 'cltbld', 07:56:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:40 INFO - '_': '/tools/buildbot/bin/python'} 07:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:40 INFO - Downloading/unpacking jsonschema 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:42 INFO - Downloading/unpacking functools32 (from jsonschema) 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:42 INFO - warning: no files found matching '*.txt' 07:56:42 INFO - no previously-included directories found matching 'build' 07:56:42 INFO - no previously-included directories found matching 'dist' 07:56:42 INFO - no previously-included directories found matching '.git*' 07:56:42 INFO - Installing collected packages: jsonschema, functools32 07:56:42 INFO - Running setup.py install for functools32 07:56:42 INFO - warning: no files found matching '*.txt' 07:56:42 INFO - no previously-included directories found matching 'build' 07:56:42 INFO - no previously-included directories found matching 'dist' 07:56:42 INFO - no previously-included directories found matching '.git*' 07:56:42 INFO - Successfully installed jsonschema functools32 07:56:42 INFO - Cleaning up... 07:56:42 INFO - Return code: 0 07:56:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 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 0x7f39e5c72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', '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 07:56:42 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 07:56:42 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 07:56:42 INFO - Using env: {'DISPLAY': ':0', 07:56:42 INFO - 'HOME': '/home/cltbld', 07:56:42 INFO - 'LANG': 'en_US.UTF-8', 07:56:42 INFO - 'LANGUAGE': 'en_US:en', 07:56:42 INFO - 'LOGNAME': 'cltbld', 07:56:42 INFO - 'MAIL': '/var/mail/cltbld', 07:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:42 INFO - 'MOZ_NO_REMOTE': '1', 07:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:42 INFO - 'NO_EM_RESTART': '1', 07:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:42 INFO - 'PWD': '/builds/slave/test', 07:56:42 INFO - 'SHELL': '/bin/bash', 07:56:42 INFO - 'SHLVL': '1', 07:56:42 INFO - 'TERM': 'linux', 07:56:42 INFO - 'TMOUT': '86400', 07:56:42 INFO - 'USER': 'cltbld', 07:56:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:42 INFO - '_': '/tools/buildbot/bin/python'} 07:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:42 INFO - Downloading/unpacking flake8 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56:44 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 07:56:44 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 07:56:44 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 07:56:44 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 07:56:44 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 07:56:44 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 07:56:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:45 INFO - no previously-included directories found matching 'docs/_build' 07:56:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:45 INFO - Running setup.py install for pep8 07:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:45 INFO - no previously-included directories found matching 'docs/_build' 07:56:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:56:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:45 INFO - Cleaning up... 07:56:45 INFO - Return code: 0 07:56:45 INFO - Running post-action listener: _resource_record_post_action 07:56:45 INFO - Running post-action listener: _start_resource_monitoring 07:56:45 INFO - Starting resource monitoring. 07:56:45 INFO - ##### 07:56:45 INFO - ##### Running install step. 07:56:45 INFO - ##### 07:56:45 INFO - Running pre-action listener: _resource_record_pre_action 07:56:45 INFO - Running main action method: install 07:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:46 INFO - Reading from file tmpfile_stdout 07:56:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:56:46 INFO - Reading from file tmpfile_stdout 07:56:46 INFO - Output received: 07:56:46 INFO - Usage: mozinstall [options] installer 07:56:46 INFO - Options: 07:56:46 INFO - -h, --help show this help message and exit 07:56:46 INFO - -d DEST, --destination=DEST 07:56:46 INFO - Directory to install application into. [default: 07:56:46 INFO - "/builds/slave/test"] 07:56:46 INFO - --app=APP Application being installed. [default: firefox] 07:56:46 INFO - mkdir: /builds/slave/test/build/application 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:56:59 INFO - Reading from file tmpfile_stdout 07:56:59 INFO - Output received: 07:56:59 INFO - /builds/slave/test/build/application/firefox/firefox 07:56:59 INFO - Running post-action listener: _resource_record_post_action 07:56:59 INFO - ##### 07:56:59 INFO - ##### Running run-tests step. 07:56:59 INFO - ##### 07:56:59 INFO - Running pre-action listener: _resource_record_pre_action 07:56:59 INFO - Running main action method: run_tests 07:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:56:59 INFO - Python 2.7.3 07:56:59 INFO - Return code: 0 07:56:59 INFO - grabbing minidump binary from tooltool 07:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:59 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 0xf6e410>, '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 0xf6f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:56:59 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 07:56:59 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 07:56:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:59 INFO - Return code: 0 07:56:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:56:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:57:00 INFO - Return code: 0 07:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 07:57:00 INFO - Using env: {'DISPLAY': ':0', 07:57:00 INFO - 'HOME': '/home/cltbld', 07:57:00 INFO - 'LANG': 'en_US.UTF-8', 07:57:00 INFO - 'LANGUAGE': 'en_US:en', 07:57:00 INFO - 'LOGNAME': 'cltbld', 07:57:00 INFO - 'MAIL': '/var/mail/cltbld', 07:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:00 INFO - 'MOZ_NO_REMOTE': '1', 07:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:57:00 INFO - 'NO_EM_RESTART': '1', 07:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:00 INFO - 'PWD': '/builds/slave/test', 07:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:00 INFO - 'SHELL': '/bin/bash', 07:57:00 INFO - 'SHLVL': '1', 07:57:00 INFO - 'TERM': 'linux', 07:57:00 INFO - 'TMOUT': '86400', 07:57:00 INFO - 'USER': 'cltbld', 07:57:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414', 07:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:00 INFO - '_': '/tools/buildbot/bin/python'} 07:57:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:57:00 INFO - mozversion application_buildid: 20160721051621 07:57:00 INFO - mozversion application_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:57:00 INFO - mozversion application_display_name: Firefox 07:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:00 INFO - mozversion application_name: Firefox 07:57:00 INFO - mozversion application_remotingname: firefox 07:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:57:00 INFO - mozversion application_vendor: Mozilla 07:57:00 INFO - mozversion application_version: 48.0 07:57:00 INFO - mozversion platform_buildid: 20160721051621 07:57:00 INFO - mozversion platform_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:57:00 INFO - mozversion platform_version: 48.0 07:57:00 INFO - using testdate: 1469113020 07:57:00 INFO - actual date: 1469113020 07:57:00 INFO - starting webserver on 'localhost:60033' 07:57:00 INFO - SUITE-START | Running 2 tests 07:57:00 INFO - TEST-START | dromaeo_css 07:57:00 INFO - operating with platform_type : linux_ 07:57:00 INFO - Initialising browser for dromaeo_css test... 07:57:00 INFO - TEST-INFO | started process 524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBVBaOk/profile http://localhost:60033/getInfo.html) 07:57:04 INFO - PROCESS | 524 | __metrics Screen width/height:1600/1200 07:57:04 INFO - PROCESS | 524 | colorDepth:24 07:57:04 INFO - PROCESS | 524 | Browser inner width/height: 1024/697 07:57:04 INFO - PROCESS | 524 | __metrics 07:57:05 INFO - PROCESS | 524 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:05 ERROR - PROCESS | 524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:57:05 INFO - TEST-INFO | 524: exit 0 07:57:05 INFO - Browser initialized. 07:57:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:05 INFO - TEST-INFO | started process 617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBVBaOk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:17 INFO - PROCESS | 617 | RSS: Main: 139669504 07:57:17 INFO - PROCESS | 617 | 07:58:08 INFO - PROCESS | 617 | 1469113088585 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:00:16 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60033/tests/dromaeo/cssquery-ext.html) 08:00:17 INFO - PROCESS | 617 | RSS: Main: 246001664 08:00:17 INFO - PROCESS | 617 | 08:03:19 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-ext.html (next: http://localhost:60033/tests/dromaeo/cssquery-jquery.html) 08:03:19 INFO - PROCESS | 617 | RSS: Main: 225181696 08:03:19 INFO - PROCESS | 617 | 08:06:21 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60033/tests/dromaeo/cssquery-mootools.html) 08:06:22 INFO - PROCESS | 617 | RSS: Main: 215683072 08:06:22 INFO - PROCESS | 617 | 08:09:23 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60033/tests/dromaeo/cssquery-prototype.html) 08:09:24 INFO - PROCESS | 617 | RSS: Main: 217419776 08:09:24 INFO - PROCESS | 617 | 08:12:27 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60033/tests/dromaeo/cssquery-yui.html) 08:12:27 INFO - PROCESS | 617 | RSS: Main: 180297728 08:12:27 INFO - PROCESS | 617 | 08:15:29 INFO - PROCESS | 617 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-yui.html (next: http://localhost:60033/tests/dromaeo/cssquery-dojo.html) 08:15:30 INFO - PROCESS | 617 | RSS: Main: 253313024 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | __start_tp_report 08:15:30 INFO - PROCESS | 617 | _x_x_mozilla_page_load 08:15:30 INFO - PROCESS | 617 | _x_x_mozilla_page_load_details 08:15:30 INFO - PROCESS | 617 | |i|pagename|runs| 08:15:30 INFO - PROCESS | 617 | |0;dojo.html;3328.2677810881605;3350.9162270943225;3372.881949131781;3373.2241584435587;3394.168428734959;5443.455654434554;5445.50990410863;5464;5472.398036216013;5491.286132802735;5473.31583552056;5488.780448782044;5501.092319767234;5501.14732216507;5540.113581826909;4903.509649035086;4976.129177393959;5045.369328833895;5067.746612669352;5144.279800827869;4906.1168989581865;4950.900981980359;4975.054739599483;4983.401991760994;4990.550850423461;4987.501249875019;5007.69953802773;5058.873528161807;5063.215201643751;5080.060188865072;5101.260317253996;5105.489451054902;5121.052605268037;5127.743612819344;5150.613703972198;4927.285543596195;5000.049990501793;5029;5046.974765126188;5055.014272216919;5434.157705555645;5463.043967305705;5464.9180262296095;5465.890682186374;5485.204645326406;5987.281526216838;6029.336772954972;6032.336442991267;6036.607620504653;6044.848878778022;5904.350521442638;6019.518438524908;6033.48715359195;6057.121717350959;6057.121717351003;5587.972060139714;5605.159226116115;5613.8596535086135;5628.268325117709;5629.9437005629825;5890.175375447441;6132.6933653317155;6133.877322453615;6147.938520614826;6149.938500614937;5860.70696465175;5939.4357536034;5941.613795103304;5942.197803296586;5949.8215053548465;5963.5527335450015;5984.73068711909;5989.341172471112;5992.970035149797;6000.369961154103;5839.532837373;5875.500582450454;5949.077892926517;5962.046072628359;5971.940280597225;5976.551758618034;6018.277806663141;6018.939810601925;6022.427869352405;6068.029115341524;4542.863714088583;4552.954470455253;4562.498125206224;4585.312203169551;4589.954100459019;3964.7621142731527;3995.9001024974027;4041.5958404159937;4103.9179216416105;4146.315857883415;5701.315842098975;5713.371529131792;5734.541236701138;5741.88516229673;5771.913421298684;5970.49250813677;6013.789517366871;6057.363976782374;6059.787907423219;6060.363661815534;5583.972080139573;5730.111832665943;5734.9390362783015;5766.163906233573;5797.536197104221;5146.897062058738;5156.484351564814;5157.510036546522;5161.174212126117;5170.767315470813;6297.559170858088;6299.401556852092;6303.46420554258;6305.274893387227;6314.210723659543;5872.442117998783;5937.554683398676;5998.790042348497;6008.188894499187;6050.183225264533;6253.5622506424115;6257.843553911189;6299.622022678654;6300.653464059521;6306.747730090929;5922.496587790086;5943.078822782476;5946.018906880489;5952.553558483044;5981.162637230878;5758.1650660654805;6013.548983826143;6042.123892035718;6092.512598992159;6105.267367915879;5692.601517893873;5708.743106560298;5712.228849105318;5727.6849773262875;5741.799037033684;5615.101583746744;5667.40492248308;5670.319561652463;5697.4302569742695;5704.458076482728;5534.889302213853;5731.111677689964;5782.710864456844;5811.593188476766;5818.912716309174;5893.705314734332;5931.822045338647;5938.495227905676;5941.673207973603;5952.940470595238;5809.2738407699035;5816.883662326814;5823.912641310469;5824.039033559416;5834.970825145847 08:15:30 INFO - PROCESS | 617 | |1;ext.html;669.3875104279583;673.3199468536776;678.8065401360611;679.2053297641759;746.2612014106037;33133.50299745503;34224;34239.4864077039;34262.14344641382;40280.79859600705;43806.780966095204;44320.11359772811;44350.11299774003;44384.55615443845;44390.556094439045;8974.910250897488;9072;9154.084591540826;9161.587728552198;9161.587728552231;7932.048154221501;8948.686795962143;10803.83794243087;11053.723656908562;11062.723431914226;11073;11126.777464450706;11210.66368008961;11226.270292431007;11235.438228088562;10955.068819150381;11005.394703291317;11009.119270458345;11023.83464248037;11028.834567481494;10882.510287037023;10998.285111467729;11003.33979961205;11003.449827508593;11012.669619911416;43996.780016099714;44377.55622443799;44428.3335749964;44440.55559444429;44515.77421128963;3855.226595765951;3943.38877473992;4074.022234663659;4322.394864718942;4605.608523275526;33690.663093368996;34158.48762268568;34176.658233417846;34389;34456.48315275273;4303.74177549348;4437.622802061796;4475.149721552894;4486.798094085774;4498.572635599613;340146;340476;340618;342093;342695;40917.590824091974;41506.37740433896;65599.67200163969;66185.6690716553;66281.33718662849;39501.60498395037;39513.209735805125;39660.2067958645;39663;39682.80158599246;17198.65602687939;17400.39098631542;17414.303427862997;17422.825771742122;17430.47708568745;13555.457781688621;14665.48670796517;14732.116073035651;14736.705265894621;14738.11571305725;9324.8601270981;9501.334906556474;9548.42709437436;9570.33007689469;9588.232941364675;3531.205478767257;3535.3106144301614;3582.802945838004;3626.9274614507563;3653.6529029742132;1131.6944425005202;1139.3107170161932;1142.959906485111;1201.3872924808236;1213.3084142038954;32879.83560082232;33027;33580;33659;34251.314973700384;1213.6905089202196;1257.352463481308;1287.9678008049873;1297.3479654771788;1317.7876353754377;17752.822471775376;17761.46715598534;17935.641287174443;18041.639167216843;18160.818391816178;513767;514076;520097;521006;521024;62903.37096629067;63597.68201158965;63947.68026159839;63960.68019659872;64007.67996160083;1321.8215540901856;1489.1958342495147;1519.5821149184062;1537.223702030445;1609.251697960454;29876;31860.203494911886;32576.674233257363;32796.672033280316;32877.50683739794;50905.74547127241;51321.23018154805;51332.48667513277;51371.48628513667;51376.48623513866;296881;302255;304735;304822;304922;28146.29634259078;31334.216644584067;31755.523667145473;31847.68152318447;32258;46169.307460388794;46662.066758665314;46838.53161468478;47098;47452.28821567748;38898.4165237516;41221.58778412177;41376;41487;41783.7910810444;39468.60531394649;39683;40582;41617.37573936333;41747.373789393794;42043;42360;42730.35904461373;42821.785891071595;42920.570794291656;35002.474962875065;35889;37130.628693712715;37297.440538391405;37510.62489375071;28028.85985570141;28109.297267568476;28308.292292692022;28536.714632853407;28830.423391532473 08:15:30 INFO - PROCESS | 617 | |2;jquery.html;406.4188210858471;410.730971213855;429.606909677645;433.7007464849255;438.9692721509494;19701.113449894754;19843.20627174915;20239.491908856424;20452.590948181027;20469.078891449884;18841.62316753664;19213.61572768544;19773.110210040548;19791;19798.208071677116;5554.527865131468;5570.693611851357;5837.532997360222;5845.357010728816;5847.619904706181;4155.563665815092;5725.914111288334;5774.913376299338;6240.906386404185;6582.769603063894;6539.182602174728;6540.215174179105;6557.573757705758;6580.045893345486;6584.111144995436;6259.843503912393;6427.614343139427;6488.31872653374;6490.448311893495;6492.156019717407;3781.659650631429;3917.5690674025836;5594.328680558359;5782.56630752691;5794.449527294901;22114.557708845732;22432;22558.661620075713;22753.317400478012;22825.885870570706;2490.116008816862;2501.9874900625564;2593.623924530951;2668.5730283154794;2691.3137150026814;13839.238841863693;14026.228557429336;14234.644133896632;14647.560573182822;14945.626359340995;2056.187805816694;2116.714243577113;2122.1299267300333;2161.5892980333842;2185.278857976864;75099;75522.99999999945;75591;76400;77115.22884771136;10641.467926603638;10742.89257107419;10955.50700218492;11210.271332363533;11372.601958931398;15640.687186256211;15855.445059422866;15864.841351586567;15872.841271587136;15916.283767230503;8929.196372326522;8980.595873185723;9107.590158442754;9140.223081038186;9175.58709858058;8977.371583989057;9078;9139.81720365589;9182.219511341476;9244.075592440702;6776.424003959719;6867.244603093655;6966.965165174243;7050.964745176241;7133.357997780121;1826.3151318255655;1907.8473722102199;1928.0237756299905;1974.2004488182308;1974.6248212839514;1046.8325067989085;1114.6488856010492;1123.8258069999163;1229.59423390281;1231;17487.737683934753;18973.43079707611;19610.411687649394;19838.107285171915;20359.08384122718;1091.2252300866314;1100.3782862682558;1122.119136477861;1195.1813008089487;1195.647284051207;11271.04196143337;11292.322460652387;11467.483963221675;11532.94233528827;11542.538298468135;500193;506071;507910;508020;551145;76608;78719.60640196876;79175;79582;79644.6017769919;1126.808442564766;1142.5886680794906;1142.7428828513519;1143.5082914346744;1167.4046236419488;17187;17458;17660;17727.911360443115;18029.188686509402;35069;35966.820165899;36327;37041.81479092587;37566.43650345192;49170.508294916595;50802;50856.237156441945;51199;51687;8308.5430301334;8458.450200736932;8564;8595.398322117391;9037.774055648399;8200.466969646954;12610.67587903257;12958;13120.212787232796;13640.86359136396;10642.361458312525;11142.220044596801;11221.438928053727;11292.209545332076;11606;11085.067145120343;11187.160962927976;11322.433878306216;11504.94247528757;11541.249818761753;11061.612843550438;11365.488553015299;11469.139814513777;11483.138764592522;11606.593769218036;8503.659853606034;8533.104024077382;8574.31405487572;8575.356848236283;8700.825983480421;11625.302481851117;11840.23038502529;11866.703332416413;12060;12167.087468440079 08:15:30 INFO - PROCESS | 617 | |3;mootools.html;1435.6554426937525;1596.872250219982;1598.0651318978396;1813.8730288879783;1945.2219112355056;7529.09650841899;8221.958890205548;8425.199606037431;8442.197991190827;8453.365997550185;8364.623591938362;8396.538190399526;8450.535220562866;8456;8461.153884611536;2425.5148970205987;2449.3876530867283;2449.963250551234;2452.3010941881566;2454.877256137186;2346.6480027995767;2389.23544465771;2391.712994440661;2394.1979436888664;2408.229366602688;2448.8163387745903;2481.4044629288933;2484.403743101652;2490.9377265568323;2503.8622875741917;2421.9273421797197;2424.818138639609;2431.768981946721;2438.7317395086525;2472.2336075816556;2402.039184326266;2457.8402403843693;2463.3718401807423;2464.876756162185;2466.161505088279;8300.750977470685;8458;8516.318694504425;8519.105493923173;8526.914730852674;5364.222187782789;5471.890562188734;5487;5487.780488780444;5489.094299440588;3565.1265439967115;3583.157957879896;3595.5865075516126;3654.214343916071;3752.137008488036;1211.5396149463147;1215.6778453709774;1277.4698500122438;1284.2230450577454;1295.8250636164187;11521.654350369503;11726.648200553997;12010.879891200977;12047.156699031071;12060.517579296818;4637.652176086807;4746.928796068062;4758.595519380891;4795.232762757942;4817.494163112893;9599.32804703664;9602.279829012852;9642.517874106266;9679.854802177973;9699.951500242594;5404.594655400861;5442.8911421771345;5443.755031023614;5444.292242008513;5447.291852059287;4287.57124287575;4892.779824907888;4995.825146119869;5020.874478138003;5041.823536176216;4137.2552940470405;4179.390934490243;4239.851605193803;4259;4270.572942705767;1354.525915929417;1376.6902446949357;1399.3003498250876;1407.27525324458;1413.1521087347714;912.3613470570627;1051.1748277602046;1080.6541906589973;1082.1775450657558;1088.3796236145479;5617.9438205618235;5882.3529411764675;5909.645421274738;5931.73307201177;6251.093591429309;478.04868312058755;482.85031640191653;482.9010052939139;499.7026769072396;1089.7874914391775;3992.2215168042535;4003.979980100081;4131.256373852735;4141.544430112685;4163.063310755056;9995.850062249072;10118.038786315288;10195.133413659922;10240;10276.229282803819;10080.495975201356;10103.545340459697;10109.64616238428;10117.241206909512;10131;7749.845003100019;7917.485363451472;8038.477498962548;8187.754367368989;8202.17978202175;5921.851953701192;5943.078822782476;6005.7297421617;6063.518802953015;6075.939240607538;9289.953550232205;9351.485668288038;9500.192483638968;9554.28342874301;9561.378510396802;9375.859362109437;9704.75738106553;9708.563114659999;9749.415035097916;9915.504224788587;6512.153420055362;7052.612106334201;7262.745803896838;7306;7412.481126321106;8149.633266502903;8193;8202.466839655403;8233.38249631268;8247.175282471704;7114.964425177841;7252.601106939169;7304.452166087458;7422.146453157956;7434.107907051189;7136.821579460555;7191.3887319578425;7218.675159617935;7225.747098851515;7301.488895777245;6705.932940670531;6756.898646520404;6825.761098361732;6884.380405763505;6890.586564806128;5078.542931136216;5102.540771330449;5142.460041695568;5195.636305458733;5225.973870130625;5060.266261392151;5144.485551444825;5213.296205012426;5261.947380526146;5397.919031214614 08:15:30 INFO - PROCESS | 617 | |4;prototype.html;350.6546052138643;357.2693841094961;358.98205089745517;361.6221049003791;362.1706292589969;6128.57100003;6132.478739307165;6133.417325354084;6134.815955521331;6225.035119556464;5769.278840144982;5891.823245302648;5975.282966044081;6026.668533230671;6084.421979911901;4663.417072865892;4693.296005599171;4696.342512048316;4697.88255293617;4706.670533062678;4675.345451636774;4684.461286951993;4698.7885545150375;4698.976505117486;4714.198586240347;4495.820167193325;4578.65660075494;4596.149712303235;4712.622990160796;4717.245240761479;4693.483716791185;4710.152172608929;4712.929306060412;4719.90560188796;4724.220503616916;4177.791110444466;4183.184279065584;4183.477065366829;4189.350650649154;4196.034911970233;5851.795187168471;5861.912071318934;5867.413258674099;5868.4718375346;5869.823905282806;5481.040817856859;5483.670979741229;5485.862853428656;5485.917711234335;5500.559955203574;6215.533834962351;6392.776252831175;6400.4559612432995;6406.423421892052;6412.326705695881;4496.190685676577;4500.8649740507835;4520.4575450946095;4524.11779702958;4536.432945881765;6648.135742353512;6681.5656982296;6700.39696427319;6718.227403848522;6728.798136055926;4605.378273933044;4611.746353950565;4614.76926153691;4619.122366750306;4624.1445332613575;4658.557437043475;4660.557247061523;4666.556677115668;4667.276572131325;4669.182892993713;5269.394019687708;5366.409694933554;5370.194470829407;5373.7581808818695;5392.379876314196;6407.615543067431;6437.485001199892;6455.548111632234;6458.806235812933;6473.417392434703;1540.653352995567;1614.5802091456305;1629.380835282585;1632.9183540822912;1634.3380930723076;1057.2810488867644;1082.7942690888863;1088.8366744988316;1089.7112265249716;1095.386583513235;6180.7527698891545;6186.845328866814;6210.937890621126;6218.036204388327;6235.750569977241;6582.473402127818;6589.835254118685;6590.143281373391;6596.076549283104;6598.208215014229;6242.406971337716;6242.719077641517;6244.843878903063;6248.156498872685;6250.718717657716;3517.472379143149;3554.413521768879;3557.5197348358156;3558.217192217708;3560.928781424357;6775.085363475868;6847.109875716125;6858.142732158481;7037.542559733601;7039.54242974205;6803.829904252433;6840.281770414134;6840.3501667341525;6851.520393572502;6859.382655560924;6958.095447591781;6993.160820701549;7006.4745144114395;7006.894896576556;7012.0533727947095;6732.932670673231;6734.124563806674;6739.898901516579;6745.86508269822;6755.831104222434;6502.154719886385;6618.63597502142;6644.90032649501;6656.800295991128;6657.1345725055435;6943.854264046578;6965.268646792217;6972.895406568804;6993.545419547713;7004.229534751275;4508.977455112835;4532.048269863366;4543.341215523797;4554.749488778149;4561.657875659273;6694.866102677822;6698.430633396216;6706.094677218513;6709.094272273181;6709.832254193684;6197.504199664107;6296.653684047421;6314.210723659543;6477.740890364521;6499.935000649933;6466.224053113657;6497.707603157774;6502.057201705632;6502.772402965874;6504.577202481823;6385.393387628168;6393.041043843461;6397.744090236339;6402.263739669997;6405.775797847053;6493.610383376824;6550.6069635820095;6554.573952693059;6559.311272316529;6562.80311590653;6179.505639548735;6331.778387756591;6339.397757213057;6399.976003839363;6411.294757576756 08:15:30 INFO - PROCESS | 617 | |5;yui.html;923.335198656967;923.736735030516;940.2571968145165;947.1664934857324;950.1923365139628;13957.09278896871;14214.71570568588;14257.71484570308;14258.358373873174;14281.50014749484;14143.575692729235;14231.78652320216;14298.356573954172;14308.57074287773;14312.642183945407;724.1274264511264;901.2159421303476;918.8208299381623;920.9769755756126;923.7598224461622;894.1639567004838;899.029048627484;902.0888902208751;902.3593248793364;902.3953950852945;960.490939801906;973.1144658360857;973.2846357926918;973.7224890906093;975.3124047546463;769.638270013093;936.3211671538114;947.7772723409993;951.7477868364889;954.065016284042;693.4452438049591;693.8993845892318;694.350782018809;694.8506071194718;699.7166147710135;15166.393344266216;15289.770653440208;15313;15317.31072101758;15330;14940.178290194035;15036.819661149182;15177.696446071017;15218.163001034938;15318.770218446733;11730.765384692344;11779.116566257566;12025.278483290944;12083.758324833454;12088.879111208864;3937.6652984496354;3999.960000399988;4002.939955900664;4019.77891215983;4046.089629833293;53442.46557534414;54604.72697636526;54704.45295547073;54743.726281368734;55510.44489555093;11432.199746017699;11532.962033417032;11730.70673233159;11772.293662380285;11796.52813887452;19750.11124499401;20062.598748024957;20100.497487562636;20102.497437563885;20130.295439659836;8713;8761.824763504694;8860.202581767671;8870;8903.154200350957;4825.638077144228;4863.732494712754;4888.535589119028;4892.437369702458;4899.559039686445;3850.0759817644125;3966.087799806061;3977.7016723745833;3992.061865461614;3997.360422332413;646.8997305417668;690.6443181761397;732.6739600877664;753.4198667026468;758.624480881967;808.5068108453838;828.1635548096466;833.0919297965247;844.6072576252072;852.7527017165077;9767;9839;10154.847677284846;10275.537600807982;10308.742281442874;626.1671976271548;626.5614070150913;628.2272804450461;703.2299631903059;725.4559080689482;4265.701400901907;4269.295566231599;4274.935875961863;4336.50130235027;4351.586599273127;66974.66512667405;67172.664136679;67375.32624673788;67725.66137169283;67817.66091169513;56848;57252;57457.425425745205;57588.42411575831;57746.422535774946;52675.47324526782;53004.46995530072;53228.201576976375;53335.46664533305;53426.73286633542;8142.145074767064;8340.749777506684;8356.080831108451;8368.874466883124;8446.957765211135;40175.1964960705;40308.798456007535;40325.79837100796;41118.38322425106;41743;46525.767371162925;46617.76691116523;51093.23360149527;52021.7398913003;52499.73750131225;12051.276923384625;12067.879321206676;12199.085068619712;12320.322382269062;12440.75118497643;12583.685407864876;13034.022448316224;13219.735605288033;13247.536336228572;13834.515791947233;12662.810057849323;12928.935355323163;12930.288834113837;12956.28740419286;13359.332033398097;12083.939580302042;12094.395280235776;12140.75718485643;12188.20776649515;12216.877831221575;12297.815532767194;12348.506059757508;12419.93790031044;12487;12541.561045363369;10008.39949603026;10177.49112544355;10419.270651054354;10493;10512.369257844553;10353.482325883826;10357.844632330673;10396;10411.94794026025;10447.111995480469 08:15:30 INFO - PROCESS | 617 | __end_tp_report 08:15:30 INFO - PROCESS | 617 | __start_cc_report 08:15:30 INFO - PROCESS | 617 | _x_x_mozilla_cycle_collect,838 08:15:30 INFO - PROCESS | 617 | __end_cc_report 08:15:30 INFO - PROCESS | 617 | __startTimestamp1469114130231__endTimestamp 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | ------- Summary: start ------- 08:15:30 INFO - PROCESS | 617 | Number of tests: 6 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#0] dojo.html Cycles:165 Average:5551.58 Median:5741.80 stddev:636.02 (11.1%) stddev-sans-first:613.59 08:15:30 INFO - PROCESS | 617 | Values: 3328.3 3350.9 3372.9 3373.2 3394.2 5443.5 5445.5 5464.0 5472.4 5491.3 5473.3 5488.8 5501.1 5501.1 5540.1 4903.5 4976.1 5045.4 5067.7 5144.3 4906.1 4950.9 4975.1 4983.4 4990.6 4987.5 5007.7 5058.9 5063.2 5080.1 5101.3 5105.5 5121.1 5127.7 5150.6 4927.3 5000.0 5029.0 5047.0 5055.0 5434.2 5463.0 5464.9 5465.9 5485.2 5987.3 6029.3 6032.3 6036.6 6044.8 5904.4 6019.5 6033.5 6057.1 6057.1 5588.0 5605.2 5613.9 5628.3 5629.9 5890.2 6132.7 6133.9 6147.9 6149.9 5860.7 5939.4 5941.6 5942.2 5949.8 5963.6 5984.7 5989.3 5993.0 6000.4 5839.5 5875.5 5949.1 5962.0 5971.9 5976.6 6018.3 6018.9 6022.4 6068.0 4542.9 4553.0 4562.5 4585.3 4590.0 3964.8 3995.9 4041.6 4103.9 4146.3 5701.3 5713.4 5734.5 5741.9 5771.9 5970.5 6013.8 6057.4 6059.8 6060.4 5584.0 5730.1 5734.9 5766.2 5797.5 5146.9 5156.5 5157.5 5161.2 5170.8 6297.6 6299.4 6303.5 6305.3 6314.2 5872.4 5937.6 5998.8 6008.2 6050.2 6253.6 6257.8 6299.6 6300.7 6306.7 5922.5 5943.1 5946.0 5952.6 5981.2 5758.2 6013.5 6042.1 6092.5 6105.3 5692.6 5708.7 5712.2 5727.7 5741.8 5615.1 5667.4 5670.3 5697.4 5704.5 5534.9 5731.1 5782.7 5811.6 5818.9 5893.7 5931.8 5938.5 5941.7 5952.9 5809.3 5816.9 5823.9 5824.0 5835.0 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#1] ext.html Cycles:180 Average:55315.90 Median:19735.90 stddev:105472.79 (534.4%) stddev-sans-first:105688.87 08:15:30 INFO - PROCESS | 617 | Values: 669.4 673.3 678.8 679.2 746.3 33133.5 34224.0 34239.5 34262.1 40280.8 43806.8 44320.1 44350.1 44384.6 44390.6 8974.9 9072.0 9154.1 9161.6 9161.6 7932.0 8948.7 10803.8 11053.7 11062.7 11073.0 11126.8 11210.7 11226.3 11235.4 10955.1 11005.4 11009.1 11023.8 11028.8 10882.5 10998.3 11003.3 11003.4 11012.7 43996.8 44377.6 44428.3 44440.6 44515.8 3855.2 3943.4 4074.0 4322.4 4605.6 33690.7 34158.5 34176.7 34389.0 34456.5 4303.7 4437.6 4475.1 4486.8 4498.6 340146.0 340476.0 340618.0 342093.0 342695.0 40917.6 41506.4 65599.7 66185.7 66281.3 39501.6 39513.2 39660.2 39663.0 39682.8 17198.7 17400.4 17414.3 17422.8 17430.5 13555.5 14665.5 14732.1 14736.7 14738.1 9324.9 9501.3 9548.4 9570.3 9588.2 3531.2 3535.3 3582.8 3626.9 3653.7 1131.7 1139.3 1143.0 1201.4 1213.3 32879.8 33027.0 33580.0 33659.0 34251.3 1213.7 1257.4 1288.0 1297.3 1317.8 17752.8 17761.5 17935.6 18041.6 18160.8 513767.0 514076.0 520097.0 521006.0 521024.0 62903.4 63597.7 63947.7 63960.7 64007.7 1321.8 1489.2 1519.6 1537.2 1609.3 29876.0 31860.2 32576.7 32796.7 32877.5 50905.7 51321.2 51332.5 51371.5 51376.5 296881.0 302255.0 304735.0 304822.0 304922.0 28146.3 31334.2 31755.5 31847.7 32258.0 46169.3 46662.1 46838.5 47098.0 47452.3 38898.4 41221.6 41376.0 41487.0 41783.8 39468.6 39683.0 40582.0 41617.4 41747.4 42043.0 42360.0 42730.4 42821.8 42920.6 35002.5 35889.0 37130.6 37297.4 37510.6 28028.9 28109.3 28308.3 28536.7 28830.4 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#2] jquery.html Cycles:180 Average:29117.62 Median:22495.33 stddev:84312.56 (374.8%) stddev-sans-first:84521.52 08:15:30 INFO - PROCESS | 617 | Values: 406.4 410.7 429.6 433.7 439.0 19701.1 19843.2 20239.5 20452.6 20469.1 18841.6 19213.6 19773.1 19791.0 19798.2 5554.5 5570.7 5837.5 5845.4 5847.6 4155.6 5725.9 5774.9 6240.9 6582.8 6539.2 6540.2 6557.6 6580.0 6584.1 6259.8 6427.6 6488.3 6490.4 6492.2 3781.7 3917.6 5594.3 5782.6 5794.4 22114.6 22432.0 22558.7 22753.3 22825.9 2490.1 2502.0 2593.6 2668.6 2691.3 13839.2 14026.2 14234.6 14647.6 14945.6 2056.2 2116.7 2122.1 2161.6 2185.3 75099.0 75523.0 75591.0 76400.0 77115.2 10641.5 10742.9 10955.5 11210.3 11372.6 15640.7 15855.4 15864.8 15872.8 15916.3 8929.2 8980.6 9107.6 9140.2 9175.6 8977.4 9078.0 9139.8 9182.2 9244.1 6776.4 6867.2 6967.0 7051.0 7133.4 1826.3 1907.8 1928.0 1974.2 1974.6 1046.8 1114.6 1123.8 1229.6 1231.0 17487.7 18973.4 19610.4 19838.1 20359.1 1091.2 1100.4 1122.1 1195.2 1195.6 11271.0 11292.3 11467.5 11532.9 11542.5 500193.0 506071.0 507910.0 508020.0 551145.0 76608.0 78719.6 79175.0 79582.0 79644.6 1126.8 1142.6 1142.7 1143.5 1167.4 17187.0 17458.0 17660.0 17727.9 18029.2 35069.0 35966.8 36327.0 37041.8 37566.4 49170.5 50802.0 50856.2 51199.0 51687.0 8308.5 8458.5 8564.0 8595.4 9037.8 8200.5 12610.7 12958.0 13120.2 13640.9 10642.4 11142.2 11221.4 11292.2 11606.0 11085.1 11187.2 11322.4 11504.9 11541.2 11061.6 11365.5 11469.1 11483.1 11606.6 8503.7 8533.1 8574.3 8575.4 8700.8 11625.3 11840.2 11866.7 12060.0 12167.1 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#3] mootools.html Cycles:180 Average:5655.47 Median:5122.50 stddev:3043.11 (59.4%) stddev-sans-first:3035.12 08:15:30 INFO - PROCESS | 617 | Values: 1435.7 1596.9 1598.1 1813.9 1945.2 7529.1 8222.0 8425.2 8442.2 8453.4 8364.6 8396.5 8450.5 8456.0 8461.2 2425.5 2449.4 2450.0 2452.3 2454.9 2346.6 2389.2 2391.7 2394.2 2408.2 2448.8 2481.4 2484.4 2490.9 2503.9 2421.9 2424.8 2431.8 2438.7 2472.2 2402.0 2457.8 2463.4 2464.9 2466.2 8300.8 8458.0 8516.3 8519.1 8526.9 5364.2 5471.9 5487.0 5487.8 5489.1 3565.1 3583.2 3595.6 3654.2 3752.1 1211.5 1215.7 1277.5 1284.2 1295.8 11521.7 11726.6 12010.9 12047.2 12060.5 4637.7 4746.9 4758.6 4795.2 4817.5 9599.3 9602.3 9642.5 9679.9 9700.0 5404.6 5442.9 5443.8 5444.3 5447.3 4287.6 4892.8 4995.8 5020.9 5041.8 4137.3 4179.4 4239.9 4259.0 4270.6 1354.5 1376.7 1399.3 1407.3 1413.2 912.4 1051.2 1080.7 1082.2 1088.4 5617.9 5882.4 5909.6 5931.7 6251.1 478.0 482.9 482.9 499.7 1089.8 3992.2 4004.0 4131.3 4141.5 4163.1 9995.9 10118.0 10195.1 10240.0 10276.2 10080.5 10103.5 10109.6 10117.2 10131.0 7749.8 7917.5 8038.5 8187.8 8202.2 5921.9 5943.1 6005.7 6063.5 6075.9 9290.0 9351.5 9500.2 9554.3 9561.4 9375.9 9704.8 9708.6 9749.4 9915.5 6512.2 7052.6 7262.7 7306.0 7412.5 8149.6 8193.0 8202.5 8233.4 8247.2 7115.0 7252.6 7304.5 7422.1 7434.1 7136.8 7191.4 7218.7 7225.7 7301.5 6705.9 6756.9 6825.8 6884.4 6890.6 5078.5 5102.5 5142.5 5195.6 5226.0 5060.3 5144.5 5213.3 5261.9 5397.9 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#4] prototype.html Cycles:180 Average:5419.61 Median:6183.80 stddev:1632.12 (26.4%) stddev-sans-first:1591.73 08:15:30 INFO - PROCESS | 617 | Values: 350.7 357.3 359.0 361.6 362.2 6128.6 6132.5 6133.4 6134.8 6225.0 5769.3 5891.8 5975.3 6026.7 6084.4 4663.4 4693.3 4696.3 4697.9 4706.7 4675.3 4684.5 4698.8 4699.0 4714.2 4495.8 4578.7 4596.1 4712.6 4717.2 4693.5 4710.2 4712.9 4719.9 4724.2 4177.8 4183.2 4183.5 4189.4 4196.0 5851.8 5861.9 5867.4 5868.5 5869.8 5481.0 5483.7 5485.9 5485.9 5500.6 6215.5 6392.8 6400.5 6406.4 6412.3 4496.2 4500.9 4520.5 4524.1 4536.4 6648.1 6681.6 6700.4 6718.2 6728.8 4605.4 4611.7 4614.8 4619.1 4624.1 4658.6 4660.6 4666.6 4667.3 4669.2 5269.4 5366.4 5370.2 5373.8 5392.4 6407.6 6437.5 6455.5 6458.8 6473.4 1540.7 1614.6 1629.4 1632.9 1634.3 1057.3 1082.8 1088.8 1089.7 1095.4 6180.8 6186.8 6210.9 6218.0 6235.8 6582.5 6589.8 6590.1 6596.1 6598.2 6242.4 6242.7 6244.8 6248.2 6250.7 3517.5 3554.4 3557.5 3558.2 3560.9 6775.1 6847.1 6858.1 7037.5 7039.5 6803.8 6840.3 6840.4 6851.5 6859.4 6958.1 6993.2 7006.5 7006.9 7012.1 6732.9 6734.1 6739.9 6745.9 6755.8 6502.2 6618.6 6644.9 6656.8 6657.1 6943.9 6965.3 6972.9 6993.5 7004.2 4509.0 4532.0 4543.3 4554.7 4561.7 6694.9 6698.4 6706.1 6709.1 6709.8 6197.5 6296.7 6314.2 6477.7 6499.9 6466.2 6497.7 6502.1 6502.8 6504.6 6385.4 6393.0 6397.7 6402.3 6405.8 6493.6 6550.6 6554.6 6559.3 6562.8 6179.5 6331.8 6339.4 6400.0 6411.3 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - PROCESS | 617 | [#5] yui.html Cycles:180 Average:15583.76 Median:4305.72 stddev:18251.11 (423.9%) stddev-sans-first:18269.10 08:15:30 INFO - PROCESS | 617 | Values: 923.3 923.7 940.3 947.2 950.2 13957.1 14214.7 14257.7 14258.4 14281.5 14143.6 14231.8 14298.4 14308.6 14312.6 724.1 901.2 918.8 921.0 923.8 894.2 899.0 902.1 902.4 902.4 960.5 973.1 973.3 973.7 975.3 769.6 936.3 947.8 951.7 954.1 693.4 693.9 694.4 694.9 699.7 15166.4 15289.8 15313.0 15317.3 15330.0 14940.2 15036.8 15177.7 15218.2 15318.8 11730.8 11779.1 12025.3 12083.8 12088.9 3937.7 4000.0 4002.9 4019.8 4046.1 53442.5 54604.7 54704.5 54743.7 55510.4 11432.2 11533.0 11730.7 11772.3 11796.5 19750.1 20062.6 20100.5 20102.5 20130.3 8713.0 8761.8 8860.2 8870.0 8903.2 4825.6 4863.7 4888.5 4892.4 4899.6 3850.1 3966.1 3977.7 3992.1 3997.4 646.9 690.6 732.7 753.4 758.6 808.5 828.2 833.1 844.6 852.8 9767.0 9839.0 10154.8 10275.5 10308.7 626.2 626.6 628.2 703.2 725.5 4265.7 4269.3 4274.9 4336.5 4351.6 66974.7 67172.7 67375.3 67725.7 67817.7 56848.0 57252.0 57457.4 57588.4 57746.4 52675.5 53004.5 53228.2 53335.5 53426.7 8142.1 8340.7 8356.1 8368.9 8447.0 40175.2 40308.8 40325.8 41118.4 41743.0 46525.8 46617.8 51093.2 52021.7 52499.7 12051.3 12067.9 12199.1 12320.3 12440.8 12583.7 13034.0 13219.7 13247.5 13834.5 12662.8 12928.9 12930.3 12956.3 13359.3 12083.9 12094.4 12140.8 12188.2 12216.9 12297.8 12348.5 12419.9 12487.0 12541.6 10008.4 10177.5 10419.3 10493.0 10512.4 10353.5 10357.8 10396.0 10411.9 10447.1 08:15:30 INFO - PROCESS | 617 | -------- Summary: end -------- 08:15:30 INFO - PROCESS | 617 | 08:15:30 INFO - TEST-INFO | 617: exit 0 08:15:30 INFO - TEST-OK | dromaeo_css | took 1110425ms 08:15:30 INFO - TEST-START | kraken 08:15:30 INFO - operating with platform_type : linux_ 08:15:30 INFO - Initialising browser for kraken test... 08:15:30 INFO - TEST-INFO | started process 811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KZMUY/profile http://localhost:60033/getInfo.html) 08:15:34 INFO - PROCESS | 811 | __metrics Screen width/height:1600/1200 08:15:34 INFO - PROCESS | 811 | colorDepth:24 08:15:34 INFO - PROCESS | 811 | Browser inner width/height: 1024/697 08:15:34 INFO - PROCESS | 811 | __metrics 08:15:35 INFO - PROCESS | 811 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:35 ERROR - PROCESS | 811 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:36 INFO - TEST-INFO | 811: exit 0 08:15:36 INFO - Browser initialized. 08:15:36 INFO - Running cycle 1/1 for kraken test... 08:15:36 INFO - TEST-INFO | started process 909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KZMUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:48 INFO - PROCESS | 909 | RSS: Main: 139280384 08:15:48 INFO - PROCESS | 909 | 08:15:50 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:51 INFO - PROCESS | 909 | RSS: Main: 197873664 08:15:51 INFO - PROCESS | 909 | 08:15:54 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-dft) 08:15:54 INFO - PROCESS | 909 | RSS: Main: 183783424 08:15:54 INFO - PROCESS | 909 | 08:15:57 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-fft) 08:15:58 INFO - PROCESS | 909 | RSS: Main: 273113088 08:15:58 INFO - PROCESS | 909 | 08:16:00 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-oscillator) 08:16:00 INFO - PROCESS | 909 | RSS: Main: 179216384 08:16:00 INFO - PROCESS | 909 | 08:16:02 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:03 INFO - PROCESS | 909 | RSS: Main: 177725440 08:16:03 INFO - PROCESS | 909 | 08:16:06 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:07 INFO - PROCESS | 909 | RSS: Main: 212946944 08:16:07 INFO - PROCESS | 909 | 08:16:10 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:10 INFO - PROCESS | 909 | RSS: Main: 212602880 08:16:10 INFO - PROCESS | 909 | 08:16:13 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60033/tests/kraken/driver.html?testName=json-parse-financial) 08:16:14 INFO - PROCESS | 909 | RSS: Main: 212611072 08:16:14 INFO - PROCESS | 909 | 08:16:15 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:16 INFO - PROCESS | 909 | RSS: Main: 196317184 08:16:16 INFO - PROCESS | 909 | 08:16:18 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:18 INFO - PROCESS | 909 | RSS: Main: 199151616 08:16:18 INFO - PROCESS | 909 | 08:16:20 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:21 INFO - PROCESS | 909 | RSS: Main: 209674240 08:16:21 INFO - PROCESS | 909 | 08:16:23 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:24 INFO - PROCESS | 909 | RSS: Main: 217034752 08:16:24 INFO - PROCESS | 909 | 08:16:26 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:27 INFO - PROCESS | 909 | RSS: Main: 211742720 08:16:27 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60033/tests/kraken/driver.html?testName=ai-astar) 08:16:29 INFO - PROCESS | 909 | RSS: Main: 272494592 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | __start_tp_report 08:16:29 INFO - PROCESS | 909 | _x_x_mozilla_page_load 08:16:29 INFO - PROCESS | 909 | _x_x_mozilla_page_load_details 08:16:29 INFO - PROCESS | 909 | |i|pagename|runs| 08:16:29 INFO - PROCESS | 909 | |0;ai-astar;110;112;110;111;111;111;104;110;112;109 08:16:29 INFO - PROCESS | 909 | |1;audio-beat-detection;153;128;149;174;127;162;165;130;180;127 08:16:29 INFO - PROCESS | 909 | |2;audio-dft;160;159;159;160;161;160;160;161;160;159 08:16:29 INFO - PROCESS | 909 | |3;audio-fft;74;77;72;168;76;76;76;76;163;73 08:16:29 INFO - PROCESS | 909 | |4;audio-oscillator;93;92;154;91;92;93;153;91;91;145 08:16:29 INFO - PROCESS | 909 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;116;117 08:16:29 INFO - PROCESS | 909 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;146 08:16:29 INFO - PROCESS | 909 | |7;imaging-desaturate;95;94;95;95;94;94;96;95;95;95 08:16:29 INFO - PROCESS | 909 | |8;json-parse-financial;55;60;54;54;55;55;56;96;53;53 08:16:29 INFO - PROCESS | 909 | |9;json-stringify-tinderbox;57;57;57;59;58;58;57;58;58;58 08:16:29 INFO - PROCESS | 909 | |10;stanford-crypto-aes;72;71;73;72;73;73;72;80;72;72 08:16:29 INFO - PROCESS | 909 | |11;stanford-crypto-ccm;114;114;113;114;110;113;116;117;125;114 08:16:29 INFO - PROCESS | 909 | |12;stanford-crypto-pbkdf2;158;155;156;159;160;158;156;157;157;156 08:16:29 INFO - PROCESS | 909 | |13;stanford-crypto-sha256-iterative;66;66;66;66;68;64;66;65;67;65 08:16:29 INFO - PROCESS | 909 | __end_tp_report 08:16:29 INFO - PROCESS | 909 | __start_cc_report 08:16:29 INFO - PROCESS | 909 | _x_x_mozilla_cycle_collect,1576 08:16:29 INFO - PROCESS | 909 | __end_cc_report 08:16:29 INFO - PROCESS | 909 | __startTimestamp1469114189456__endTimestamp 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | ------- Summary: start ------- 08:16:29 INFO - PROCESS | 909 | Number of tests: 14 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.31 (2.1%) stddev-sans-first:2.45 08:16:29 INFO - PROCESS | 909 | Values: 110.0 112.0 110.0 111.0 111.0 111.0 104.0 110.0 112.0 109.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.50 stddev:20.53 (13.0%) stddev-sans-first:21.74 08:16:29 INFO - PROCESS | 909 | Values: 153.0 128.0 149.0 174.0 127.0 162.0 165.0 130.0 180.0 127.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:16:29 INFO - PROCESS | 909 | Values: 160.0 159.0 159.0 160.0 161.0 160.0 160.0 161.0 160.0 159.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:38.21 (50.3%) stddev-sans-first:39.90 08:16:29 INFO - PROCESS | 909 | Values: 74.0 77.0 72.0 168.0 76.0 76.0 76.0 76.0 163.0 73.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:91.50 stddev:28.51 (31.2%) stddev-sans-first:29.61 08:16:29 INFO - PROCESS | 909 | Values: 93.0 92.0 154.0 91.0 92.0 93.0 153.0 91.0 91.0 145.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:16:29 INFO - PROCESS | 909 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:16:29 INFO - PROCESS | 909 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:16:29 INFO - PROCESS | 909 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 96.0 95.0 95.0 95.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:55.00 stddev:13.12 (23.9%) stddev-sans-first:13.83 08:16:29 INFO - PROCESS | 909 | Values: 55.0 60.0 54.0 54.0 55.0 55.0 56.0 96.0 53.0 53.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 08:16:29 INFO - PROCESS | 909 | Values: 57.0 57.0 57.0 59.0 58.0 58.0 57.0 58.0 58.0 58.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:72.50 stddev:2.54 (3.5%) stddev-sans-first:2.67 08:16:29 INFO - PROCESS | 909 | Values: 72.0 71.0 73.0 72.0 73.0 73.0 72.0 80.0 72.0 72.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:114.00 stddev:3.97 (3.5%) stddev-sans-first:4.20 08:16:29 INFO - PROCESS | 909 | Values: 114.0 114.0 113.0 114.0 110.0 113.0 116.0 117.0 125.0 114.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:1.55 (1.0%) stddev-sans-first:1.62 08:16:29 INFO - PROCESS | 909 | Values: 158.0 155.0 156.0 159.0 160.0 158.0 156.0 157.0 157.0 156.0 08:16:29 INFO - PROCESS | 909 | 08:16:29 INFO - PROCESS | 909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 08:16:29 INFO - PROCESS | 909 | Values: 66.0 66.0 66.0 66.0 68.0 64.0 66.0 65.0 67.0 65.0 08:16:29 INFO - PROCESS | 909 | -------- Summary: end -------- 08:16:29 INFO - PROCESS | 909 | 08:16:30 INFO - TEST-INFO | 909: exit 0 08:16:30 INFO - TEST-OK | kraken | took 59409ms 08:16:30 INFO - SUITE-END | took 1169s 08:16:30 INFO - Completed test suite (00:19:30) 08:16:30 INFO - javascript benchmark 08:16:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.2677810881605, 3350.9162270943225, 3372.881949131781, 3373.2241584435587, 3394.168428734959, 5443.455654434554, 5445.50990410863, 5464.0, 5472.398036216013, 5491.286132802735, 5473.31583552056, 5488.780448782044, 5501.092319767234, 5501.14732216507, 5540.113581826909, 4903.509649035086, 4976.129177393959, 5045.369328833895, 5067.746612669352, 5144.279800827869, 4906.1168989581865, 4950.900981980359, 4975.054739599483, 4983.401991760994, 4990.550850423461, 4987.501249875019, 5007.69953802773, 5058.873528161807, 5063.215201643751, 5080.060188865072, 5101.260317253996, 5105.489451054902, 5121.052605268037, 5127.743612819344, 5150.613703972198, 4927.285543596195, 5000.049990501793, 5029.0, 5046.974765126188, 5055.014272216919, 5434.157705555645, 5463.043967305705, 5464.9180262296095, 5465.890682186374, 5485.204645326406, 5987.281526216838, 6029.336772954972, 6032.336442991267, 6036.607620504653, 6044.848878778022, 5904.350521442638, 6019.518438524908, 6033.48715359195, 6057.121717350959, 6057.121717351003, 5587.972060139714, 5605.159226116115, 5613.8596535086135, 5628.268325117709, 5629.9437005629825, 5890.175375447441, 6132.6933653317155, 6133.877322453615, 6147.938520614826, 6149.938500614937, 5860.70696465175, 5939.4357536034, 5941.613795103304, 5942.197803296586, 5949.8215053548465, 5963.5527335450015, 5984.73068711909, 5989.341172471112, 5992.970035149797, 6000.369961154103, 5839.532837373, 5875.500582450454, 5949.077892926517, 5962.046072628359, 5971.940280597225, 5976.551758618034, 6018.277806663141, 6018.939810601925, 6022.427869352405, 6068.029115341524, 4542.863714088583, 4552.954470455253, 4562.498125206224, 4585.312203169551, 4589.954100459019, 3964.7621142731527, 3995.9001024974027, 4041.5958404159937, 4103.9179216416105, 4146.315857883415, 5701.315842098975, 5713.371529131792, 5734.541236701138, 5741.88516229673, 5771.913421298684, 5970.49250813677, 6013.789517366871, 6057.363976782374, 6059.787907423219, 6060.363661815534, 5583.972080139573, 5730.111832665943, 5734.9390362783015, 5766.163906233573, 5797.536197104221, 5146.897062058738, 5156.484351564814, 5157.510036546522, 5161.174212126117, 5170.767315470813, 6297.559170858088, 6299.401556852092, 6303.46420554258, 6305.274893387227, 6314.210723659543, 5872.442117998783, 5937.554683398676, 5998.790042348497, 6008.188894499187, 6050.183225264533, 6253.5622506424115, 6257.843553911189, 6299.622022678654, 6300.653464059521, 6306.747730090929, 5922.496587790086, 5943.078822782476, 5946.018906880489, 5952.553558483044, 5981.162637230878, 5758.1650660654805, 6013.548983826143, 6042.123892035718, 6092.512598992159, 6105.267367915879, 5692.601517893873, 5708.743106560298, 5712.228849105318, 5727.6849773262875, 5741.799037033684, 5615.101583746744, 5667.40492248308, 5670.319561652463, 5697.4302569742695, 5704.458076482728, 5534.889302213853, 5731.111677689964, 5782.710864456844, 5811.593188476766, 5818.912716309174, 5893.705314734332, 5931.822045338647, 5938.495227905676, 5941.673207973603, 5952.940470595238, 5809.2738407699035, 5816.883662326814, 5823.912641310469, 5824.039033559416, 5834.970825145847], "value": 5509.374495502781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.3875104279583, 673.3199468536776, 678.8065401360611, 679.2053297641759, 746.2612014106037, 33133.50299745503, 34224.0, 34239.4864077039, 34262.14344641382, 40280.79859600705, 43806.780966095204, 44320.11359772811, 44350.11299774003, 44384.55615443845, 44390.556094439045, 8974.910250897488, 9072.0, 9154.084591540826, 9161.587728552198, 9161.587728552231, 7932.048154221501, 8948.686795962143, 10803.83794243087, 11053.723656908562, 11062.723431914226, 11073.0, 11126.777464450706, 11210.66368008961, 11226.270292431007, 11235.438228088562, 10955.068819150381, 11005.394703291317, 11009.119270458345, 11023.83464248037, 11028.834567481494, 10882.510287037023, 10998.285111467729, 11003.33979961205, 11003.449827508593, 11012.669619911416, 43996.780016099714, 44377.55622443799, 44428.3335749964, 44440.55559444429, 44515.77421128963, 3855.226595765951, 3943.38877473992, 4074.022234663659, 4322.394864718942, 4605.608523275526, 33690.663093368996, 34158.48762268568, 34176.658233417846, 34389.0, 34456.48315275273, 4303.74177549348, 4437.622802061796, 4475.149721552894, 4486.798094085774, 4498.572635599613, 340146.0, 340476.0, 340618.0, 342093.0, 342695.0, 40917.590824091974, 41506.37740433896, 65599.67200163969, 66185.6690716553, 66281.33718662849, 39501.60498395037, 39513.209735805125, 39660.2067958645, 39663.0, 39682.80158599246, 17198.65602687939, 17400.39098631542, 17414.303427862997, 17422.825771742122, 17430.47708568745, 13555.457781688621, 14665.48670796517, 14732.116073035651, 14736.705265894621, 14738.11571305725, 9324.8601270981, 9501.334906556474, 9548.42709437436, 9570.33007689469, 9588.232941364675, 3531.205478767257, 3535.3106144301614, 3582.802945838004, 3626.9274614507563, 3653.6529029742132, 1131.6944425005202, 1139.3107170161932, 1142.959906485111, 1201.3872924808236, 1213.3084142038954, 32879.83560082232, 33027.0, 33580.0, 33659.0, 34251.314973700384, 1213.6905089202196, 1257.352463481308, 1287.9678008049873, 1297.3479654771788, 1317.7876353754377, 17752.822471775376, 17761.46715598534, 17935.641287174443, 18041.639167216843, 18160.818391816178, 513767.0, 514076.0, 520097.0, 521006.0, 521024.0, 62903.37096629067, 63597.68201158965, 63947.68026159839, 63960.68019659872, 64007.67996160083, 1321.8215540901856, 1489.1958342495147, 1519.5821149184062, 1537.223702030445, 1609.251697960454, 29876.0, 31860.203494911886, 32576.674233257363, 32796.672033280316, 32877.50683739794, 50905.74547127241, 51321.23018154805, 51332.48667513277, 51371.48628513667, 51376.48623513866, 296881.0, 302255.0, 304735.0, 304822.0, 304922.0, 28146.29634259078, 31334.216644584067, 31755.523667145473, 31847.68152318447, 32258.0, 46169.307460388794, 46662.066758665314, 46838.53161468478, 47098.0, 47452.28821567748, 38898.4165237516, 41221.58778412177, 41376.0, 41487.0, 41783.7910810444, 39468.60531394649, 39683.0, 40582.0, 41617.37573936333, 41747.373789393794, 42043.0, 42360.0, 42730.35904461373, 42821.785891071595, 42920.570794291656, 35002.474962875065, 35889.0, 37130.628693712715, 37297.440538391405, 37510.62489375071, 28028.85985570141, 28109.297267568476, 28308.292292692022, 28536.714632853407, 28830.423391532473], "value": 19888.493794930873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.4188210858471, 410.730971213855, 429.606909677645, 433.7007464849255, 438.9692721509494, 19701.113449894754, 19843.20627174915, 20239.491908856424, 20452.590948181027, 20469.078891449884, 18841.62316753664, 19213.61572768544, 19773.110210040548, 19791.0, 19798.208071677116, 5554.527865131468, 5570.693611851357, 5837.532997360222, 5845.357010728816, 5847.619904706181, 4155.563665815092, 5725.914111288334, 5774.913376299338, 6240.906386404185, 6582.769603063894, 6539.182602174728, 6540.215174179105, 6557.573757705758, 6580.045893345486, 6584.111144995436, 6259.843503912393, 6427.614343139427, 6488.31872653374, 6490.448311893495, 6492.156019717407, 3781.659650631429, 3917.5690674025836, 5594.328680558359, 5782.56630752691, 5794.449527294901, 22114.557708845732, 22432.0, 22558.661620075713, 22753.317400478012, 22825.885870570706, 2490.116008816862, 2501.9874900625564, 2593.623924530951, 2668.5730283154794, 2691.3137150026814, 13839.238841863693, 14026.228557429336, 14234.644133896632, 14647.560573182822, 14945.626359340995, 2056.187805816694, 2116.714243577113, 2122.1299267300333, 2161.5892980333842, 2185.278857976864, 75099.0, 75522.99999999945, 75591.0, 76400.0, 77115.22884771136, 10641.467926603638, 10742.89257107419, 10955.50700218492, 11210.271332363533, 11372.601958931398, 15640.687186256211, 15855.445059422866, 15864.841351586567, 15872.841271587136, 15916.283767230503, 8929.196372326522, 8980.595873185723, 9107.590158442754, 9140.223081038186, 9175.58709858058, 8977.371583989057, 9078.0, 9139.81720365589, 9182.219511341476, 9244.075592440702, 6776.424003959719, 6867.244603093655, 6966.965165174243, 7050.964745176241, 7133.357997780121, 1826.3151318255655, 1907.8473722102199, 1928.0237756299905, 1974.2004488182308, 1974.6248212839514, 1046.8325067989085, 1114.6488856010492, 1123.8258069999163, 1229.59423390281, 1231.0, 17487.737683934753, 18973.43079707611, 19610.411687649394, 19838.107285171915, 20359.08384122718, 1091.2252300866314, 1100.3782862682558, 1122.119136477861, 1195.1813008089487, 1195.647284051207, 11271.04196143337, 11292.322460652387, 11467.483963221675, 11532.94233528827, 11542.538298468135, 500193.0, 506071.0, 507910.0, 508020.0, 551145.0, 76608.0, 78719.60640196876, 79175.0, 79582.0, 79644.6017769919, 1126.808442564766, 1142.5886680794906, 1142.7428828513519, 1143.5082914346744, 1167.4046236419488, 17187.0, 17458.0, 17660.0, 17727.911360443115, 18029.188686509402, 35069.0, 35966.820165899, 36327.0, 37041.81479092587, 37566.43650345192, 49170.508294916595, 50802.0, 50856.237156441945, 51199.0, 51687.0, 8308.5430301334, 8458.450200736932, 8564.0, 8595.398322117391, 9037.774055648399, 8200.466969646954, 12610.67587903257, 12958.0, 13120.212787232796, 13640.86359136396, 10642.361458312525, 11142.220044596801, 11221.438928053727, 11292.209545332076, 11606.0, 11085.067145120343, 11187.160962927976, 11322.433878306216, 11504.94247528757, 11541.249818761753, 11061.612843550438, 11365.488553015299, 11469.139814513777, 11483.138764592522, 11606.593769218036, 8503.659853606034, 8533.104024077382, 8574.31405487572, 8575.356848236283, 8700.825983480421, 11625.302481851117, 11840.23038502529, 11866.703332416413, 12060.0, 12167.087468440079], "value": 9561.398434951067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.6554426937525, 1596.872250219982, 1598.0651318978396, 1813.8730288879783, 1945.2219112355056, 7529.09650841899, 8221.958890205548, 8425.199606037431, 8442.197991190827, 8453.365997550185, 8364.623591938362, 8396.538190399526, 8450.535220562866, 8456.0, 8461.153884611536, 2425.5148970205987, 2449.3876530867283, 2449.963250551234, 2452.3010941881566, 2454.877256137186, 2346.6480027995767, 2389.23544465771, 2391.712994440661, 2394.1979436888664, 2408.229366602688, 2448.8163387745903, 2481.4044629288933, 2484.403743101652, 2490.9377265568323, 2503.8622875741917, 2421.9273421797197, 2424.818138639609, 2431.768981946721, 2438.7317395086525, 2472.2336075816556, 2402.039184326266, 2457.8402403843693, 2463.3718401807423, 2464.876756162185, 2466.161505088279, 8300.750977470685, 8458.0, 8516.318694504425, 8519.105493923173, 8526.914730852674, 5364.222187782789, 5471.890562188734, 5487.0, 5487.780488780444, 5489.094299440588, 3565.1265439967115, 3583.157957879896, 3595.5865075516126, 3654.214343916071, 3752.137008488036, 1211.5396149463147, 1215.6778453709774, 1277.4698500122438, 1284.2230450577454, 1295.8250636164187, 11521.654350369503, 11726.648200553997, 12010.879891200977, 12047.156699031071, 12060.517579296818, 4637.652176086807, 4746.928796068062, 4758.595519380891, 4795.232762757942, 4817.494163112893, 9599.32804703664, 9602.279829012852, 9642.517874106266, 9679.854802177973, 9699.951500242594, 5404.594655400861, 5442.8911421771345, 5443.755031023614, 5444.292242008513, 5447.291852059287, 4287.57124287575, 4892.779824907888, 4995.825146119869, 5020.874478138003, 5041.823536176216, 4137.2552940470405, 4179.390934490243, 4239.851605193803, 4259.0, 4270.572942705767, 1354.525915929417, 1376.6902446949357, 1399.3003498250876, 1407.27525324458, 1413.1521087347714, 912.3613470570627, 1051.1748277602046, 1080.6541906589973, 1082.1775450657558, 1088.3796236145479, 5617.9438205618235, 5882.3529411764675, 5909.645421274738, 5931.73307201177, 6251.093591429309, 478.04868312058755, 482.85031640191653, 482.9010052939139, 499.7026769072396, 1089.7874914391775, 3992.2215168042535, 4003.979980100081, 4131.256373852735, 4141.544430112685, 4163.063310755056, 9995.850062249072, 10118.038786315288, 10195.133413659922, 10240.0, 10276.229282803819, 10080.495975201356, 10103.545340459697, 10109.64616238428, 10117.241206909512, 10131.0, 7749.845003100019, 7917.485363451472, 8038.477498962548, 8187.754367368989, 8202.17978202175, 5921.851953701192, 5943.078822782476, 6005.7297421617, 6063.518802953015, 6075.939240607538, 9289.953550232205, 9351.485668288038, 9500.192483638968, 9554.28342874301, 9561.378510396802, 9375.859362109437, 9704.75738106553, 9708.563114659999, 9749.415035097916, 9915.504224788587, 6512.153420055362, 7052.612106334201, 7262.745803896838, 7306.0, 7412.481126321106, 8149.633266502903, 8193.0, 8202.466839655403, 8233.38249631268, 8247.175282471704, 7114.964425177841, 7252.601106939169, 7304.452166087458, 7422.146453157956, 7434.107907051189, 7136.821579460555, 7191.3887319578425, 7218.675159617935, 7225.747098851515, 7301.488895777245, 6705.932940670531, 6756.898646520404, 6825.761098361732, 6884.380405763505, 6890.586564806128, 5078.542931136216, 5102.540771330449, 5142.460041695568, 5195.636305458733, 5225.973870130625, 5060.266261392151, 5144.485551444825, 5213.296205012426, 5261.947380526146, 5397.919031214614], "value": 4595.265590979455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.6546052138643, 357.2693841094961, 358.98205089745517, 361.6221049003791, 362.1706292589969, 6128.57100003, 6132.478739307165, 6133.417325354084, 6134.815955521331, 6225.035119556464, 5769.278840144982, 5891.823245302648, 5975.282966044081, 6026.668533230671, 6084.421979911901, 4663.417072865892, 4693.296005599171, 4696.342512048316, 4697.88255293617, 4706.670533062678, 4675.345451636774, 4684.461286951993, 4698.7885545150375, 4698.976505117486, 4714.198586240347, 4495.820167193325, 4578.65660075494, 4596.149712303235, 4712.622990160796, 4717.245240761479, 4693.483716791185, 4710.152172608929, 4712.929306060412, 4719.90560188796, 4724.220503616916, 4177.791110444466, 4183.184279065584, 4183.477065366829, 4189.350650649154, 4196.034911970233, 5851.795187168471, 5861.912071318934, 5867.413258674099, 5868.4718375346, 5869.823905282806, 5481.040817856859, 5483.670979741229, 5485.862853428656, 5485.917711234335, 5500.559955203574, 6215.533834962351, 6392.776252831175, 6400.4559612432995, 6406.423421892052, 6412.326705695881, 4496.190685676577, 4500.8649740507835, 4520.4575450946095, 4524.11779702958, 4536.432945881765, 6648.135742353512, 6681.5656982296, 6700.39696427319, 6718.227403848522, 6728.798136055926, 4605.378273933044, 4611.746353950565, 4614.76926153691, 4619.122366750306, 4624.1445332613575, 4658.557437043475, 4660.557247061523, 4666.556677115668, 4667.276572131325, 4669.182892993713, 5269.394019687708, 5366.409694933554, 5370.194470829407, 5373.7581808818695, 5392.379876314196, 6407.615543067431, 6437.485001199892, 6455.548111632234, 6458.806235812933, 6473.417392434703, 1540.653352995567, 1614.5802091456305, 1629.380835282585, 1632.9183540822912, 1634.3380930723076, 1057.2810488867644, 1082.7942690888863, 1088.8366744988316, 1089.7112265249716, 1095.386583513235, 6180.7527698891545, 6186.845328866814, 6210.937890621126, 6218.036204388327, 6235.750569977241, 6582.473402127818, 6589.835254118685, 6590.143281373391, 6596.076549283104, 6598.208215014229, 6242.406971337716, 6242.719077641517, 6244.843878903063, 6248.156498872685, 6250.718717657716, 3517.472379143149, 3554.413521768879, 3557.5197348358156, 3558.217192217708, 3560.928781424357, 6775.085363475868, 6847.109875716125, 6858.142732158481, 7037.542559733601, 7039.54242974205, 6803.829904252433, 6840.281770414134, 6840.3501667341525, 6851.520393572502, 6859.382655560924, 6958.095447591781, 6993.160820701549, 7006.4745144114395, 7006.894896576556, 7012.0533727947095, 6732.932670673231, 6734.124563806674, 6739.898901516579, 6745.86508269822, 6755.831104222434, 6502.154719886385, 6618.63597502142, 6644.90032649501, 6656.800295991128, 6657.1345725055435, 6943.854264046578, 6965.268646792217, 6972.895406568804, 6993.545419547713, 7004.229534751275, 4508.977455112835, 4532.048269863366, 4543.341215523797, 4554.749488778149, 4561.657875659273, 6694.866102677822, 6698.430633396216, 6706.094677218513, 6709.094272273181, 6709.832254193684, 6197.504199664107, 6296.653684047421, 6314.210723659543, 6477.740890364521, 6499.935000649933, 6466.224053113657, 6497.707603157774, 6502.057201705632, 6502.772402965874, 6504.577202481823, 6385.393387628168, 6393.041043843461, 6397.744090236339, 6402.263739669997, 6405.775797847053, 6493.610383376824, 6550.6069635820095, 6554.573952693059, 6559.311272316529, 6562.80311590653, 6179.505639548735, 6331.778387756591, 6339.397757213057, 6399.976003839363, 6411.294757576756], "value": 4890.9508058475085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.335198656967, 923.736735030516, 940.2571968145165, 947.1664934857324, 950.1923365139628, 13957.09278896871, 14214.71570568588, 14257.71484570308, 14258.358373873174, 14281.50014749484, 14143.575692729235, 14231.78652320216, 14298.356573954172, 14308.57074287773, 14312.642183945407, 724.1274264511264, 901.2159421303476, 918.8208299381623, 920.9769755756126, 923.7598224461622, 894.1639567004838, 899.029048627484, 902.0888902208751, 902.3593248793364, 902.3953950852945, 960.490939801906, 973.1144658360857, 973.2846357926918, 973.7224890906093, 975.3124047546463, 769.638270013093, 936.3211671538114, 947.7772723409993, 951.7477868364889, 954.065016284042, 693.4452438049591, 693.8993845892318, 694.350782018809, 694.8506071194718, 699.7166147710135, 15166.393344266216, 15289.770653440208, 15313.0, 15317.31072101758, 15330.0, 14940.178290194035, 15036.819661149182, 15177.696446071017, 15218.163001034938, 15318.770218446733, 11730.765384692344, 11779.116566257566, 12025.278483290944, 12083.758324833454, 12088.879111208864, 3937.6652984496354, 3999.960000399988, 4002.939955900664, 4019.77891215983, 4046.089629833293, 53442.46557534414, 54604.72697636526, 54704.45295547073, 54743.726281368734, 55510.44489555093, 11432.199746017699, 11532.962033417032, 11730.70673233159, 11772.293662380285, 11796.52813887452, 19750.11124499401, 20062.598748024957, 20100.497487562636, 20102.497437563885, 20130.295439659836, 8713.0, 8761.824763504694, 8860.202581767671, 8870.0, 8903.154200350957, 4825.638077144228, 4863.732494712754, 4888.535589119028, 4892.437369702458, 4899.559039686445, 3850.0759817644125, 3966.087799806061, 3977.7016723745833, 3992.061865461614, 3997.360422332413, 646.8997305417668, 690.6443181761397, 732.6739600877664, 753.4198667026468, 758.624480881967, 808.5068108453838, 828.1635548096466, 833.0919297965247, 844.6072576252072, 852.7527017165077, 9767.0, 9839.0, 10154.847677284846, 10275.537600807982, 10308.742281442874, 626.1671976271548, 626.5614070150913, 628.2272804450461, 703.2299631903059, 725.4559080689482, 4265.701400901907, 4269.295566231599, 4274.935875961863, 4336.50130235027, 4351.586599273127, 66974.66512667405, 67172.664136679, 67375.32624673788, 67725.66137169283, 67817.66091169513, 56848.0, 57252.0, 57457.425425745205, 57588.42411575831, 57746.422535774946, 52675.47324526782, 53004.46995530072, 53228.201576976375, 53335.46664533305, 53426.73286633542, 8142.145074767064, 8340.749777506684, 8356.080831108451, 8368.874466883124, 8446.957765211135, 40175.1964960705, 40308.798456007535, 40325.79837100796, 41118.38322425106, 41743.0, 46525.767371162925, 46617.76691116523, 51093.23360149527, 52021.7398913003, 52499.73750131225, 12051.276923384625, 12067.879321206676, 12199.085068619712, 12320.322382269062, 12440.75118497643, 12583.685407864876, 13034.022448316224, 13219.735605288033, 13247.536336228572, 13834.515791947233, 12662.810057849323, 12928.935355323163, 12930.288834113837, 12956.28740419286, 13359.332033398097, 12083.939580302042, 12094.395280235776, 12140.75718485643, 12188.20776649515, 12216.877831221575, 12297.815532767194, 12348.506059757508, 12419.93790031044, 12487.0, 12541.561045363369, 10008.39949603026, 10177.49112544355, 10419.270651054354, 10493.0, 10512.369257844553, 10353.482325883826, 10357.844632330673, 10396.0, 10411.94794026025, 10447.111995480469], "value": 7102.415995941318, "unit": "score"}], "name": "dromaeo_css", "value": 7422.710391321318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 110.0, 111.0, 111.0, 111.0, 104.0, 110.0, 112.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 149.0, 174.0, 127.0, 162.0, 165.0, 130.0, 180.0, 127.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 168.0, 76.0, 76.0, 76.0, 76.0, 163.0, 73.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 91.0, 92.0, 93.0, 153.0, 91.0, 91.0, 145.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 54.0, 54.0, 55.0, 55.0, 56.0, 96.0, 53.0, 53.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 72.0, 73.0, 73.0, 72.0, 80.0, 72.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 110.0, 113.0, 116.0, 117.0, 125.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 156.0, 159.0, 160.0, 158.0, 156.0, 157.0, 157.0, 156.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 68.0, 64.0, 66.0, 65.0, 67.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1506.5, "alertThreshold": 2.0}]} 08:16:30 INFO - Return code: 0 08:16:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:30 ERROR - # TBPL SUCCESS # 08:16:30 INFO - Running post-action listener: _resource_record_post_action 08:16:30 INFO - Running post-run listener: _resource_record_post_run 08:16:31 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 453058560; Read time: 184; Write time: 349660 08:16:31 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241737728; Read time: 0; Write time: 231916 08:16:31 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 210952192; Read time: 184; Write time: 117720 08:16:31 INFO - Running post-run listener: _upload_blobber_files 08:16:31 INFO - Blob upload gear active. 08:16:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:16:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:31 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:16:31 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:16:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:33 INFO - (blobuploader) - INFO - Done attempting. 08:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:33 INFO - (blobuploader) - INFO - Done attempting. 08:16:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:33 INFO - Return code: 0 08:16:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:16:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4785645ef0d49a32272dc70f12089acacc005d0c5e3074a153fbba20ec456d0ed16d848f65783ef89af898241ec269e2557812bb3242e956636dfe5bf79eb303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c8baf8219cb55885d4c2afb37c93b0695b9bd0ea01d49e5f71ed8d3a5961a1c03d78e1ad5f4eaee5d0c3ba0e17c6324245b5ab610e32e2ea47b5241af1664f0"} 08:16:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:16:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:16:33 INFO - Contents: 08:16:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4785645ef0d49a32272dc70f12089acacc005d0c5e3074a153fbba20ec456d0ed16d848f65783ef89af898241ec269e2557812bb3242e956636dfe5bf79eb303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c8baf8219cb55885d4c2afb37c93b0695b9bd0ea01d49e5f71ed8d3a5961a1c03d78e1ad5f4eaee5d0c3ba0e17c6324245b5ab610e32e2ea47b5241af1664f0"} 08:16:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:33 INFO - Copying logs to upload dir... 08:16:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:16:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.256199 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-21 08:16:33.904014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:33.907883) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4785645ef0d49a32272dc70f12089acacc005d0c5e3074a153fbba20ec456d0ed16d848f65783ef89af898241ec269e2557812bb3242e956636dfe5bf79eb303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c8baf8219cb55885d4c2afb37c93b0695b9bd0ea01d49e5f71ed8d3a5961a1c03d78e1ad5f4eaee5d0c3ba0e17c6324245b5ab610e32e2ea47b5241af1664f0"} build_url:https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/ImADQN8BRxu8zJ1SOcj-GA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4785645ef0d49a32272dc70f12089acacc005d0c5e3074a153fbba20ec456d0ed16d848f65783ef89af898241ec269e2557812bb3242e956636dfe5bf79eb303", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c8baf8219cb55885d4c2afb37c93b0695b9bd0ea01d49e5f71ed8d3a5961a1c03d78e1ad5f4eaee5d0c3ba0e17c6324245b5ab610e32e2ea47b5241af1664f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:33.934393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:33.934726) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469112647.389047-571873414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:16:34.016979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:16:34.017356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:16:34.017846) ========= ========= Total master_lag: 0.18 =========