builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1464376833.52 results: success (0) buildid: 20160527093441 builduid: 2f62a19f8076409f813b3fc4e7ccef8c revision: 9d87d3a279a08ac507dda94c36d5a12185fea4a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.517314) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.517786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.518113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.542733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.543012) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 12:20:34-- 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% 223M=0s 2016-05-27 12:20:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083286 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.654750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.655056) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.703860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:33.704173) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9d87d3a279a08ac507dda94c36d5a12185fea4a6 --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-aurora --rev 9d87d3a279a08ac507dda94c36d5a12185fea4a6 --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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 12:20:34,254 truncating revision to first 12 chars 2016-05-27 12:20:34,254 Setting DEBUG logging. 2016-05-27 12:20:34,254 attempt 1/10 2016-05-27 12:20:34,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9d87d3a279a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 12:20:34,602 unpacking tar archive at: mozilla-aurora-9d87d3a279a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:34.401899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:34.402208) ========= script_repo_revision: 9d87d3a279a08ac507dda94c36d5a12185fea4a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:34.402625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:34.402892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 12:20:34.410614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 12:20:34.410882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:20:35 INFO - MultiFileLogger online at 20160527 12:20:35 in /builds/slave/test 12:20:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:20:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:35 INFO - {'append_to_log': False, 12:20:35 INFO - 'base_work_dir': '/builds/slave/test', 12:20:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:20:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:35 INFO - 'branch': 'Mozilla-Aurora', 12:20:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:35 INFO - 'config_files': ('talos/linux_config.py',), 12:20:35 INFO - 'default_actions': ('clobber', 12:20:35 INFO - 'read-buildbot-config', 12:20:35 INFO - 'download-and-extract', 12:20:35 INFO - 'populate-webroot', 12:20:35 INFO - 'create-virtualenv', 12:20:35 INFO - 'install', 12:20:35 INFO - 'run-tests'), 12:20:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:35 INFO - 'download_minidump_stackwalk': True, 12:20:35 INFO - 'download_symbols': 'ondemand', 12:20:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:20:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:20:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:20:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:20:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:35 INFO - 'installer_path': 'installer.exe', 12:20:35 INFO - 'log_level': 'info', 12:20:35 INFO - 'log_name': 'talos', 12:20:35 INFO - 'log_to_console': True, 12:20:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:20:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:20:35 INFO - 'opt_config_files': (), 12:20:35 INFO - 'pip_index': False, 12:20:35 INFO - 'sps_profile': False, 12:20:35 INFO - 'sps_profile_interval': 0, 12:20:35 INFO - 'suite': 'dromaeojs', 12:20:35 INFO - 'system_bits': '32', 12:20:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:35 INFO - 'title': 'talos-linux64-ix-037', 12:20:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:35 INFO - 'use_talos_json': True, 12:20:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:35 INFO - 'work_dir': 'build'} 12:20:35 INFO - ##### 12:20:35 INFO - ##### Running clobber step. 12:20:35 INFO - ##### 12:20:35 INFO - Running pre-action listener: _resource_record_pre_action 12:20:35 INFO - Running main action method: clobber 12:20:35 INFO - rmtree: /builds/slave/test/build 12:20:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:20:36 INFO - Running post-action listener: _resource_record_post_action 12:20:36 INFO - ##### 12:20:36 INFO - ##### Running read-buildbot-config step. 12:20:36 INFO - ##### 12:20:36 INFO - Running pre-action listener: _resource_record_pre_action 12:20:36 INFO - Running main action method: read_buildbot_config 12:20:36 INFO - Using buildbot properties: 12:20:36 INFO - { 12:20:36 INFO - "project": "", 12:20:36 INFO - "product": "firefox", 12:20:36 INFO - "script_repo_revision": "production", 12:20:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:20:36 INFO - "repository": "", 12:20:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:20:36 INFO - "buildid": "20160527093441", 12:20:36 INFO - "pgo_build": "True", 12:20:36 INFO - "basedir": "/builds/slave/test", 12:20:36 INFO - "buildnumber": 346, 12:20:36 INFO - "slavename": "talos-linux64-ix-037", 12:20:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:20:36 INFO - "platform": "ubuntu64_hw", 12:20:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:20:36 INFO - "branch": "mozilla-aurora", 12:20:36 INFO - "repo_path": "releases/mozilla-aurora", 12:20:36 INFO - "revision": "9d87d3a279a08ac507dda94c36d5a12185fea4a6", 12:20:36 INFO - "stage_platform": "linux64-pgo", 12:20:36 INFO - "builduid": "2f62a19f8076409f813b3fc4e7ccef8c", 12:20:36 INFO - "slavebuilddir": "test" 12:20:36 INFO - } 12:20:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 12:20:36 INFO - Running post-action listener: _resource_record_post_action 12:20:36 INFO - ##### 12:20:36 INFO - ##### Running download-and-extract step. 12:20:36 INFO - ##### 12:20:36 INFO - Running pre-action listener: _resource_record_pre_action 12:20:36 INFO - Running main action method: download_and_extract 12:20:36 INFO - mkdir: /builds/slave/test/build/tests 12:20: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')]} 12:20:36 INFO - https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:20:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:20:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:20:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:20:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:20:37 INFO - Downloaded 1361 bytes. 12:20:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:20:37 INFO - Using the following test package requirements: 12:20:37 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:20:37 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:20:37 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:20:37 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'jsshell-linux-x86_64.zip'], 12:20:37 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:20:37 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:20:37 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:20:37 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:20:37 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:20:37 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:20:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:20:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:37 INFO - https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:20:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:20:39 INFO - Downloaded 24136545 bytes. 12:20:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:20:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:20:40 INFO - Return code: 0 12:20:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:20: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')]} 12:20:40 INFO - https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:21:00 INFO - Downloaded 24136545 bytes. 12:21:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:21:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:21:01 INFO - Return code: 0 12:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:01 INFO - https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:21:02 INFO - Downloaded 10840145 bytes. 12:21:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:21:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:21:02 INFO - Return code: 0 12:21:02 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')]} 12:21:02 INFO - https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:21:05 INFO - Downloaded 62768252 bytes. 12:21:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:21:05 INFO - mkdir: /builds/slave/test/properties 12:21:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:21:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:21:05 INFO - Contents: 12:21:05 INFO - build_url:https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:21:06 INFO - Running post-action listener: _resource_record_post_action 12:21:06 INFO - Running post-action listener: set_extra_try_arguments 12:21:06 INFO - ##### 12:21:06 INFO - ##### Running populate-webroot step. 12:21:06 INFO - ##### 12:21:06 INFO - Running pre-action listener: _resource_record_pre_action 12:21:06 INFO - Running main action method: populate_webroot 12:21:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:21:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:21:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:21:06 INFO - '--tppagecycles', 12:21:06 INFO - '7'], 12:21:06 INFO - 'tests': ['tsvgm']}}, 12:21:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:21:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:21:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:21:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:21:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['damp', 'tps']}, 12:21:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'tests': ['damp', 'tps']}, 12:21:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['dromaeo_dom']}, 12:21:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:21:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['a11yr', 12:21:06 INFO - 'ts_paint', 12:21:06 INFO - 'tpaint', 12:21:06 INFO - 'sessionrestore', 12:21:06 INFO - 'sessionrestore_no_auto_restore', 12:21:06 INFO - 'tabpaint']}, 12:21:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['tsvgx', 12:21:06 INFO - 'tsvgr_opacity', 12:21:06 INFO - 'tart', 12:21:06 INFO - 'tscrollx', 12:21:06 INFO - 'cart']}, 12:21:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:21:06 INFO - 'tsvgr_opacity', 12:21:06 INFO - 'tart', 12:21:06 INFO - 'tscrollx', 12:21:06 INFO - 'cart']}, 12:21:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'talos_options': ['--disable-e10s'], 12:21:06 INFO - 'tests': ['tp5o']}, 12:21:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'tests': ['tp5o']}, 12:21:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'talos_options': ['--disable-e10s', 12:21:06 INFO - '--xperf_path', 12:21:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:06 INFO - 'tests': ['tp5n']}, 12:21:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:06 INFO - 'talos_options': ['--xperf_path', 12:21:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:06 INFO - 'tests': ['tp5n']}}, 12:21:06 INFO - 'talos.zip': {'path': '', 12:21:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:21:06 INFO - Running post-action listener: _resource_record_post_action 12:21:06 INFO - ##### 12:21:06 INFO - ##### Running create-virtualenv step. 12:21:06 INFO - ##### 12:21:06 INFO - Running pre-action listener: _resource_record_pre_action 12:21:06 INFO - Running main action method: create_virtualenv 12:21:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:21:06 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 12:21:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:21:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:21:06 INFO - Using real prefix '/usr' 12:21:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:21:08 INFO - Installing pip.................done. 12:21:08 INFO - Return code: 0 12:21:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:08 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:08 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 12:21:08 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 12:21:08 INFO - Using env: {'DISPLAY': ':0', 12:21:08 INFO - 'HOME': '/home/cltbld', 12:21:08 INFO - 'LANG': 'en_US.UTF-8', 12:21:08 INFO - 'LANGUAGE': 'en_US:en', 12:21:08 INFO - 'LOGNAME': 'cltbld', 12:21:08 INFO - 'MAIL': '/var/mail/cltbld', 12:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:08 INFO - 'MOZ_NO_REMOTE': '1', 12:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:08 INFO - 'NO_EM_RESTART': '1', 12:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:08 INFO - 'PWD': '/builds/slave/test', 12:21:08 INFO - 'SHELL': '/bin/bash', 12:21:08 INFO - 'SHLVL': '1', 12:21:08 INFO - 'TERM': 'linux', 12:21:08 INFO - 'TMOUT': '86400', 12:21:08 INFO - 'USER': 'cltbld', 12:21:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:08 INFO - '_': '/tools/buildbot/bin/python'} 12:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:08 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 12:21:08 INFO - Cleaning up... 12:21:08 INFO - Return code: 0 12:21:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:08 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:08 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 12:21:08 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 12:21:08 INFO - Using env: {'DISPLAY': ':0', 12:21:08 INFO - 'HOME': '/home/cltbld', 12:21:08 INFO - 'LANG': 'en_US.UTF-8', 12:21:08 INFO - 'LANGUAGE': 'en_US:en', 12:21:08 INFO - 'LOGNAME': 'cltbld', 12:21:08 INFO - 'MAIL': '/var/mail/cltbld', 12:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:08 INFO - 'MOZ_NO_REMOTE': '1', 12:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:08 INFO - 'NO_EM_RESTART': '1', 12:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:08 INFO - 'PWD': '/builds/slave/test', 12:21:08 INFO - 'SHELL': '/bin/bash', 12:21:08 INFO - 'SHLVL': '1', 12:21:08 INFO - 'TERM': 'linux', 12:21:08 INFO - 'TMOUT': '86400', 12:21:08 INFO - 'USER': 'cltbld', 12:21:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:08 INFO - '_': '/tools/buildbot/bin/python'} 12:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:09 INFO - Downloading/unpacking psutil>=0.7.1 12:21:09 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 12:21:09 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 12:21:09 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 12:21:09 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 12:21:09 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 12:21:09 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 12:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:11 INFO - Installing collected packages: psutil 12:21:11 INFO - Running setup.py install for psutil 12:21:11 INFO - building 'psutil._psutil_linux' extension 12:21:11 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 12:21:11 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 12:21:11 INFO - building 'psutil._psutil_posix' extension 12:21:11 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 12:21:11 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 12:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:11 INFO - Successfully installed psutil 12:21:11 INFO - Cleaning up... 12:21:11 INFO - Return code: 0 12:21:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:11 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:11 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 12:21:11 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 12:21:11 INFO - Using env: {'DISPLAY': ':0', 12:21:11 INFO - 'HOME': '/home/cltbld', 12:21:11 INFO - 'LANG': 'en_US.UTF-8', 12:21:11 INFO - 'LANGUAGE': 'en_US:en', 12:21:11 INFO - 'LOGNAME': 'cltbld', 12:21:11 INFO - 'MAIL': '/var/mail/cltbld', 12:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:11 INFO - 'MOZ_NO_REMOTE': '1', 12:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:11 INFO - 'NO_EM_RESTART': '1', 12:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:11 INFO - 'PWD': '/builds/slave/test', 12:21:11 INFO - 'SHELL': '/bin/bash', 12:21:11 INFO - 'SHLVL': '1', 12:21:11 INFO - 'TERM': 'linux', 12:21:11 INFO - 'TMOUT': '86400', 12:21:11 INFO - 'USER': 'cltbld', 12:21:11 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:11 INFO - '_': '/tools/buildbot/bin/python'} 12:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:21:11 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 12:21:11 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 12:21:11 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 12:21:11 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 12:21:11 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 12:21:11 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 12:21:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:21:13 INFO - Installing collected packages: mozsystemmonitor 12:21:13 INFO - Running setup.py install for mozsystemmonitor 12:21:13 INFO - Successfully installed mozsystemmonitor 12:21:13 INFO - Cleaning up... 12:21:13 INFO - Return code: 0 12:21:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21:13 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')]} 12:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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')]} 12:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:13 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 12:21:13 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 12:21:13 INFO - Using env: {'DISPLAY': ':0', 12:21:13 INFO - 'HOME': '/home/cltbld', 12:21:13 INFO - 'LANG': 'en_US.UTF-8', 12:21:13 INFO - 'LANGUAGE': 'en_US:en', 12:21:13 INFO - 'LOGNAME': 'cltbld', 12:21:13 INFO - 'MAIL': '/var/mail/cltbld', 12:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:13 INFO - 'MOZ_NO_REMOTE': '1', 12:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:13 INFO - 'NO_EM_RESTART': '1', 12:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:13 INFO - 'PWD': '/builds/slave/test', 12:21:13 INFO - 'SHELL': '/bin/bash', 12:21:13 INFO - 'SHLVL': '1', 12:21:13 INFO - 'TERM': 'linux', 12:21:13 INFO - 'TMOUT': '86400', 12:21:13 INFO - 'USER': 'cltbld', 12:21:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:13 INFO - '_': '/tools/buildbot/bin/python'} 12:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:21:14 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 12:21:14 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 12:21:14 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 12:21:14 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 12:21:14 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 12:21:14 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 12:21:15 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 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 12:21:16 INFO - Downloading docopt-0.6.1.tar.gz 12:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:16 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:16 INFO - Running setup.py install for blobuploader 12:21:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:16 INFO - Running setup.py install for requests 12:21:17 INFO - Running setup.py install for docopt 12:21:17 INFO - Successfully installed blobuploader requests docopt 12:21:17 INFO - Cleaning up... 12:21:17 INFO - Return code: 0 12:21:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:17 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:17 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 12:21:17 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 12:21:17 INFO - Using env: {'DISPLAY': ':0', 12:21:17 INFO - 'HOME': '/home/cltbld', 12:21:17 INFO - 'LANG': 'en_US.UTF-8', 12:21:17 INFO - 'LANGUAGE': 'en_US:en', 12:21:17 INFO - 'LOGNAME': 'cltbld', 12:21:17 INFO - 'MAIL': '/var/mail/cltbld', 12:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:17 INFO - 'MOZ_NO_REMOTE': '1', 12:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:17 INFO - 'NO_EM_RESTART': '1', 12:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:17 INFO - 'PWD': '/builds/slave/test', 12:21:17 INFO - 'SHELL': '/bin/bash', 12:21:17 INFO - 'SHLVL': '1', 12:21:17 INFO - 'TERM': 'linux', 12:21:17 INFO - 'TMOUT': '86400', 12:21:17 INFO - 'USER': 'cltbld', 12:21:17 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:17 INFO - '_': '/tools/buildbot/bin/python'} 12:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:17 INFO - Running setup.py (path:/tmp/pip-bC685u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:17 INFO - Running setup.py (path:/tmp/pip-o7Ukmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:17 INFO - Running setup.py (path:/tmp/pip-Jqesjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:17 INFO - Running setup.py (path:/tmp/pip-S_5YQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:17 INFO - Running setup.py (path:/tmp/pip-XMEkJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:17 INFO - Running setup.py (path:/tmp/pip-pcevLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:17 INFO - Running setup.py (path:/tmp/pip-3F0TO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:18 INFO - Running setup.py (path:/tmp/pip-KZn70m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:18 INFO - Running setup.py (path:/tmp/pip-TbOMn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:18 INFO - Running setup.py (path:/tmp/pip-rT_1J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:18 INFO - Running setup.py (path:/tmp/pip-N1qH2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:18 INFO - Running setup.py (path:/tmp/pip-sAYA_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:18 INFO - Running setup.py (path:/tmp/pip-U5ABUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:18 INFO - Running setup.py (path:/tmp/pip-_4X0lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:18 INFO - Running setup.py (path:/tmp/pip-QHQmF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:18 INFO - Running setup.py (path:/tmp/pip-v5Zsw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:18 INFO - Running setup.py (path:/tmp/pip-Lqfz8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:18 INFO - Running setup.py install for manifestparser 12:21:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:18 INFO - Running setup.py install for mozcrash 12:21:18 INFO - Running setup.py install for mozdebug 12:21:19 INFO - Running setup.py install for mozdevice 12:21:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for mozfile 12:21:19 INFO - Running setup.py install for mozhttpd 12:21:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for mozinfo 12:21:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for mozInstall 12:21:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for mozleak 12:21:19 INFO - Running setup.py install for mozlog 12:21:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for moznetwork 12:21:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:19 INFO - Running setup.py install for mozprocess 12:21:20 INFO - Running setup.py install for mozprofile 12:21:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:20 INFO - Running setup.py install for mozrunner 12:21:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:20 INFO - Running setup.py install for mozscreenshot 12:21:20 INFO - Running setup.py install for moztest 12:21:20 INFO - Running setup.py install for mozversion 12:21:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:20 INFO - Cleaning up... 12:21:20 INFO - Return code: 0 12:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:20 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 12:21:20 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 12:21:20 INFO - Using env: {'DISPLAY': ':0', 12:21:20 INFO - 'HOME': '/home/cltbld', 12:21:20 INFO - 'LANG': 'en_US.UTF-8', 12:21:20 INFO - 'LANGUAGE': 'en_US:en', 12:21:20 INFO - 'LOGNAME': 'cltbld', 12:21:20 INFO - 'MAIL': '/var/mail/cltbld', 12:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:20 INFO - 'MOZ_NO_REMOTE': '1', 12:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:20 INFO - 'NO_EM_RESTART': '1', 12:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:20 INFO - 'PWD': '/builds/slave/test', 12:21:20 INFO - 'SHELL': '/bin/bash', 12:21:20 INFO - 'SHLVL': '1', 12:21:20 INFO - 'TERM': 'linux', 12:21:20 INFO - 'TMOUT': '86400', 12:21:20 INFO - 'USER': 'cltbld', 12:21:20 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:20 INFO - '_': '/tools/buildbot/bin/python'} 12:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:20 INFO - Running setup.py (path:/tmp/pip-ayDZGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:20 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)) 12:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:20 INFO - Running setup.py (path:/tmp/pip-bTfPl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:20 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)) 12:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:20 INFO - Running setup.py (path:/tmp/pip-YmZ1j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:21 INFO - Running setup.py (path:/tmp/pip-wb8f7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:21 INFO - Running setup.py (path:/tmp/pip-3MPKUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:21 INFO - Running setup.py (path:/tmp/pip-cOZqXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:21 INFO - Running setup.py (path:/tmp/pip-y0w31Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:21 INFO - Running setup.py (path:/tmp/pip-iqLNTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:21 INFO - Running setup.py (path:/tmp/pip-EEmSwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:21 INFO - Running setup.py (path:/tmp/pip-VWw2Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:21 INFO - Running setup.py (path:/tmp/pip-ZfeFL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:21 INFO - Running setup.py (path:/tmp/pip-llbf3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:21 INFO - Running setup.py (path:/tmp/pip-5AHxSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:21 INFO - Running setup.py (path:/tmp/pip-lt7SWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:21 INFO - Running setup.py (path:/tmp/pip-d4stO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:21 INFO - Running setup.py (path:/tmp/pip-XOyiAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:21 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)) 12:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:21 INFO - Running setup.py (path:/tmp/pip-7VBaiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:22 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)) 12:21:22 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)) 12:21:22 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)) 12:21:22 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)) 12:21:22 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)) 12:21:22 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)) 12:21:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21:22 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 12:21:22 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 12:21:22 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 12:21:22 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 12:21:22 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 12:21:22 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 12:21:23 INFO - Downloading blessings-1.6.tar.gz 12:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:23 INFO - Installing collected packages: blessings 12:21:23 INFO - Running setup.py install for blessings 12:21:24 INFO - Successfully installed blessings 12:21:24 INFO - Cleaning up... 12:21:24 INFO - Return code: 0 12:21:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:24 INFO - Reading from file tmpfile_stdout 12:21:24 INFO - Current package versions: 12:21:24 INFO - argparse == 1.2.1 12:21:24 INFO - blessings == 1.6 12:21:24 INFO - blobuploader == 1.2.4 12:21:24 INFO - docopt == 0.6.1 12:21:24 INFO - manifestparser == 1.1 12:21:24 INFO - mozInstall == 1.12 12:21:24 INFO - mozcrash == 0.17 12:21:24 INFO - mozdebug == 0.1 12:21:24 INFO - mozdevice == 0.48 12:21:24 INFO - mozfile == 1.2 12:21:24 INFO - mozhttpd == 0.7 12:21:24 INFO - mozinfo == 0.9 12:21:24 INFO - mozleak == 0.1 12:21:24 INFO - mozlog == 3.1 12:21:24 INFO - moznetwork == 0.27 12:21:24 INFO - mozprocess == 0.22 12:21:24 INFO - mozprofile == 0.28 12:21:24 INFO - mozrunner == 6.11 12:21:24 INFO - mozscreenshot == 0.1 12:21:24 INFO - mozsystemmonitor == 0.0 12:21:24 INFO - moztest == 0.7 12:21:24 INFO - mozversion == 1.4 12:21:24 INFO - psutil == 3.1.1 12:21:24 INFO - requests == 1.2.3 12:21:24 INFO - wsgiref == 0.1.2 12:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:24 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 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21:24 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 12:21:24 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 12:21:24 INFO - Using env: {'DISPLAY': ':0', 12:21:24 INFO - 'HOME': '/home/cltbld', 12:21:24 INFO - 'LANG': 'en_US.UTF-8', 12:21:24 INFO - 'LANGUAGE': 'en_US:en', 12:21:24 INFO - 'LOGNAME': 'cltbld', 12:21:24 INFO - 'MAIL': '/var/mail/cltbld', 12:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:24 INFO - 'MOZ_NO_REMOTE': '1', 12:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:24 INFO - 'NO_EM_RESTART': '1', 12:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:24 INFO - 'PWD': '/builds/slave/test', 12:21:24 INFO - 'SHELL': '/bin/bash', 12:21:24 INFO - 'SHLVL': '1', 12:21:24 INFO - 'TERM': 'linux', 12:21:24 INFO - 'TMOUT': '86400', 12:21:24 INFO - 'USER': 'cltbld', 12:21:24 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:24 INFO - '_': '/tools/buildbot/bin/python'} 12:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 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)) 12:21:24 INFO - Cleaning up... 12:21:24 INFO - Return code: 0 12:21:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21: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', 'jsonschema'] in /builds/slave/test/build 12:21: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 jsonschema 12:21:24 INFO - Using env: {'DISPLAY': ':0', 12:21:24 INFO - 'HOME': '/home/cltbld', 12:21:24 INFO - 'LANG': 'en_US.UTF-8', 12:21:24 INFO - 'LANGUAGE': 'en_US:en', 12:21:24 INFO - 'LOGNAME': 'cltbld', 12:21:24 INFO - 'MAIL': '/var/mail/cltbld', 12:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:24 INFO - 'MOZ_NO_REMOTE': '1', 12:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:24 INFO - 'NO_EM_RESTART': '1', 12:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:24 INFO - 'PWD': '/builds/slave/test', 12:21:24 INFO - 'SHELL': '/bin/bash', 12:21:24 INFO - 'SHLVL': '1', 12:21:24 INFO - 'TERM': 'linux', 12:21:24 INFO - 'TMOUT': '86400', 12:21:24 INFO - 'USER': 'cltbld', 12:21:24 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:24 INFO - '_': '/tools/buildbot/bin/python'} 12:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:24 INFO - Downloading/unpacking jsonschema 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:26 INFO - Downloading/unpacking functools32 (from jsonschema) 12:21:26 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 12:21:26 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 12:21:26 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 12:21:26 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 12:21:26 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 12:21:26 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 12:21:26 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:26 INFO - warning: no files found matching '*.txt' 12:21:26 INFO - no previously-included directories found matching 'build' 12:21:26 INFO - no previously-included directories found matching 'dist' 12:21:26 INFO - no previously-included directories found matching '.git*' 12:21:26 INFO - Installing collected packages: jsonschema, functools32 12:21:27 INFO - Running setup.py install for functools32 12:21:27 INFO - warning: no files found matching '*.txt' 12:21:27 INFO - no previously-included directories found matching 'build' 12:21:27 INFO - no previously-included directories found matching 'dist' 12:21:27 INFO - no previously-included directories found matching '.git*' 12:21:27 INFO - Successfully installed jsonschema functools32 12:21:27 INFO - Cleaning up... 12:21:27 INFO - Return code: 0 12:21:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1da164ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', '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 12:21: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', 'flake8'] in /builds/slave/test/build 12:21: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 flake8 12:21:27 INFO - Using env: {'DISPLAY': ':0', 12:21:27 INFO - 'HOME': '/home/cltbld', 12:21:27 INFO - 'LANG': 'en_US.UTF-8', 12:21:27 INFO - 'LANGUAGE': 'en_US:en', 12:21:27 INFO - 'LOGNAME': 'cltbld', 12:21:27 INFO - 'MAIL': '/var/mail/cltbld', 12:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:27 INFO - 'MOZ_NO_REMOTE': '1', 12:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:27 INFO - 'NO_EM_RESTART': '1', 12:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:27 INFO - 'PWD': '/builds/slave/test', 12:21:27 INFO - 'SHELL': '/bin/bash', 12:21:27 INFO - 'SHLVL': '1', 12:21:27 INFO - 'TERM': 'linux', 12:21:27 INFO - 'TMOUT': '86400', 12:21:27 INFO - 'USER': 'cltbld', 12:21:27 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:27 INFO - '_': '/tools/buildbot/bin/python'} 12:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:27 INFO - Downloading/unpacking flake8 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:21:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:21:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:21:29 INFO - no previously-included directories found matching 'docs/_build' 12:21:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:21:30 INFO - Running setup.py install for pep8 12:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:21:30 INFO - no previously-included directories found matching 'docs/_build' 12:21:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:21:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:21:30 INFO - Cleaning up... 12:21:30 INFO - Return code: 0 12:21:30 INFO - Running post-action listener: _resource_record_post_action 12:21:30 INFO - Running post-action listener: _start_resource_monitoring 12:21:30 INFO - Starting resource monitoring. 12:21:30 INFO - ##### 12:21:30 INFO - ##### Running install step. 12:21:30 INFO - ##### 12:21:30 INFO - Running pre-action listener: _resource_record_pre_action 12:21:30 INFO - Running main action method: install 12:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:30 INFO - Reading from file tmpfile_stdout 12:21:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:30 INFO - Reading from file tmpfile_stdout 12:21:30 INFO - Output received: 12:21:30 INFO - Usage: mozinstall [options] installer 12:21:30 INFO - Options: 12:21:30 INFO - -h, --help show this help message and exit 12:21:30 INFO - -d DEST, --destination=DEST 12:21:30 INFO - Directory to install application into. [default: 12:21:30 INFO - "/builds/slave/test"] 12:21:30 INFO - --app=APP Application being installed. [default: firefox] 12:21:30 INFO - mkdir: /builds/slave/test/build/application 12:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:21:46 INFO - Reading from file tmpfile_stdout 12:21:46 INFO - Output received: 12:21:46 INFO - /builds/slave/test/build/application/firefox/firefox 12:21:46 INFO - Running post-action listener: _resource_record_post_action 12:21:46 INFO - ##### 12:21:46 INFO - ##### Running run-tests step. 12:21:46 INFO - ##### 12:21:46 INFO - Running pre-action listener: _resource_record_pre_action 12:21:46 INFO - Running main action method: run_tests 12:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:46 INFO - Python 2.7.3 12:21:46 INFO - Return code: 0 12:21:46 INFO - grabbing minidump binary from tooltool 12:21:46 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')]} 12:21:46 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 0x2ae9640>, '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 0x2aea540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aea9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:46 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 12:21:46 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 12:21:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:46 INFO - Return code: 0 12:21:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:21:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:21:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:21:47 INFO - Return code: 0 12:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 12:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 12:21:47 INFO - Using env: {'DISPLAY': ':0', 12:21:47 INFO - 'HOME': '/home/cltbld', 12:21:47 INFO - 'LANG': 'en_US.UTF-8', 12:21:47 INFO - 'LANGUAGE': 'en_US:en', 12:21:47 INFO - 'LOGNAME': 'cltbld', 12:21:47 INFO - 'MAIL': '/var/mail/cltbld', 12:21:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:47 INFO - 'MOZ_NO_REMOTE': '1', 12:21:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:47 INFO - 'NO_EM_RESTART': '1', 12:21:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:47 INFO - 'PWD': '/builds/slave/test', 12:21:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:47 INFO - 'SHELL': '/bin/bash', 12:21:47 INFO - 'SHLVL': '1', 12:21:47 INFO - 'TERM': 'linux', 12:21:47 INFO - 'TMOUT': '86400', 12:21:47 INFO - 'USER': 'cltbld', 12:21:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810', 12:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:47 INFO - '_': '/tools/buildbot/bin/python'} 12:21:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 12:21:47 INFO - mozversion application_buildid: 20160527093441 12:21:47 INFO - mozversion application_changeset: 9d87d3a279a08ac507dda94c36d5a12185fea4a6 12:21:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:21:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:47 INFO - mozversion application_name: Firefox 12:21:47 INFO - mozversion application_remotingname: firefox-dev 12:21:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:21:47 INFO - mozversion application_vendor: Mozilla 12:21:47 INFO - mozversion application_version: 48.0a2 12:21:47 INFO - mozversion platform_buildid: 20160527093441 12:21:47 INFO - mozversion platform_changeset: 9d87d3a279a08ac507dda94c36d5a12185fea4a6 12:21:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:21:47 INFO - mozversion platform_version: 48.0a2 12:21:47 INFO - using testdate: 1464376907 12:21:47 INFO - actual date: 1464376907 12:21:47 INFO - starting webserver on 'localhost:36404' 12:21:47 INFO - SUITE-START | Running 2 tests 12:21:47 INFO - TEST-START | dromaeo_css 12:21:47 INFO - operating with platform_type : linux_ 12:21:47 INFO - Initialising browser for dromaeo_css test... 12:21:47 INFO - TEST-INFO | started process 1485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDUMPL/profile http://localhost:36404/getInfo.html) 12:21:51 INFO - PROCESS | 1485 | __metrics Screen width/height:1600/1200 12:21:51 INFO - PROCESS | 1485 | colorDepth:24 12:21:51 INFO - PROCESS | 1485 | Browser inner width/height: 1024/697 12:21:51 INFO - PROCESS | 1485 | __metrics 12:21:52 ERROR - PROCESS | 1485 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:21:53 INFO - TEST-INFO | 1485: exit 0 12:21:53 INFO - Browser initialized. 12:21:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:21:53 INFO - TEST-INFO | started process 1580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDUMPL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:05 INFO - PROCESS | 1580 | RSS: Main: 141352960 12:22:05 INFO - PROCESS | 1580 | 12:22:56 INFO - PROCESS | 1580 | 1464376976505 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] 12:25:04 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36404/tests/dromaeo/cssquery-ext.html) 12:25:05 INFO - PROCESS | 1580 | RSS: Main: 256049152 12:25:05 INFO - PROCESS | 1580 | 12:28:07 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-ext.html (next: http://localhost:36404/tests/dromaeo/cssquery-jquery.html) 12:28:08 INFO - PROCESS | 1580 | RSS: Main: 222670848 12:28:08 INFO - PROCESS | 1580 | 12:31:09 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36404/tests/dromaeo/cssquery-mootools.html) 12:31:10 INFO - PROCESS | 1580 | RSS: Main: 221446144 12:31:10 INFO - PROCESS | 1580 | 12:34:12 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36404/tests/dromaeo/cssquery-prototype.html) 12:34:12 INFO - PROCESS | 1580 | RSS: Main: 224927744 12:34:12 INFO - PROCESS | 1580 | 12:37:15 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36404/tests/dromaeo/cssquery-yui.html) 12:37:16 INFO - PROCESS | 1580 | RSS: Main: 211591168 12:37:16 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | Cycle 1(1): loaded http://localhost:36404/tests/dromaeo/cssquery-yui.html (next: http://localhost:36404/tests/dromaeo/cssquery-dojo.html) 12:40:18 INFO - PROCESS | 1580 | RSS: Main: 256753664 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | __start_tp_report 12:40:18 INFO - PROCESS | 1580 | _x_x_mozilla_page_load 12:40:18 INFO - PROCESS | 1580 | _x_x_mozilla_page_load_details 12:40:18 INFO - PROCESS | 1580 | |i|pagename|runs| 12:40:18 INFO - PROCESS | 1580 | |0;dojo.html;3353.4131526982774;3436.5876094868618;3438.037349542129;3468.65313468653;3478.4956181353705;5678.829635110953;5680.1195814648745;5700.059490184115;5704.743286552105;5712.143178523218;5693.316801983758;5729;5734.942650573493;5737.311522617292;5743.138529220619;4982.103221420143;5119.872003199922;5230.476952304777;5259.815906443275;5282.445343238962;5144.17693169093;5179.792808287682;5183.714895680736;5185.637005409623;5186.688798672073;5105.770240339175;5151.201563757623;5165.3026841376495;5170.9224361634415;5178.585713142958;5188.247704082905;5229.633925625208;5237.7381130943495;5247.10799164143;5267.341582302212;4945.184044632631;5048.1418158913075;5128.051310507568;5146.125158723026;5163.277141200235;5541.5289700375515;5551.472610102034;5592.3009623797025;5598.076317407623;5604.663720176803;6133.080037994292;6164.599301045462;6168.105624684441;6168.9691551541955;6171.413715697002;6108.3280839107665;6177.96911015442;6180.6291622502795;6192.380761923817;6206.937930620681;5459.645123067027;5501.669899806025;5513.9448605513835;5515.669059856422;5568.972155139239;5985.610935289193;5991;5991.940080599138;6037.6679282639;6129.1419201311855;5853.88292234153;5951.315598706117;5966;5969.671668058299;5983.132445795335;5951.732172052268;5952.345242023374;5953.374895635896;5953.910691339634;5961.463468287789;5918.496927761188;5923.141144534018;5930.140129681172;5940.673262970578;6087.57386982907;5937.317208521075;5939;5940.495057920039;5953.374895635896;5965.433283838029;4526.886827829265;4536.342230376643;4539.432570928634;4549.954500455019;4560.087982403533;4081.4285999959434;4095.385692146202;4100;4103.138340948374;4163.2298024865495;5773.1051686988585;5799.594028417971;5799.94200057994;5805.36141024487;5807.070868660994;6133.570650054543;6153.2000839891425;6183.165272688219;6183.258009038944;6187.84530386744;5456.099743542351;5699.971500142473;5787.536997040227;5813.360530341659;5828.76684932598;5208.947910520847;5231.215317702375;5236.476352364733;5237.816676416307;5242.239875218072;6313.2424109107205;6339.0808332791485;6345.111684364193;6349.714262858182;6358.936410635927;6036.63780173191;6071.483923866344;6113.083037544226;6116.938830611637;6126.540509461897;6250.343713909974;6274.090256912631;6317.210348706411;6321.30465648769;6324.810255692337;5819.098039803837;5998.910016349845;6011.849703757266;6017;6019.819405417845;6127.0062805303205;6129.417705317987;6203.875922481616;6209.59637623553;6215.160953271431;5991.970040149946;6007.369226231358;6011.428914253139;6015.939840601538;6044.032954727222;5790.189373487631;5921.911171332347;5939.10913362999;5989.401059893976;5996.910046349221;5754.251947246831;5757.884842303214;5760.366359700513;5764.510016648464;5788.305403351625;5811.709414529341;5868.3251426086545;5874.295084589877;5875.383084776037;5888.381719919346;5739.971300143473;5792.7103644818435;5833.883322333614;5900.793472228452;5918.201042859159 12:40:18 INFO - PROCESS | 1580 | |1;ext.html;651.7327895562818;660.408934004066;668.18147768983;668.5520701130242;673.8208135762414;33743.831280843595;34322.65677343226;34413;41275;42029.36955945663;43820;44157;44165.558344416546;44294;44342.33486497705;8168.795780105485;8894.377393582436;9082.818343633124;9093.499857507835;9096.727098187032;8024;10714.357138571671;10915.617953371633;10980.341179529254;10984.176186785982;10733.51699173539;10832.729181770479;10834.349939003685;10841.241113122085;10844.186685998542;8312.127226641176;10459.738506537398;10627.52176152075;10703.357798532035;10709.785804283909;10396.48017599117;10507.211959103022;10508.684739457829;10511.474426278732;10518.158547316196;41737.58262417367;42135.789321053504;42290.57709422928;42415;42419;3534.4874993125854;3613.6205698401554;3616.2948225096115;3733.6826369758605;4229.70392072555;31833.84083079593;33824.10825946799;34974.82512587421;35506.112347191265;36452.45321320156;4579.450465944108;4625.583697467244;4627.30590411441;4644.2801365788355;4691.530846915315;326511;330004;330012;331512;331621.9999999976;40935;41609;41674;67472.3252767466;68506.31493684999;38584.80707596444;38645;38777;38843;38874.416883746766;17668.293268269383;17914.641707166043;17952.19215135322;17955.192016359295;17957.910210448863;13629.795553066711;14714.779278310834;14943.925280373529;14974.775378369333;15195.164265965257;9445.76385590352;9487.430754154773;9508.572114254875;9553.42679439222;9569.665061722806;3707.9073023174637;3715.368387374099;3726.6087060858217;3766.453864189677;3778.1688028633657;1088.4176965323513;1118.6472727996497;1149.1381463902073;1166.3235323512513;1319.6107148391247;32246.83876580602;32756.67243327584;34027.14932126667;34610;35106.82446587751;1212.3211001838822;1230.9815352769715;1277.2400421749044;1300.6163181861373;1312.120879011065;17605.911970440324;18351.816481835012;18374.540636484195;18444.170012349477;18497;473619;483475;484576;485024;485554;62309.68845155745;63908;63909.68045159744;63971.680141599;64029.35970640234;1406.064966797089;1459.7956286119952;1516.545036489049;1540.7457769468137;1550.7518796992426;30449;34274.14314642154;34287.82856085704;34487.65512344844;35658.28683426369;49612.503874960785;49765.751171243915;50087;50149.74925125351;50171.74914125406;326819;328837;329410;329698;468105;31315;31616.419179040495;31697.524537132424;31770.36459270848;31799.52300715445;44346;45088;45958.77020614876;46086.539134608225;52614.473855260956;36700.63299366972;37369.626303736615;37965.81017094897;38220;38351.42472862853;37667.81166094152;37961.240775184895;38175.80912095422;39798.801005994785;40815;42977.14045719131;43701.12597748091;44187;44615.55384446114;44707.552924470336;36014.639853601126;37618.247635046595;37660.72004565482;38334.808325959304;38899.22201555897;29046.709532905246;29515.354678843407;29592;29690.109296721133;29728.702712972594 12:40:18 INFO - PROCESS | 1580 | |2;jquery.html;422.9133027729315;433.0580986354678;436.323698267685;439.09313422503527;440.1153681100988;18481.907590462044;19024.14391352389;19148.808511914893;19380.418587442364;19904.10431530581;18500.629987400243;18924.71612925804;19060.04699765013;19092.809071909276;19109;5776.898402134469;5780.508656764169;5795.391483894194;5910.4089591040765;5920.171176035358;3813.0657988792786;5861.53107751381;5901.4688678018965;6327.588706734047;6622.4370928471135;6569.802905912807;6573.112629794964;6591.11020012297;6595.901061484082;6604;6387.393197646263;6420.165378500788;6539.50953678476;6550.672466376662;6565.244996825379;3966.603339666039;4108.4864391951005;5589.524890384281;5858.970705146447;5860.824175274749;23321.766782332128;23913;23945.52108957811;24348.80860722526;24486.877565612234;2500.2874180858366;2569.4604133132066;2584.974150258511;2600.687917449918;2671.545837207679;10147.695569132939;14550.27248637564;14683.632909177357;14809.407623695039;14979.775303370458;2015.093208056366;2052.48687828043;2058.1458694641706;2058.5985732782115;2102.16964299101;77423;80517.99999999942;80866.59566702187;81599;82369.58815205886;11335.376554289429;11409.942950285196;11472.942635286938;11541.480633371519;11627;15827.446039388566;15901.363945442285;16031.919840400724;16064.518064458085;16076.839231607768;8694.434861733967;8732.825343493221;8741.694040708544;8778.473291602397;8787;8297.8340433191;8316.293115085164;8357.916420835836;8514.10601886793;8523.829523409497;4909.208139029229;4936.407631084293;4984.22744474607;4998.700077995332;5034.244863270465;1810.5377031445714;1918.3765276284985;1957.549763554362;2031.4515080928068;2104.905279262437;1013.6756238003768;1027.9023492768174;1100.2243418390017;1105.7401510644993;1134.6369161868122;18515;18762.24951001972;19347;19435.51411214731;19706.507337316394;1047.3925123428394;1084.9403282819362;1108.3682301088463;1111.766529028897;1137.397179494869;10584.364938103738;10655.786884262272;10763.977422144884;10919.617813376493;11023.118150548098;542759;550495;568962;573386;574796;62003;87978.56010719905;102748;103005;103838.48080759699;1070.5129166229347;1124.5839039555417;1127.639155470258;1168.415792103948;1175.747214348919;17389.739153912447;17591.82408175902;17776.644467110844;17880.910595446938;18145.00202488876;38988.41517377185;39281;40047.39928901127;40727.389089163094;41006.58993410028;54747.45252547583;57284;57445.13832292435;57592.13611795742;57705;9179.17387435134;9252.35233533673;9273.165415112673;9394.530273486434;9411.10594493522;10864.456777160953;14094.929525352307;14157.43370265219;14205.502807401692;14237.786433203302;11695.356755378536;11711.180217385043;12226;12626.36868156607;12747.298898560668;11367.829482557934;11553.13351498624;11778.646640600795;12204.633860984184;12701.301428421526;12026.639200823989;12257.632271031884;12323.938380308042;12665.620031399072;12955.935220324214;9039.864402034107;9200;9201;9243.352965292364;9362.953185234303;9526.809463810823;12697.492100315883;12734.87265127374;12828.807567886302;12892.806607901077 12:40:18 INFO - PROCESS | 1580 | |3;mootools.html;1448.1890141520742;1548.318739754508;1598.9440369587066;1793.2378739035914;1901.8858868467885;7556.471047026704;7999;8154.3884208684285;8167;8183.345332373411;8223.876641850376;8361;8372.288355489776;8377.994640643132;8378;2160.2655097266925;2216.933491995235;2350.5298940211983;2381.4403615150427;2404.471016376403;2451.779339859412;2458.2748089313604;2460.1635443949053;2462.5936720441196;2462.802975761944;2287.165184707578;2317.4553979814814;2319.408550819547;2332.6850875131895;2334.36972017556;2175.369142948543;2358.702713507581;2382.285314405671;2389.175734371639;2426.344886880532;2339.894704738291;2384;2384.0463814474174;2385.5348207099623;2386.4033991502124;8300.501969881827;8338.04112527055;8349.874751878726;8357.373197010249;8357.83284334316;5182.481751824825;5210.452902445227;5358.437364076754;5363.061464243741;5372.382176049765;3285.5728755261903;3426.3489936911906;3426.777259478126;3437.570303712036;3509.3683137035323;1111.3498603317069;1114.4817659788237;1114.648885601033;1158.7624536969986;1177.1818586082677;12220.388980550937;12224.755504889941;12229.93885030569;12266.202696824677;12289.75420491594;4749.596284315803;4806.134895718735;4861.222204447342;4885.731284779371;4914.778834952435;10325.535350909227;10371.585136594602;10402.791944161074;10404.479776011169;10412.375257484575;5485.01269771437;5502.174673798882;5503.2020357048;5504;5506.284183056177;4370.344448332776;4451.799669014902;4496.910061798746;4790.784414701347;5042.193249080129;4107.856225032109;4199.769012704331;4215.641670457984;4273.273543497613;4290.978545107255;1306.8366454193226;1361.1424802374638;1364.7134101838526;1365.1194979238335;1372.389286767399;935.9157675809209;1083.34999000599;1092.4373947417087;1097.4677281518457;1105.5135740274254;5913.76344946206;6066.817995460143;6171.259448866164;6181.258249010148;6189.164462797555;483.44645381038515;485.6794515619674;490.4947903659237;921.7649499377616;1115.2416356877238;4151.584841515824;4173.353130264813;4189.581041895847;4194.496660400771;4204;10155.984401559932;10629.9468502657;10646.680599582025;10661;10668.946655266674;10322.638707645347;10423.843642345371;10463.947680261703;10487;10488.370697758159;8055.919440805634;8159.755207343789;8231.588420578948;8262.710805121913;8271.1728827118;5897;5946.554008449297;5965.164876917148;6034.818955431344;6095.817125486243;9418.340716150078;9490.05099490073;9584.568694408908;9679.612815487302;9696.369735967139;9622.951885240529;9755.80488390214;9788.657396991071;9832.410055396698;10015.749606259902;6617.669116544057;7059.929400705927;7186.784396468114;7388.039554857834;7500.399968002655;8159.632816523389;8175.754727358189;8190.344772418312;8211.548364839991;8235.83528329442;7227.8554428912175;7388.076490438695;7451.81370465721;7470.514416562906;7507.849843003219;7167.462440317101;7407.111146662435;7431.108267007994;7511.173770885308;7520.059992500937;6793.592384456949;6830.282820303796;6966.059581956573;7014.789556313319;7017.859642807218;5171.431142574239;5175.92236116451;5208.140656791587;5290.28581141541;5438.945610543844;5169.563892953297;5171.9482805172975;5228.921566176435;5251.553617942518;5291.417944026231 12:40:18 INFO - PROCESS | 1580 | |4;prototype.html;361.199942128186;365.35879531422347;368.5227630218867;369.4347648098409;373.458485196465;6199.597026193294;6201.906971395427;6235.127082208494;6269.247690277161;6289.339619339967;6147.723352449139;6147.723352449139;6154.507639388849;6159.8768024639485;6166.599171053889;4574.634029277659;4672.135654903854;4738.360321356625;4755.45312289086;4766.213574760161;4713.43438787346;4746.074515469485;4749.240121580548;4762.3094651275715;4763.476017638057;4590.97704511477;4741.644376671747;4781.617470602343;4781.856544303677;4792.113459010076;4631.768411579441;4709.987352719165;4726.574608285271;4742.644301677354;4755.785989630475;4159.334506478949;4187.016051227959;4199.181159673864;4210.200061988213;4227.957720422818;5927.347991720907;5931.466168044896;5941.554383421218;5944.851378715523;5947.10793380992;5544.944550554484;5578.330600327987;5579.191017302509;5600.131979543177;5604.943950560483;6465.644389558573;6578.868422631568;6596.505262105314;6599.868002639968;6602.471802255808;4710.599599034086;4723.36234608327;4729.385179926622;4736.9526304736855;4737.976310118462;6876.037354770337;6905.274946130685;6910.7581234656545;6916.515843890929;6920.204176519664;4830.492798256203;4831.975840120777;4832.685875418087;4837;4838.516148385133;4893.143699852511;4900.656954013256;4903.41159060915;4906.215005599087;4910.90178196434;5593.188987596775;5597.916031259534;5597.944020559824;5602;5604.047311956896;6508.316626754217;6669.966650166718;6678;6685.966570167216;6692.297308782605;1709.444430560048;1719.7678313427778;1726.0765490462543;1728.4987353667548;1728.8530474909521;1105.2539535813455;1149.6723433821487;1157.4617802721775;1174.142875700726;1175.9941200293945;6264.373562643699;6414.03789431589;6430.099786029959;6436.227652681709;6436.774712885027;6889.138857642794;6926.619035953071;6928.7228510859;6933.722651094001;6937;6488.870222595521;6504.9674751625935;6507.707153178024;6513.316101809241;6519.054737063099;3681.5398075240596;3722.758020728644;3724.5902950675404;3727.962720372816;3728.067983004249;6989.266127056688;7125.643717814089;7128.716830970475;7139.357457828716;7187;7079.752208672672;7084.92915070853;7102;7102.360787529044;7127.857442851114;7159.89260161098;7167.677454514559;7171.067761191011;7173.6771845267085;7188.101487313981;6913.446924245947;6916.031755554126;6916.861662766616;6921.304280451322;6931.2375638678695;6631.801045968628;6838.487113466609;6844.760433384808;6924.896126558005;6928.3764461196715;7154.141503019671;7155.105611798525;7175.2465991070185;7178.4257259420165;7185.748498802726;4884.145274577006;4887.951120488749;4890.951090489192;4894.094592500399;4895.118878601886;6912.44700423975;6915.343042410963;6918.688659010458;6922.134733158356;6922.411595014279;6494.772682956074;6695.933040669531;6733.326667333227;6734.696938637871;6760.3239676032;6700;6702.765403210864;6705.631190284386;6719.328067193437;6724.327567243236;6599.67001649906;6622;6625.304343043911;6627.3372662733345;6634.83412914681;6735.427488663322;6740.831479213059;6741.561798483083;6743.393094621508;6744.7976560703255;6288.5598008138995;6391.58454700443;6425.614463132227;6454.19322584677;6590.538662293593 12:40:18 INFO - PROCESS | 1580 | |5;yui.html;789.3369569561568;827.7433995461407;884.1865483754945;884.5432999811587;898.9101089891008;14792.926035369821;15132.848671513282;15258.69482610347;15270.541883743477;15287.92356038221;14077.648058798535;14128.576142715736;14140.787888181685;14142.64643383916;14144.71710565788;733.9853202935951;778.1401551285833;778.5445514374098;778.7196609220676;894.1907573645829;913.4975763330175;913.6528119314651;913.8629205619177;914.6295750221171;915.2632131134434;970.0493516353978;973.2797729680021;973.634886917406;973.6640858903702;974.2692980264801;786.8268980824209;928.1414691410419;960.5725452173785;960.9567569459356;969.8642190093393;703.9859202815966;705.1643802094534;705.3017512662478;708.3837061756253;710.8365076032542;14650;14724;14766.630834229123;14827.77758333626;14843.628909277246;14565.927170364186;15059.849401505955;15082.698346033018;15123.848761512465;15183.392664293415;12129.454174562166;12265.448054837465;12348.938255308756;12354.38228088601;12357.32034738089;4051.9594804051876;4086.3257562502154;4088.2028004539125;4100.200460910124;4117.341225403921;60307.396926031055;60379.39620603782;60392.094118588255;60638.090428643605;60828.087578686354;10711.143108551452;10766.56933722658;11054.170937179744;11108.555657773599;11535.826962595567;20458;20499.8975005124;20555.58888822215;20581.970901454868;20598.073086711134;8247;8274.172582741678;8339.666413343519;8356.637115487609;8526.616302266413;4831.251156070814;4894.388201474816;4902.093112774148;4906.558409743069;5048.268001139888;3779.829907654162;3851.1334949636107;3854.2291541691775;3856.2287542491613;3856.5564960029956;654.3325807676143;657.976970806029;661.5005670718576;668.4251543672437;669.1735706402588;750.0624219725344;800.2797482266008;801.8133162918913;805.4281460163232;814.8207394373347;9459.810284573141;9637.18083962857;9684.757881052888;9727.756806079904;9878;772.2547741429547;778.8442311537602;783.6473586885924;785.3285440947907;796.4186144114828;4708.717476951394;4719.4100737407825;4739.526047395302;4739.668223224341;4816.128615574153;69214.65392673106;69670;69821;70291.64854175696;70355;57577.71211143918;58410.12384814231;58448.41551584515;58780.41219587835;58793.412065878794;53566.464335356926;53660.19509707358;53888.461115388345;54246.728766356704;54950.45049549533;9250.676226332045;9295.86056209171;9360.672376466791;9404.106609872051;9405.153536181777;40252;41667.7916610415;41715.16569668529;41816.58183418127;42163.578364215966;49339.25991110064;52005.47994520158;52574.47425525849;52580.737096314275;53178;11483.138764592522;11716.355600442057;11771.587994420153;11779.116566257393;11852.585159519376;12946.223226606433;13043.608691739262;13089.214647121204;13244.801327979896;13307.866921330662;11989.880101199225;12383.380830958236;12518.248905065726;12604.432800524182;12621.432035558606;12981.350932453151;13140.540081097115;13348.866511334762;13393.531226407029;13454.730905382034;12644.810327844905;12689.682757930756;12899.226046437243;12974.610761677164;13316.201027938354;10765.677029689123;10813.405262710627;10946.233763636468;11535.077193824307;11695.298282103102;11206.43967801623;11307;11536.884631153582;11567.942160289145;11589.362585057903 12:40:18 INFO - PROCESS | 1580 | __end_tp_report 12:40:18 INFO - PROCESS | 1580 | __start_cc_report 12:40:18 INFO - PROCESS | 1580 | _x_x_mozilla_cycle_collect,918 12:40:18 INFO - PROCESS | 1580 | __end_cc_report 12:40:18 INFO - PROCESS | 1580 | __startTimestamp1464378018639__endTimestamp 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | ------- Summary: start ------- 12:40:18 INFO - PROCESS | 1580 | Number of tests: 6 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#0] dojo.html Cycles:165 Average:5630.16 Median:5813.36 stddev:631.55 (10.9%) stddev-sans-first:607.70 12:40:18 INFO - PROCESS | 1580 | Values: 3353.4 3436.6 3438.0 3468.7 3478.5 5678.8 5680.1 5700.1 5704.7 5712.1 5693.3 5729.0 5734.9 5737.3 5743.1 4982.1 5119.9 5230.5 5259.8 5282.4 5144.2 5179.8 5183.7 5185.6 5186.7 5105.8 5151.2 5165.3 5170.9 5178.6 5188.2 5229.6 5237.7 5247.1 5267.3 4945.2 5048.1 5128.1 5146.1 5163.3 5541.5 5551.5 5592.3 5598.1 5604.7 6133.1 6164.6 6168.1 6169.0 6171.4 6108.3 6178.0 6180.6 6192.4 6206.9 5459.6 5501.7 5513.9 5515.7 5569.0 5985.6 5991.0 5991.9 6037.7 6129.1 5853.9 5951.3 5966.0 5969.7 5983.1 5951.7 5952.3 5953.4 5953.9 5961.5 5918.5 5923.1 5930.1 5940.7 6087.6 5937.3 5939.0 5940.5 5953.4 5965.4 4526.9 4536.3 4539.4 4550.0 4560.1 4081.4 4095.4 4100.0 4103.1 4163.2 5773.1 5799.6 5799.9 5805.4 5807.1 6133.6 6153.2 6183.2 6183.3 6187.8 5456.1 5700.0 5787.5 5813.4 5828.8 5208.9 5231.2 5236.5 5237.8 5242.2 6313.2 6339.1 6345.1 6349.7 6358.9 6036.6 6071.5 6113.1 6116.9 6126.5 6250.3 6274.1 6317.2 6321.3 6324.8 5819.1 5998.9 6011.8 6017.0 6019.8 6127.0 6129.4 6203.9 6209.6 6215.2 5992.0 6007.4 6011.4 6015.9 6044.0 5790.2 5921.9 5939.1 5989.4 5996.9 5754.3 5757.9 5760.4 5764.5 5788.3 5811.7 5868.3 5874.3 5875.4 5888.4 5740.0 5792.7 5833.9 5900.8 5918.2 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#1] ext.html Cycles:180 Average:55360.45 Median:3711.64 stddev:104773.68 (2822.8%) stddev-sans-first:104987.08 12:40:18 INFO - PROCESS | 1580 | Values: 651.7 660.4 668.2 668.6 673.8 33743.8 34322.7 34413.0 41275.0 42029.4 43820.0 44157.0 44165.6 44294.0 44342.3 8168.8 8894.4 9082.8 9093.5 9096.7 8024.0 10714.4 10915.6 10980.3 10984.2 10733.5 10832.7 10834.3 10841.2 10844.2 8312.1 10459.7 10627.5 10703.4 10709.8 10396.5 10507.2 10508.7 10511.5 10518.2 41737.6 42135.8 42290.6 42415.0 42419.0 3534.5 3613.6 3616.3 3733.7 4229.7 31833.8 33824.1 34974.8 35506.1 36452.5 4579.5 4625.6 4627.3 4644.3 4691.5 326511.0 330004.0 330012.0 331512.0 331622.0 40935.0 41609.0 41674.0 67472.3 68506.3 38584.8 38645.0 38777.0 38843.0 38874.4 17668.3 17914.6 17952.2 17955.2 17957.9 13629.8 14714.8 14943.9 14974.8 15195.2 9445.8 9487.4 9508.6 9553.4 9569.7 3707.9 3715.4 3726.6 3766.5 3778.2 1088.4 1118.6 1149.1 1166.3 1319.6 32246.8 32756.7 34027.1 34610.0 35106.8 1212.3 1231.0 1277.2 1300.6 1312.1 17605.9 18351.8 18374.5 18444.2 18497.0 473619.0 483475.0 484576.0 485024.0 485554.0 62309.7 63908.0 63909.7 63971.7 64029.4 1406.1 1459.8 1516.5 1540.7 1550.8 30449.0 34274.1 34287.8 34487.7 35658.3 49612.5 49765.8 50087.0 50149.7 50171.7 326819.0 328837.0 329410.0 329698.0 468105.0 31315.0 31616.4 31697.5 31770.4 31799.5 44346.0 45088.0 45958.8 46086.5 52614.5 36700.6 37369.6 37965.8 38220.0 38351.4 37667.8 37961.2 38175.8 39798.8 40815.0 42977.1 43701.1 44187.0 44615.6 44707.6 36014.6 37618.2 37660.7 38334.8 38899.2 29046.7 29515.4 29592.0 29690.1 29728.7 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#2] jquery.html Cycles:180 Average:31264.75 Median:2103.54 stddev:92295.92 (4387.7%) stddev-sans-first:92525.78 12:40:18 INFO - PROCESS | 1580 | Values: 422.9 433.1 436.3 439.1 440.1 18481.9 19024.1 19148.8 19380.4 19904.1 18500.6 18924.7 19060.0 19092.8 19109.0 5776.9 5780.5 5795.4 5910.4 5920.2 3813.1 5861.5 5901.5 6327.6 6622.4 6569.8 6573.1 6591.1 6595.9 6604.0 6387.4 6420.2 6539.5 6550.7 6565.2 3966.6 4108.5 5589.5 5859.0 5860.8 23321.8 23913.0 23945.5 24348.8 24486.9 2500.3 2569.5 2585.0 2600.7 2671.5 10147.7 14550.3 14683.6 14809.4 14979.8 2015.1 2052.5 2058.1 2058.6 2102.2 77423.0 80518.0 80866.6 81599.0 82369.6 11335.4 11409.9 11472.9 11541.5 11627.0 15827.4 15901.4 16031.9 16064.5 16076.8 8694.4 8732.8 8741.7 8778.5 8787.0 8297.8 8316.3 8357.9 8514.1 8523.8 4909.2 4936.4 4984.2 4998.7 5034.2 1810.5 1918.4 1957.5 2031.5 2104.9 1013.7 1027.9 1100.2 1105.7 1134.6 18515.0 18762.2 19347.0 19435.5 19706.5 1047.4 1084.9 1108.4 1111.8 1137.4 10584.4 10655.8 10764.0 10919.6 11023.1 542759.0 550495.0 568962.0 573386.0 574796.0 62003.0 87978.6 102748.0 103005.0 103838.5 1070.5 1124.6 1127.6 1168.4 1175.7 17389.7 17591.8 17776.6 17880.9 18145.0 38988.4 39281.0 40047.4 40727.4 41006.6 54747.5 57284.0 57445.1 57592.1 57705.0 9179.2 9252.4 9273.2 9394.5 9411.1 10864.5 14094.9 14157.4 14205.5 14237.8 11695.4 11711.2 12226.0 12626.4 12747.3 11367.8 11553.1 11778.6 12204.6 12701.3 12026.6 12257.6 12323.9 12665.6 12955.9 9039.9 9200.0 9201.0 9243.4 9363.0 9526.8 12697.5 12734.9 12828.8 12892.8 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#3] mootools.html Cycles:180 Average:5704.08 Median:2688.11 stddev:3149.55 (117.2%) stddev-sans-first:3142.15 12:40:18 INFO - PROCESS | 1580 | Values: 1448.2 1548.3 1598.9 1793.2 1901.9 7556.5 7999.0 8154.4 8167.0 8183.3 8223.9 8361.0 8372.3 8378.0 8378.0 2160.3 2216.9 2350.5 2381.4 2404.5 2451.8 2458.3 2460.2 2462.6 2462.8 2287.2 2317.5 2319.4 2332.7 2334.4 2175.4 2358.7 2382.3 2389.2 2426.3 2339.9 2384.0 2384.0 2385.5 2386.4 8300.5 8338.0 8349.9 8357.4 8357.8 5182.5 5210.5 5358.4 5363.1 5372.4 3285.6 3426.3 3426.8 3437.6 3509.4 1111.3 1114.5 1114.6 1158.8 1177.2 12220.4 12224.8 12229.9 12266.2 12289.8 4749.6 4806.1 4861.2 4885.7 4914.8 10325.5 10371.6 10402.8 10404.5 10412.4 5485.0 5502.2 5503.2 5504.0 5506.3 4370.3 4451.8 4496.9 4790.8 5042.2 4107.9 4199.8 4215.6 4273.3 4291.0 1306.8 1361.1 1364.7 1365.1 1372.4 935.9 1083.3 1092.4 1097.5 1105.5 5913.8 6066.8 6171.3 6181.3 6189.2 483.4 485.7 490.5 921.8 1115.2 4151.6 4173.4 4189.6 4194.5 4204.0 10156.0 10629.9 10646.7 10661.0 10668.9 10322.6 10423.8 10463.9 10487.0 10488.4 8055.9 8159.8 8231.6 8262.7 8271.2 5897.0 5946.6 5965.2 6034.8 6095.8 9418.3 9490.1 9584.6 9679.6 9696.4 9623.0 9755.8 9788.7 9832.4 10015.7 6617.7 7059.9 7186.8 7388.0 7500.4 8159.6 8175.8 8190.3 8211.5 8235.8 7227.9 7388.1 7451.8 7470.5 7507.8 7167.5 7407.1 7431.1 7511.2 7520.1 6793.6 6830.3 6966.1 7014.8 7017.9 5171.4 5175.9 5208.1 5290.3 5438.9 5169.6 5171.9 5228.9 5251.6 5291.4 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#4] prototype.html Cycles:180 Average:5591.27 Median:6288.95 stddev:1678.57 (26.7%) stddev-sans-first:1636.74 12:40:18 INFO - PROCESS | 1580 | Values: 361.2 365.4 368.5 369.4 373.5 6199.6 6201.9 6235.1 6269.2 6289.3 6147.7 6147.7 6154.5 6159.9 6166.6 4574.6 4672.1 4738.4 4755.5 4766.2 4713.4 4746.1 4749.2 4762.3 4763.5 4591.0 4741.6 4781.6 4781.9 4792.1 4631.8 4710.0 4726.6 4742.6 4755.8 4159.3 4187.0 4199.2 4210.2 4228.0 5927.3 5931.5 5941.6 5944.9 5947.1 5544.9 5578.3 5579.2 5600.1 5604.9 6465.6 6578.9 6596.5 6599.9 6602.5 4710.6 4723.4 4729.4 4737.0 4738.0 6876.0 6905.3 6910.8 6916.5 6920.2 4830.5 4832.0 4832.7 4837.0 4838.5 4893.1 4900.7 4903.4 4906.2 4910.9 5593.2 5597.9 5597.9 5602.0 5604.0 6508.3 6670.0 6678.0 6686.0 6692.3 1709.4 1719.8 1726.1 1728.5 1728.9 1105.3 1149.7 1157.5 1174.1 1176.0 6264.4 6414.0 6430.1 6436.2 6436.8 6889.1 6926.6 6928.7 6933.7 6937.0 6488.9 6505.0 6507.7 6513.3 6519.1 3681.5 3722.8 3724.6 3728.0 3728.1 6989.3 7125.6 7128.7 7139.4 7187.0 7079.8 7084.9 7102.0 7102.4 7127.9 7159.9 7167.7 7171.1 7173.7 7188.1 6913.4 6916.0 6916.9 6921.3 6931.2 6631.8 6838.5 6844.8 6924.9 6928.4 7154.1 7155.1 7175.2 7178.4 7185.7 4884.1 4888.0 4891.0 4894.1 4895.1 6912.4 6915.3 6918.7 6922.1 6922.4 6494.8 6695.9 6733.3 6734.7 6760.3 6700.0 6702.8 6705.6 6719.3 6724.3 6599.7 6622.0 6625.3 6627.3 6634.8 6735.4 6740.8 6741.6 6743.4 6744.8 6288.6 6391.6 6425.6 6454.2 6590.5 12:40:18 INFO - PROCESS | 1580 | 12:40:18 INFO - PROCESS | 1580 | [#5] yui.html Cycles:180 Average:16044.57 Median:4862.82 stddev:19054.31 (391.8%) stddev-sans-first:19073.33 12:40:18 INFO - PROCESS | 1580 | Values: 789.3 827.7 884.2 884.5 898.9 14792.9 15132.8 15258.7 15270.5 15287.9 14077.6 14128.6 14140.8 14142.6 14144.7 734.0 778.1 778.5 778.7 894.2 913.5 913.7 913.9 914.6 915.3 970.0 973.3 973.6 973.7 974.3 786.8 928.1 960.6 961.0 969.9 704.0 705.2 705.3 708.4 710.8 14650.0 14724.0 14766.6 14827.8 14843.6 14565.9 15059.8 15082.7 15123.8 15183.4 12129.5 12265.4 12348.9 12354.4 12357.3 4052.0 4086.3 4088.2 4100.2 4117.3 60307.4 60379.4 60392.1 60638.1 60828.1 10711.1 10766.6 11054.2 11108.6 11535.8 20458.0 20499.9 20555.6 20582.0 20598.1 8247.0 8274.2 8339.7 8356.6 8526.6 4831.3 4894.4 4902.1 4906.6 5048.3 3779.8 3851.1 3854.2 3856.2 3856.6 654.3 658.0 661.5 668.4 669.2 750.1 800.3 801.8 805.4 814.8 9459.8 9637.2 9684.8 9727.8 9878.0 772.3 778.8 783.6 785.3 796.4 4708.7 4719.4 4739.5 4739.7 4816.1 69214.7 69670.0 69821.0 70291.6 70355.0 57577.7 58410.1 58448.4 58780.4 58793.4 53566.5 53660.2 53888.5 54246.7 54950.5 9250.7 9295.9 9360.7 9404.1 9405.2 40252.0 41667.8 41715.2 41816.6 42163.6 49339.3 52005.5 52574.5 52580.7 53178.0 11483.1 11716.4 11771.6 11779.1 11852.6 12946.2 13043.6 13089.2 13244.8 13307.9 11989.9 12383.4 12518.2 12604.4 12621.4 12981.4 13140.5 13348.9 13393.5 13454.7 12644.8 12689.7 12899.2 12974.6 13316.2 10765.7 10813.4 10946.2 11535.1 11695.3 11206.4 11307.0 11536.9 11567.9 11589.4 12:40:18 INFO - PROCESS | 1580 | -------- Summary: end -------- 12:40:18 INFO - PROCESS | 1580 | 12:40:19 INFO - TEST-INFO | 1580: exit 0 12:40:19 INFO - TEST-OK | dromaeo_css | took 1111969ms 12:40:19 INFO - TEST-START | kraken 12:40:19 INFO - operating with platform_type : linux_ 12:40:19 INFO - Initialising browser for kraken test... 12:40:19 INFO - TEST-INFO | started process 1767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wnABQ/profile http://localhost:36404/getInfo.html) 12:40:23 INFO - PROCESS | 1767 | __metrics Screen width/height:1600/1200 12:40:23 INFO - PROCESS | 1767 | colorDepth:24 12:40:23 INFO - PROCESS | 1767 | Browser inner width/height: 1024/697 12:40:23 INFO - PROCESS | 1767 | __metrics 12:40:24 ERROR - PROCESS | 1767 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:40:25 INFO - TEST-INFO | 1767: exit 0 12:40:25 INFO - Browser initialized. 12:40:25 INFO - Running cycle 1/1 for kraken test... 12:40:25 INFO - TEST-INFO | started process 1857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wnABQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:37 INFO - PROCESS | 1857 | RSS: Main: 141410304 12:40:37 INFO - PROCESS | 1857 | 12:40:39 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36404/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:40 INFO - PROCESS | 1857 | RSS: Main: 196816896 12:40:40 INFO - PROCESS | 1857 | 12:40:43 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36404/tests/kraken/driver.html?testName=audio-dft) 12:40:43 INFO - PROCESS | 1857 | RSS: Main: 181186560 12:40:43 INFO - PROCESS | 1857 | 12:40:46 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36404/tests/kraken/driver.html?testName=audio-fft) 12:40:47 INFO - PROCESS | 1857 | RSS: Main: 271953920 12:40:47 INFO - PROCESS | 1857 | 12:40:49 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36404/tests/kraken/driver.html?testName=audio-oscillator) 12:40:49 INFO - PROCESS | 1857 | RSS: Main: 178827264 12:40:49 INFO - PROCESS | 1857 | 12:40:52 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:40:52 INFO - PROCESS | 1857 | RSS: Main: 176971776 12:40:52 INFO - PROCESS | 1857 | 12:40:55 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36404/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:56 INFO - PROCESS | 1857 | RSS: Main: 211791872 12:40:56 INFO - PROCESS | 1857 | 12:40:59 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36404/tests/kraken/driver.html?testName=imaging-desaturate) 12:41:00 INFO - PROCESS | 1857 | RSS: Main: 211746816 12:41:00 INFO - PROCESS | 1857 | 12:41:02 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36404/tests/kraken/driver.html?testName=json-parse-financial) 12:41:03 INFO - PROCESS | 1857 | RSS: Main: 211521536 12:41:03 INFO - PROCESS | 1857 | 12:41:05 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:41:05 INFO - PROCESS | 1857 | RSS: Main: 190758912 12:41:05 INFO - PROCESS | 1857 | 12:41:07 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:41:08 INFO - PROCESS | 1857 | RSS: Main: 194555904 12:41:08 INFO - PROCESS | 1857 | 12:41:09 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:41:10 INFO - PROCESS | 1857 | RSS: Main: 207634432 12:41:10 INFO - PROCESS | 1857 | 12:41:12 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:13 INFO - PROCESS | 1857 | RSS: Main: 213037056 12:41:13 INFO - PROCESS | 1857 | 12:41:16 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:16 INFO - PROCESS | 1857 | RSS: Main: 209707008 12:41:16 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:36404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36404/tests/kraken/driver.html?testName=ai-astar) 12:41:18 INFO - PROCESS | 1857 | RSS: Main: 273453056 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | __start_tp_report 12:41:18 INFO - PROCESS | 1857 | _x_x_mozilla_page_load 12:41:18 INFO - PROCESS | 1857 | _x_x_mozilla_page_load_details 12:41:18 INFO - PROCESS | 1857 | |i|pagename|runs| 12:41:18 INFO - PROCESS | 1857 | |0;ai-astar;111;112;111;111;110;112;109;110;110;110 12:41:18 INFO - PROCESS | 1857 | |1;audio-beat-detection;155;127;160;178;128;162;155;132;188;131 12:41:18 INFO - PROCESS | 1857 | |2;audio-dft;161;160;162;160;163;161;161;161;160;160 12:41:18 INFO - PROCESS | 1857 | |3;audio-fft;76;74;75;176;76;76;75;75;161;76 12:41:18 INFO - PROCESS | 1857 | |4;audio-oscillator;92;91;148;91;92;92;142;93;92;150 12:41:18 INFO - PROCESS | 1857 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;117;116;117 12:41:18 INFO - PROCESS | 1857 | |6;imaging-darkroom;146;146;146;145;147;145;145;145;146;145 12:41:18 INFO - PROCESS | 1857 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;94;94 12:41:18 INFO - PROCESS | 1857 | |8;json-parse-financial;54;56;59;56;57;53;57;72;54;53 12:41:18 INFO - PROCESS | 1857 | |9;json-stringify-tinderbox;58;59;58;58;59;58;59;59;60;60 12:41:18 INFO - PROCESS | 1857 | |10;stanford-crypto-aes;73;72;71;72;73;73;73;73;73;72 12:41:18 INFO - PROCESS | 1857 | |11;stanford-crypto-ccm;120;118;113;117;111;110;111;112;128;130 12:41:18 INFO - PROCESS | 1857 | |12;stanford-crypto-pbkdf2;162;160;155;156;160;161;163;156;157;156 12:41:18 INFO - PROCESS | 1857 | |13;stanford-crypto-sha256-iterative;68;67;67;68;66;68;66;65;66;65 12:41:18 INFO - PROCESS | 1857 | __end_tp_report 12:41:18 INFO - PROCESS | 1857 | __start_cc_report 12:41:18 INFO - PROCESS | 1857 | _x_x_mozilla_cycle_collect,1637 12:41:18 INFO - PROCESS | 1857 | __end_cc_report 12:41:18 INFO - PROCESS | 1857 | __startTimestamp1464378078842__endTimestamp 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | ------- Summary: start ------- 12:41:18 INFO - PROCESS | 1857 | Number of tests: 14 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 12:41:18 INFO - PROCESS | 1857 | Values: 111.0 112.0 111.0 111.0 110.0 112.0 109.0 110.0 110.0 110.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:157.50 stddev:21.59 (13.7%) stddev-sans-first:22.86 12:41:18 INFO - PROCESS | 1857 | Values: 155.0 127.0 160.0 178.0 128.0 162.0 155.0 132.0 188.0 131.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 12:41:18 INFO - PROCESS | 1857 | Values: 161.0 160.0 162.0 160.0 163.0 161.0 161.0 161.0 160.0 160.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.43 (52.2%) stddev-sans-first:41.28 12:41:18 INFO - PROCESS | 1857 | Values: 76.0 74.0 75.0 176.0 76.0 76.0 75.0 75.0 161.0 76.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:26.55 (28.9%) stddev-sans-first:27.50 12:41:18 INFO - PROCESS | 1857 | Values: 92.0 91.0 148.0 91.0 92.0 92.0 142.0 93.0 92.0 150.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:41:18 INFO - PROCESS | 1857 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:41:18 INFO - PROCESS | 1857 | Values: 146.0 146.0 146.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:41:18 INFO - PROCESS | 1857 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:5.59 (9.9%) stddev-sans-first:5.81 12:41:18 INFO - PROCESS | 1857 | Values: 54.0 56.0 59.0 56.0 57.0 53.0 57.0 72.0 54.0 53.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 12:41:18 INFO - PROCESS | 1857 | Values: 58.0 59.0 58.0 58.0 59.0 58.0 59.0 59.0 60.0 60.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:73.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 12:41:18 INFO - PROCESS | 1857 | Values: 73.0 72.0 71.0 72.0 73.0 73.0 73.0 73.0 73.0 72.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.50 stddev:7.16 (6.1%) stddev-sans-first:7.52 12:41:18 INFO - PROCESS | 1857 | Values: 120.0 118.0 113.0 117.0 111.0 110.0 111.0 112.0 128.0 130.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:160.00 stddev:2.91 (1.8%) stddev-sans-first:2.82 12:41:18 INFO - PROCESS | 1857 | Values: 162.0 160.0 155.0 156.0 160.0 161.0 163.0 156.0 157.0 156.0 12:41:18 INFO - PROCESS | 1857 | 12:41:18 INFO - PROCESS | 1857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.17 (1.8%) stddev-sans-first:1.13 12:41:18 INFO - PROCESS | 1857 | Values: 68.0 67.0 67.0 68.0 66.0 68.0 66.0 65.0 66.0 65.0 12:41:18 INFO - PROCESS | 1857 | -------- Summary: end -------- 12:41:18 INFO - PROCESS | 1857 | 12:41:19 INFO - TEST-INFO | 1857: exit 0 12:41:19 INFO - TEST-OK | kraken | took 60501ms 12:41:19 INFO - SUITE-END | took 1172s 12:41:19 INFO - Completed test suite (00:19:32) 12:41:19 INFO - javascript benchmark 12:41:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.4131526982774, 3436.5876094868618, 3438.037349542129, 3468.65313468653, 3478.4956181353705, 5678.829635110953, 5680.1195814648745, 5700.059490184115, 5704.743286552105, 5712.143178523218, 5693.316801983758, 5729.0, 5734.942650573493, 5737.311522617292, 5743.138529220619, 4982.103221420143, 5119.872003199922, 5230.476952304777, 5259.815906443275, 5282.445343238962, 5144.17693169093, 5179.792808287682, 5183.714895680736, 5185.637005409623, 5186.688798672073, 5105.770240339175, 5151.201563757623, 5165.3026841376495, 5170.9224361634415, 5178.585713142958, 5188.247704082905, 5229.633925625208, 5237.7381130943495, 5247.10799164143, 5267.341582302212, 4945.184044632631, 5048.1418158913075, 5128.051310507568, 5146.125158723026, 5163.277141200235, 5541.5289700375515, 5551.472610102034, 5592.3009623797025, 5598.076317407623, 5604.663720176803, 6133.080037994292, 6164.599301045462, 6168.105624684441, 6168.9691551541955, 6171.413715697002, 6108.3280839107665, 6177.96911015442, 6180.6291622502795, 6192.380761923817, 6206.937930620681, 5459.645123067027, 5501.669899806025, 5513.9448605513835, 5515.669059856422, 5568.972155139239, 5985.610935289193, 5991.0, 5991.940080599138, 6037.6679282639, 6129.1419201311855, 5853.88292234153, 5951.315598706117, 5966.0, 5969.671668058299, 5983.132445795335, 5951.732172052268, 5952.345242023374, 5953.374895635896, 5953.910691339634, 5961.463468287789, 5918.496927761188, 5923.141144534018, 5930.140129681172, 5940.673262970578, 6087.57386982907, 5937.317208521075, 5939.0, 5940.495057920039, 5953.374895635896, 5965.433283838029, 4526.886827829265, 4536.342230376643, 4539.432570928634, 4549.954500455019, 4560.087982403533, 4081.4285999959434, 4095.385692146202, 4100.0, 4103.138340948374, 4163.2298024865495, 5773.1051686988585, 5799.594028417971, 5799.94200057994, 5805.36141024487, 5807.070868660994, 6133.570650054543, 6153.2000839891425, 6183.165272688219, 6183.258009038944, 6187.84530386744, 5456.099743542351, 5699.971500142473, 5787.536997040227, 5813.360530341659, 5828.76684932598, 5208.947910520847, 5231.215317702375, 5236.476352364733, 5237.816676416307, 5242.239875218072, 6313.2424109107205, 6339.0808332791485, 6345.111684364193, 6349.714262858182, 6358.936410635927, 6036.63780173191, 6071.483923866344, 6113.083037544226, 6116.938830611637, 6126.540509461897, 6250.343713909974, 6274.090256912631, 6317.210348706411, 6321.30465648769, 6324.810255692337, 5819.098039803837, 5998.910016349845, 6011.849703757266, 6017.0, 6019.819405417845, 6127.0062805303205, 6129.417705317987, 6203.875922481616, 6209.59637623553, 6215.160953271431, 5991.970040149946, 6007.369226231358, 6011.428914253139, 6015.939840601538, 6044.032954727222, 5790.189373487631, 5921.911171332347, 5939.10913362999, 5989.401059893976, 5996.910046349221, 5754.251947246831, 5757.884842303214, 5760.366359700513, 5764.510016648464, 5788.305403351625, 5811.709414529341, 5868.3251426086545, 5874.295084589877, 5875.383084776037, 5888.381719919346, 5739.971300143473, 5792.7103644818435, 5833.883322333614, 5900.793472228452, 5918.201042859159], "value": 5588.92986364584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.7327895562818, 660.408934004066, 668.18147768983, 668.5520701130242, 673.8208135762414, 33743.831280843595, 34322.65677343226, 34413.0, 41275.0, 42029.36955945663, 43820.0, 44157.0, 44165.558344416546, 44294.0, 44342.33486497705, 8168.795780105485, 8894.377393582436, 9082.818343633124, 9093.499857507835, 9096.727098187032, 8024.0, 10714.357138571671, 10915.617953371633, 10980.341179529254, 10984.176186785982, 10733.51699173539, 10832.729181770479, 10834.349939003685, 10841.241113122085, 10844.186685998542, 8312.127226641176, 10459.738506537398, 10627.52176152075, 10703.357798532035, 10709.785804283909, 10396.48017599117, 10507.211959103022, 10508.684739457829, 10511.474426278732, 10518.158547316196, 41737.58262417367, 42135.789321053504, 42290.57709422928, 42415.0, 42419.0, 3534.4874993125854, 3613.6205698401554, 3616.2948225096115, 3733.6826369758605, 4229.70392072555, 31833.84083079593, 33824.10825946799, 34974.82512587421, 35506.112347191265, 36452.45321320156, 4579.450465944108, 4625.583697467244, 4627.30590411441, 4644.2801365788355, 4691.530846915315, 326511.0, 330004.0, 330012.0, 331512.0, 331621.9999999976, 40935.0, 41609.0, 41674.0, 67472.3252767466, 68506.31493684999, 38584.80707596444, 38645.0, 38777.0, 38843.0, 38874.416883746766, 17668.293268269383, 17914.641707166043, 17952.19215135322, 17955.192016359295, 17957.910210448863, 13629.795553066711, 14714.779278310834, 14943.925280373529, 14974.775378369333, 15195.164265965257, 9445.76385590352, 9487.430754154773, 9508.572114254875, 9553.42679439222, 9569.665061722806, 3707.9073023174637, 3715.368387374099, 3726.6087060858217, 3766.453864189677, 3778.1688028633657, 1088.4176965323513, 1118.6472727996497, 1149.1381463902073, 1166.3235323512513, 1319.6107148391247, 32246.83876580602, 32756.67243327584, 34027.14932126667, 34610.0, 35106.82446587751, 1212.3211001838822, 1230.9815352769715, 1277.2400421749044, 1300.6163181861373, 1312.120879011065, 17605.911970440324, 18351.816481835012, 18374.540636484195, 18444.170012349477, 18497.0, 473619.0, 483475.0, 484576.0, 485024.0, 485554.0, 62309.68845155745, 63908.0, 63909.68045159744, 63971.680141599, 64029.35970640234, 1406.064966797089, 1459.7956286119952, 1516.545036489049, 1540.7457769468137, 1550.7518796992426, 30449.0, 34274.14314642154, 34287.82856085704, 34487.65512344844, 35658.28683426369, 49612.503874960785, 49765.751171243915, 50087.0, 50149.74925125351, 50171.74914125406, 326819.0, 328837.0, 329410.0, 329698.0, 468105.0, 31315.0, 31616.419179040495, 31697.524537132424, 31770.36459270848, 31799.52300715445, 44346.0, 45088.0, 45958.77020614876, 46086.539134608225, 52614.473855260956, 36700.63299366972, 37369.626303736615, 37965.81017094897, 38220.0, 38351.42472862853, 37667.81166094152, 37961.240775184895, 38175.80912095422, 39798.801005994785, 40815.0, 42977.14045719131, 43701.12597748091, 44187.0, 44615.55384446114, 44707.552924470336, 36014.639853601126, 37618.247635046595, 37660.72004565482, 38334.808325959304, 38899.22201555897, 29046.709532905246, 29515.354678843407, 29592.0, 29690.109296721133, 29728.702712972594], "value": 19810.361294815862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.9133027729315, 433.0580986354678, 436.323698267685, 439.09313422503527, 440.1153681100988, 18481.907590462044, 19024.14391352389, 19148.808511914893, 19380.418587442364, 19904.10431530581, 18500.629987400243, 18924.71612925804, 19060.04699765013, 19092.809071909276, 19109.0, 5776.898402134469, 5780.508656764169, 5795.391483894194, 5910.4089591040765, 5920.171176035358, 3813.0657988792786, 5861.53107751381, 5901.4688678018965, 6327.588706734047, 6622.4370928471135, 6569.802905912807, 6573.112629794964, 6591.11020012297, 6595.901061484082, 6604.0, 6387.393197646263, 6420.165378500788, 6539.50953678476, 6550.672466376662, 6565.244996825379, 3966.603339666039, 4108.4864391951005, 5589.524890384281, 5858.970705146447, 5860.824175274749, 23321.766782332128, 23913.0, 23945.52108957811, 24348.80860722526, 24486.877565612234, 2500.2874180858366, 2569.4604133132066, 2584.974150258511, 2600.687917449918, 2671.545837207679, 10147.695569132939, 14550.27248637564, 14683.632909177357, 14809.407623695039, 14979.775303370458, 2015.093208056366, 2052.48687828043, 2058.1458694641706, 2058.5985732782115, 2102.16964299101, 77423.0, 80517.99999999942, 80866.59566702187, 81599.0, 82369.58815205886, 11335.376554289429, 11409.942950285196, 11472.942635286938, 11541.480633371519, 11627.0, 15827.446039388566, 15901.363945442285, 16031.919840400724, 16064.518064458085, 16076.839231607768, 8694.434861733967, 8732.825343493221, 8741.694040708544, 8778.473291602397, 8787.0, 8297.8340433191, 8316.293115085164, 8357.916420835836, 8514.10601886793, 8523.829523409497, 4909.208139029229, 4936.407631084293, 4984.22744474607, 4998.700077995332, 5034.244863270465, 1810.5377031445714, 1918.3765276284985, 1957.549763554362, 2031.4515080928068, 2104.905279262437, 1013.6756238003768, 1027.9023492768174, 1100.2243418390017, 1105.7401510644993, 1134.6369161868122, 18515.0, 18762.24951001972, 19347.0, 19435.51411214731, 19706.507337316394, 1047.3925123428394, 1084.9403282819362, 1108.3682301088463, 1111.766529028897, 1137.397179494869, 10584.364938103738, 10655.786884262272, 10763.977422144884, 10919.617813376493, 11023.118150548098, 542759.0, 550495.0, 568962.0, 573386.0, 574796.0, 62003.0, 87978.56010719905, 102748.0, 103005.0, 103838.48080759699, 1070.5129166229347, 1124.5839039555417, 1127.639155470258, 1168.415792103948, 1175.747214348919, 17389.739153912447, 17591.82408175902, 17776.644467110844, 17880.910595446938, 18145.00202488876, 38988.41517377185, 39281.0, 40047.39928901127, 40727.389089163094, 41006.58993410028, 54747.45252547583, 57284.0, 57445.13832292435, 57592.13611795742, 57705.0, 9179.17387435134, 9252.35233533673, 9273.165415112673, 9394.530273486434, 9411.10594493522, 10864.456777160953, 14094.929525352307, 14157.43370265219, 14205.502807401692, 14237.786433203302, 11695.356755378536, 11711.180217385043, 12226.0, 12626.36868156607, 12747.298898560668, 11367.829482557934, 11553.13351498624, 11778.646640600795, 12204.633860984184, 12701.301428421526, 12026.639200823989, 12257.632271031884, 12323.938380308042, 12665.620031399072, 12955.935220324214, 9039.864402034107, 9200.0, 9201.0, 9243.352965292364, 9362.953185234303, 9526.809463810823, 12697.492100315883, 12734.87265127374, 12828.807567886302, 12892.806607901077], "value": 9685.25016072795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.1890141520742, 1548.318739754508, 1598.9440369587066, 1793.2378739035914, 1901.8858868467885, 7556.471047026704, 7999.0, 8154.3884208684285, 8167.0, 8183.345332373411, 8223.876641850376, 8361.0, 8372.288355489776, 8377.994640643132, 8378.0, 2160.2655097266925, 2216.933491995235, 2350.5298940211983, 2381.4403615150427, 2404.471016376403, 2451.779339859412, 2458.2748089313604, 2460.1635443949053, 2462.5936720441196, 2462.802975761944, 2287.165184707578, 2317.4553979814814, 2319.408550819547, 2332.6850875131895, 2334.36972017556, 2175.369142948543, 2358.702713507581, 2382.285314405671, 2389.175734371639, 2426.344886880532, 2339.894704738291, 2384.0, 2384.0463814474174, 2385.5348207099623, 2386.4033991502124, 8300.501969881827, 8338.04112527055, 8349.874751878726, 8357.373197010249, 8357.83284334316, 5182.481751824825, 5210.452902445227, 5358.437364076754, 5363.061464243741, 5372.382176049765, 3285.5728755261903, 3426.3489936911906, 3426.777259478126, 3437.570303712036, 3509.3683137035323, 1111.3498603317069, 1114.4817659788237, 1114.648885601033, 1158.7624536969986, 1177.1818586082677, 12220.388980550937, 12224.755504889941, 12229.93885030569, 12266.202696824677, 12289.75420491594, 4749.596284315803, 4806.134895718735, 4861.222204447342, 4885.731284779371, 4914.778834952435, 10325.535350909227, 10371.585136594602, 10402.791944161074, 10404.479776011169, 10412.375257484575, 5485.01269771437, 5502.174673798882, 5503.2020357048, 5504.0, 5506.284183056177, 4370.344448332776, 4451.799669014902, 4496.910061798746, 4790.784414701347, 5042.193249080129, 4107.856225032109, 4199.769012704331, 4215.641670457984, 4273.273543497613, 4290.978545107255, 1306.8366454193226, 1361.1424802374638, 1364.7134101838526, 1365.1194979238335, 1372.389286767399, 935.9157675809209, 1083.34999000599, 1092.4373947417087, 1097.4677281518457, 1105.5135740274254, 5913.76344946206, 6066.817995460143, 6171.259448866164, 6181.258249010148, 6189.164462797555, 483.44645381038515, 485.6794515619674, 490.4947903659237, 921.7649499377616, 1115.2416356877238, 4151.584841515824, 4173.353130264813, 4189.581041895847, 4194.496660400771, 4204.0, 10155.984401559932, 10629.9468502657, 10646.680599582025, 10661.0, 10668.946655266674, 10322.638707645347, 10423.843642345371, 10463.947680261703, 10487.0, 10488.370697758159, 8055.919440805634, 8159.755207343789, 8231.588420578948, 8262.710805121913, 8271.1728827118, 5897.0, 5946.554008449297, 5965.164876917148, 6034.818955431344, 6095.817125486243, 9418.340716150078, 9490.05099490073, 9584.568694408908, 9679.612815487302, 9696.369735967139, 9622.951885240529, 9755.80488390214, 9788.657396991071, 9832.410055396698, 10015.749606259902, 6617.669116544057, 7059.929400705927, 7186.784396468114, 7388.039554857834, 7500.399968002655, 8159.632816523389, 8175.754727358189, 8190.344772418312, 8211.548364839991, 8235.83528329442, 7227.8554428912175, 7388.076490438695, 7451.81370465721, 7470.514416562906, 7507.849843003219, 7167.462440317101, 7407.111146662435, 7431.108267007994, 7511.173770885308, 7520.059992500937, 6793.592384456949, 6830.282820303796, 6966.059581956573, 7014.789556313319, 7017.859642807218, 5171.431142574239, 5175.92236116451, 5208.140656791587, 5290.28581141541, 5438.945610543844, 5169.563892953297, 5171.9482805172975, 5228.921566176435, 5251.553617942518, 5291.417944026231], "value": 4602.100600937825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.199942128186, 365.35879531422347, 368.5227630218867, 369.4347648098409, 373.458485196465, 6199.597026193294, 6201.906971395427, 6235.127082208494, 6269.247690277161, 6289.339619339967, 6147.723352449139, 6147.723352449139, 6154.507639388849, 6159.8768024639485, 6166.599171053889, 4574.634029277659, 4672.135654903854, 4738.360321356625, 4755.45312289086, 4766.213574760161, 4713.43438787346, 4746.074515469485, 4749.240121580548, 4762.3094651275715, 4763.476017638057, 4590.97704511477, 4741.644376671747, 4781.617470602343, 4781.856544303677, 4792.113459010076, 4631.768411579441, 4709.987352719165, 4726.574608285271, 4742.644301677354, 4755.785989630475, 4159.334506478949, 4187.016051227959, 4199.181159673864, 4210.200061988213, 4227.957720422818, 5927.347991720907, 5931.466168044896, 5941.554383421218, 5944.851378715523, 5947.10793380992, 5544.944550554484, 5578.330600327987, 5579.191017302509, 5600.131979543177, 5604.943950560483, 6465.644389558573, 6578.868422631568, 6596.505262105314, 6599.868002639968, 6602.471802255808, 4710.599599034086, 4723.36234608327, 4729.385179926622, 4736.9526304736855, 4737.976310118462, 6876.037354770337, 6905.274946130685, 6910.7581234656545, 6916.515843890929, 6920.204176519664, 4830.492798256203, 4831.975840120777, 4832.685875418087, 4837.0, 4838.516148385133, 4893.143699852511, 4900.656954013256, 4903.41159060915, 4906.215005599087, 4910.90178196434, 5593.188987596775, 5597.916031259534, 5597.944020559824, 5602.0, 5604.047311956896, 6508.316626754217, 6669.966650166718, 6678.0, 6685.966570167216, 6692.297308782605, 1709.444430560048, 1719.7678313427778, 1726.0765490462543, 1728.4987353667548, 1728.8530474909521, 1105.2539535813455, 1149.6723433821487, 1157.4617802721775, 1174.142875700726, 1175.9941200293945, 6264.373562643699, 6414.03789431589, 6430.099786029959, 6436.227652681709, 6436.774712885027, 6889.138857642794, 6926.619035953071, 6928.7228510859, 6933.722651094001, 6937.0, 6488.870222595521, 6504.9674751625935, 6507.707153178024, 6513.316101809241, 6519.054737063099, 3681.5398075240596, 3722.758020728644, 3724.5902950675404, 3727.962720372816, 3728.067983004249, 6989.266127056688, 7125.643717814089, 7128.716830970475, 7139.357457828716, 7187.0, 7079.752208672672, 7084.92915070853, 7102.0, 7102.360787529044, 7127.857442851114, 7159.89260161098, 7167.677454514559, 7171.067761191011, 7173.6771845267085, 7188.101487313981, 6913.446924245947, 6916.031755554126, 6916.861662766616, 6921.304280451322, 6931.2375638678695, 6631.801045968628, 6838.487113466609, 6844.760433384808, 6924.896126558005, 6928.3764461196715, 7154.141503019671, 7155.105611798525, 7175.2465991070185, 7178.4257259420165, 7185.748498802726, 4884.145274577006, 4887.951120488749, 4890.951090489192, 4894.094592500399, 4895.118878601886, 6912.44700423975, 6915.343042410963, 6918.688659010458, 6922.134733158356, 6922.411595014279, 6494.772682956074, 6695.933040669531, 6733.326667333227, 6734.696938637871, 6760.3239676032, 6700.0, 6702.765403210864, 6705.631190284386, 6719.328067193437, 6724.327567243236, 6599.67001649906, 6622.0, 6625.304343043911, 6627.3372662733345, 6634.83412914681, 6735.427488663322, 6740.831479213059, 6741.561798483083, 6743.393094621508, 6744.7976560703255, 6288.5598008138995, 6391.58454700443, 6425.614463132227, 6454.19322584677, 6590.538662293593], "value": 5051.9367859169615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.3369569561568, 827.7433995461407, 884.1865483754945, 884.5432999811587, 898.9101089891008, 14792.926035369821, 15132.848671513282, 15258.69482610347, 15270.541883743477, 15287.92356038221, 14077.648058798535, 14128.576142715736, 14140.787888181685, 14142.64643383916, 14144.71710565788, 733.9853202935951, 778.1401551285833, 778.5445514374098, 778.7196609220676, 894.1907573645829, 913.4975763330175, 913.6528119314651, 913.8629205619177, 914.6295750221171, 915.2632131134434, 970.0493516353978, 973.2797729680021, 973.634886917406, 973.6640858903702, 974.2692980264801, 786.8268980824209, 928.1414691410419, 960.5725452173785, 960.9567569459356, 969.8642190093393, 703.9859202815966, 705.1643802094534, 705.3017512662478, 708.3837061756253, 710.8365076032542, 14650.0, 14724.0, 14766.630834229123, 14827.77758333626, 14843.628909277246, 14565.927170364186, 15059.849401505955, 15082.698346033018, 15123.848761512465, 15183.392664293415, 12129.454174562166, 12265.448054837465, 12348.938255308756, 12354.38228088601, 12357.32034738089, 4051.9594804051876, 4086.3257562502154, 4088.2028004539125, 4100.200460910124, 4117.341225403921, 60307.396926031055, 60379.39620603782, 60392.094118588255, 60638.090428643605, 60828.087578686354, 10711.143108551452, 10766.56933722658, 11054.170937179744, 11108.555657773599, 11535.826962595567, 20458.0, 20499.8975005124, 20555.58888822215, 20581.970901454868, 20598.073086711134, 8247.0, 8274.172582741678, 8339.666413343519, 8356.637115487609, 8526.616302266413, 4831.251156070814, 4894.388201474816, 4902.093112774148, 4906.558409743069, 5048.268001139888, 3779.829907654162, 3851.1334949636107, 3854.2291541691775, 3856.2287542491613, 3856.5564960029956, 654.3325807676143, 657.976970806029, 661.5005670718576, 668.4251543672437, 669.1735706402588, 750.0624219725344, 800.2797482266008, 801.8133162918913, 805.4281460163232, 814.8207394373347, 9459.810284573141, 9637.18083962857, 9684.757881052888, 9727.756806079904, 9878.0, 772.2547741429547, 778.8442311537602, 783.6473586885924, 785.3285440947907, 796.4186144114828, 4708.717476951394, 4719.4100737407825, 4739.526047395302, 4739.668223224341, 4816.128615574153, 69214.65392673106, 69670.0, 69821.0, 70291.64854175696, 70355.0, 57577.71211143918, 58410.12384814231, 58448.41551584515, 58780.41219587835, 58793.412065878794, 53566.464335356926, 53660.19509707358, 53888.461115388345, 54246.728766356704, 54950.45049549533, 9250.676226332045, 9295.86056209171, 9360.672376466791, 9404.106609872051, 9405.153536181777, 40252.0, 41667.7916610415, 41715.16569668529, 41816.58183418127, 42163.578364215966, 49339.25991110064, 52005.47994520158, 52574.47425525849, 52580.737096314275, 53178.0, 11483.138764592522, 11716.355600442057, 11771.587994420153, 11779.116566257393, 11852.585159519376, 12946.223226606433, 13043.608691739262, 13089.214647121204, 13244.801327979896, 13307.866921330662, 11989.880101199225, 12383.380830958236, 12518.248905065726, 12604.432800524182, 12621.432035558606, 12981.350932453151, 13140.540081097115, 13348.866511334762, 13393.531226407029, 13454.730905382034, 12644.810327844905, 12689.682757930756, 12899.226046437243, 12974.610761677164, 13316.201027938354, 10765.677029689123, 10813.405262710627, 10946.233763636468, 11535.077193824307, 11695.298282103102, 11206.43967801623, 11307.0, 11536.884631153582, 11567.942160289145, 11589.362585057903], "value": 7196.1886475475685, "unit": "score"}], "name": "dromaeo_css", "value": 7510.1354883888325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 110.0, 112.0, 109.0, 110.0, 110.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 160.0, 178.0, 128.0, 162.0, 155.0, 132.0, 188.0, 131.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 163.0, 161.0, 161.0, 161.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 176.0, 76.0, 76.0, 75.0, 75.0, 161.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 148.0, 91.0, 92.0, 92.0, 142.0, 93.0, 92.0, 150.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 59.0, 56.0, 57.0, 53.0, 57.0, 72.0, 54.0, 53.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 58.0, 59.0, 59.0, 60.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 113.0, 117.0, 111.0, 110.0, 111.0, 112.0, 128.0, 130.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 155.0, 156.0, 160.0, 161.0, 163.0, 156.0, 157.0, 156.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 66.0, 68.0, 66.0, 65.0, 66.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1512.5999999999997, "alertThreshold": 2.0}]} 12:41:20 INFO - Return code: 0 12:41:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:41:20 ERROR - # TBPL SUCCESS # 12:41:20 INFO - Running post-action listener: _resource_record_post_action 12:41:20 INFO - Running post-run listener: _resource_record_post_run 12:41:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498012160; Read time: 12; Write time: 337648 12:41:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249360384; Read time: 0; Write time: 210924 12:41:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248651776; Read time: 12; Write time: 126724 12:41:21 INFO - Running post-run listener: _upload_blobber_files 12:41:21 INFO - Blob upload gear active. 12:41:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:21 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 12:41:21 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:41:21 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:41:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:23 INFO - (blobuploader) - INFO - Done attempting. 12:41:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:23 INFO - (blobuploader) - INFO - Done attempting. 12:41:23 INFO - (blobuploader) - INFO - Iteration through files over. 12:41:24 INFO - Return code: 0 12:41:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:41:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:41:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/928cf3a1ddcf383c876e95635e42bdd87b11dbfe1c0bc1945669c5c491d4f6859f9546143799325551d05fe6e6c4098b3fc44dd86b04ed0d523c02f558212004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dde3769a34f25e28fa137c5d7acba7ce8c078e8f7a9217bbe30c748e567e2a5868309b87898174144e9b52ac13576f59b8d0c0b25478a7aa68442256b26d9884"} 12:41:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:41:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:41:24 INFO - Contents: 12:41:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/928cf3a1ddcf383c876e95635e42bdd87b11dbfe1c0bc1945669c5c491d4f6859f9546143799325551d05fe6e6c4098b3fc44dd86b04ed0d523c02f558212004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dde3769a34f25e28fa137c5d7acba7ce8c078e8f7a9217bbe30c748e567e2a5868309b87898174144e9b52ac13576f59b8d0c0b25478a7aa68442256b26d9884"} 12:41:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:41:24 INFO - Copying logs to upload dir... 12:41:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:41:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.125223 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 12:41:23.567732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 12:41:23.572269) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 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-Aurora/sha512/928cf3a1ddcf383c876e95635e42bdd87b11dbfe1c0bc1945669c5c491d4f6859f9546143799325551d05fe6e6c4098b3fc44dd86b04ed0d523c02f558212004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dde3769a34f25e28fa137c5d7acba7ce8c078e8f7a9217bbe30c748e567e2a5868309b87898174144e9b52ac13576f59b8d0c0b25478a7aa68442256b26d9884"} build_url:https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/D0K9XhXFSZW2R3tq5rn_hQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/928cf3a1ddcf383c876e95635e42bdd87b11dbfe1c0bc1945669c5c491d4f6859f9546143799325551d05fe6e6c4098b3fc44dd86b04ed0d523c02f558212004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dde3769a34f25e28fa137c5d7acba7ce8c078e8f7a9217bbe30c748e567e2a5868309b87898174144e9b52ac13576f59b8d0c0b25478a7aa68442256b26d9884"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 12:41:23.600012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:41:23.600659) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464376018.397490-11568810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 12:41:23.683054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 12:41:23.683585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 12:41:23.684078) ========= ========= Total master_lag: 0.20 =========