builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1469617277.83 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:17.833173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:17.833765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:17.834050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:17.849195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:17.849687) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:18-- 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% 226M=0s 2016-07-27 04:01:18 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.003392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.003781) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019709 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.053121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.056547) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --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=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:18,594 truncating revision to first 12 chars 2016-07-27 04:01:18,594 Setting DEBUG logging. 2016-07-27 04:01:18,594 attempt 1/10 2016-07-27 04:01:18,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:01:18,919 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.732312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.732628) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.733015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.733303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:18.743785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-27 04:01:18.744114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:19 INFO - MultiFileLogger online at 20160727 04:01:19 in /builds/slave/test 04:01:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:01:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:19 INFO - {'append_to_log': False, 04:01:19 INFO - 'base_work_dir': '/builds/slave/test', 04:01:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:01:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:19 INFO - 'branch': 'Mozilla-Beta', 04:01:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:19 INFO - 'config_files': ('talos/linux_config.py',), 04:01:19 INFO - 'default_actions': ('clobber', 04:01:19 INFO - 'read-buildbot-config', 04:01:19 INFO - 'download-and-extract', 04:01:19 INFO - 'populate-webroot', 04:01:19 INFO - 'create-virtualenv', 04:01:19 INFO - 'install', 04:01:19 INFO - 'run-tests'), 04:01:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:19 INFO - 'download_minidump_stackwalk': True, 04:01:19 INFO - 'download_symbols': 'ondemand', 04:01:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:19 INFO - 'installer_path': 'installer.exe', 04:01:19 INFO - 'log_level': 'info', 04:01:19 INFO - 'log_name': 'talos', 04:01:19 INFO - 'log_to_console': True, 04:01:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:19 INFO - 'opt_config_files': (), 04:01:19 INFO - 'pip_index': False, 04:01:19 INFO - 'sps_profile': False, 04:01:19 INFO - 'sps_profile_interval': 0, 04:01:19 INFO - 'suite': 'dromaeojs', 04:01:19 INFO - 'system_bits': '32', 04:01:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:19 INFO - 'title': 'talos-linux64-ix-006', 04:01:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:19 INFO - 'use_talos_json': True, 04:01:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:19 INFO - 'work_dir': 'build'} 04:01:19 INFO - ##### 04:01:19 INFO - ##### Running clobber step. 04:01:19 INFO - ##### 04:01:19 INFO - Running pre-action listener: _resource_record_pre_action 04:01:19 INFO - Running main action method: clobber 04:01:19 INFO - rmtree: /builds/slave/test/build 04:01:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:19 INFO - Running post-action listener: _resource_record_post_action 04:01:19 INFO - ##### 04:01:19 INFO - ##### Running read-buildbot-config step. 04:01:19 INFO - ##### 04:01:19 INFO - Running pre-action listener: _resource_record_pre_action 04:01:19 INFO - Running main action method: read_buildbot_config 04:01:19 INFO - Using buildbot properties: 04:01:19 INFO - { 04:01:19 INFO - "project": "", 04:01:19 INFO - "product": "firefox", 04:01:19 INFO - "script_repo_revision": "production", 04:01:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:01:19 INFO - "repository": "", 04:01:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:01:19 INFO - "buildid": "20160726073802", 04:01:19 INFO - "pgo_build": "True", 04:01:19 INFO - "basedir": "/builds/slave/test", 04:01:19 INFO - "buildnumber": 112, 04:01:19 INFO - "slavename": "talos-linux64-ix-006", 04:01:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:01:19 INFO - "platform": "ubuntu64_hw", 04:01:19 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:19 INFO - "branch": "mozilla-beta", 04:01:19 INFO - "repo_path": "releases/mozilla-beta", 04:01:19 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:19 INFO - "stage_platform": "linux64-pgo", 04:01:19 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:19 INFO - "slavebuilddir": "test" 04:01:19 INFO - } 04:01:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 04:01:19 INFO - Running post-action listener: _resource_record_post_action 04:01:19 INFO - ##### 04:01:19 INFO - ##### Running download-and-extract step. 04:01:19 INFO - ##### 04:01:19 INFO - Running pre-action listener: _resource_record_pre_action 04:01:19 INFO - Running main action method: download_and_extract 04:01:19 INFO - mkdir: /builds/slave/test/build/tests 04:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:19 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:01:20 INFO - Downloaded 1327 bytes. 04:01:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:20 INFO - Using the following test package requirements: 04:01:20 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:20 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:20 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'jsshell-linux-x86_64.zip'], 04:01:20 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:20 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:20 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:20 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:20 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:20 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:20 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01: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')]} 04:01:20 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:21 INFO - Downloaded 24199952 bytes. 04:01:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:22 INFO - Return code: 0 04:01:22 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:22 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:23 INFO - Downloaded 24199952 bytes. 04:01:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:25 INFO - Return code: 0 04:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:25 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:01:26 INFO - Downloaded 10840145 bytes. 04:01:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:01:26 INFO - Return code: 0 04:01:26 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')]} 04:01:26 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:01:27 INFO - Downloaded 56024276 bytes. 04:01:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:27 INFO - mkdir: /builds/slave/test/properties 04:01:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:27 INFO - Contents: 04:01:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:28 INFO - Running post-action listener: _resource_record_post_action 04:01:28 INFO - Running post-action listener: set_extra_try_arguments 04:01:28 INFO - ##### 04:01:28 INFO - ##### Running populate-webroot step. 04:01:28 INFO - ##### 04:01:28 INFO - Running pre-action listener: _resource_record_pre_action 04:01:28 INFO - Running main action method: populate_webroot 04:01:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:28 INFO - '--tppagecycles', 04:01:28 INFO - '7'], 04:01:28 INFO - 'tests': ['tsvgm']}}, 04:01:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['damp', 'tps']}, 04:01:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'tests': ['damp', 'tps']}, 04:01:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['dromaeo_dom']}, 04:01:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['a11yr', 04:01:28 INFO - 'ts_paint', 04:01:28 INFO - 'tpaint', 04:01:28 INFO - 'sessionrestore', 04:01:28 INFO - 'sessionrestore_no_auto_restore', 04:01:28 INFO - 'tabpaint']}, 04:01:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['tsvgx', 04:01:28 INFO - 'tsvgr_opacity', 04:01:28 INFO - 'tart', 04:01:28 INFO - 'tscrollx', 04:01:28 INFO - 'cart']}, 04:01:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:28 INFO - 'tsvgr_opacity', 04:01:28 INFO - 'tart', 04:01:28 INFO - 'tscrollx', 04:01:28 INFO - 'cart']}, 04:01:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'talos_options': ['--disable-e10s'], 04:01:28 INFO - 'tests': ['tp5o']}, 04:01:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'tests': ['tp5o']}, 04:01:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'talos_options': ['--disable-e10s', 04:01:28 INFO - '--xperf_path', 04:01:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:28 INFO - 'tests': ['tp5n']}, 04:01:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:28 INFO - 'talos_options': ['--xperf_path', 04:01:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:28 INFO - 'tests': ['tp5n']}}, 04:01:28 INFO - 'talos.zip': {'path': '', 04:01:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:28 INFO - Running post-action listener: _resource_record_post_action 04:01:28 INFO - ##### 04:01:28 INFO - ##### Running create-virtualenv step. 04:01:28 INFO - ##### 04:01:28 INFO - Running pre-action listener: _resource_record_pre_action 04:01:28 INFO - Running main action method: create_virtualenv 04:01:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:28 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 04:01:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:28 INFO - Using real prefix '/usr' 04:01:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:30 INFO - Installing pip.................done. 04:01:30 INFO - Return code: 0 04:01:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:30 INFO - Using env: {'DISPLAY': ':0', 04:01:30 INFO - 'HOME': '/home/cltbld', 04:01:30 INFO - 'LANG': 'en_US.UTF-8', 04:01:30 INFO - 'LANGUAGE': 'en_US:en', 04:01:30 INFO - 'LOGNAME': 'cltbld', 04:01:30 INFO - 'MAIL': '/var/mail/cltbld', 04:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:30 INFO - 'MOZ_NO_REMOTE': '1', 04:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:30 INFO - 'NO_EM_RESTART': '1', 04:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:30 INFO - 'PWD': '/builds/slave/test', 04:01:30 INFO - 'SHELL': '/bin/bash', 04:01:30 INFO - 'SHLVL': '1', 04:01:30 INFO - 'TERM': 'linux', 04:01:30 INFO - 'TMOUT': '86400', 04:01:30 INFO - 'USER': 'cltbld', 04:01:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:30 INFO - '_': '/tools/buildbot/bin/python'} 04:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:31 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 04:01:31 INFO - Cleaning up... 04:01:31 INFO - Return code: 0 04:01:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:31 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')]} 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:31 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')]} 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:31 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:31 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 04:01:31 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 04:01:31 INFO - Using env: {'DISPLAY': ':0', 04:01:31 INFO - 'HOME': '/home/cltbld', 04:01:31 INFO - 'LANG': 'en_US.UTF-8', 04:01:31 INFO - 'LANGUAGE': 'en_US:en', 04:01:31 INFO - 'LOGNAME': 'cltbld', 04:01:31 INFO - 'MAIL': '/var/mail/cltbld', 04:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:31 INFO - 'MOZ_NO_REMOTE': '1', 04:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:31 INFO - 'NO_EM_RESTART': '1', 04:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:31 INFO - 'PWD': '/builds/slave/test', 04:01:31 INFO - 'SHELL': '/bin/bash', 04:01:31 INFO - 'SHLVL': '1', 04:01:31 INFO - 'TERM': 'linux', 04:01:31 INFO - 'TMOUT': '86400', 04:01:31 INFO - 'USER': 'cltbld', 04:01:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:31 INFO - '_': '/tools/buildbot/bin/python'} 04:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:31 INFO - Downloading/unpacking psutil>=0.7.1 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:33 INFO - Installing collected packages: psutil 04:01:33 INFO - Running setup.py install for psutil 04:01:33 INFO - building 'psutil._psutil_linux' extension 04:01:33 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 04:01:33 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 04:01:33 INFO - building 'psutil._psutil_posix' extension 04:01:33 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 04:01:33 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 04:01:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:33 INFO - Successfully installed psutil 04:01:33 INFO - Cleaning up... 04:01:33 INFO - Return code: 0 04:01:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:33 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')]} 04:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:33 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')]} 04:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:33 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:33 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 04:01:33 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 04:01:33 INFO - Using env: {'DISPLAY': ':0', 04:01:33 INFO - 'HOME': '/home/cltbld', 04:01:33 INFO - 'LANG': 'en_US.UTF-8', 04:01:33 INFO - 'LANGUAGE': 'en_US:en', 04:01:33 INFO - 'LOGNAME': 'cltbld', 04:01:33 INFO - 'MAIL': '/var/mail/cltbld', 04:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:33 INFO - 'MOZ_NO_REMOTE': '1', 04:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:33 INFO - 'NO_EM_RESTART': '1', 04:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:33 INFO - 'PWD': '/builds/slave/test', 04:01:33 INFO - 'SHELL': '/bin/bash', 04:01:33 INFO - 'SHLVL': '1', 04:01:33 INFO - 'TERM': 'linux', 04:01:33 INFO - 'TMOUT': '86400', 04:01:33 INFO - 'USER': 'cltbld', 04:01:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:33 INFO - '_': '/tools/buildbot/bin/python'} 04:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:35 INFO - Installing collected packages: mozsystemmonitor 04:01:35 INFO - Running setup.py install for mozsystemmonitor 04:01:36 INFO - Successfully installed mozsystemmonitor 04:01:36 INFO - Cleaning up... 04:01:36 INFO - Return code: 0 04:01:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:01:36 INFO - Using env: {'DISPLAY': ':0', 04:01:36 INFO - 'HOME': '/home/cltbld', 04:01:36 INFO - 'LANG': 'en_US.UTF-8', 04:01:36 INFO - 'LANGUAGE': 'en_US:en', 04:01:36 INFO - 'LOGNAME': 'cltbld', 04:01:36 INFO - 'MAIL': '/var/mail/cltbld', 04:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:36 INFO - 'MOZ_NO_REMOTE': '1', 04:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:36 INFO - 'NO_EM_RESTART': '1', 04:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:36 INFO - 'PWD': '/builds/slave/test', 04:01:36 INFO - 'SHELL': '/bin/bash', 04:01:36 INFO - 'SHLVL': '1', 04:01:36 INFO - 'TERM': 'linux', 04:01:36 INFO - 'TMOUT': '86400', 04:01:36 INFO - 'USER': 'cltbld', 04:01:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:36 INFO - '_': '/tools/buildbot/bin/python'} 04:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:38 INFO - Downloading docopt-0.6.1.tar.gz 04:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:39 INFO - Running setup.py install for blobuploader 04:01:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:39 INFO - Running setup.py install for requests 04:01:39 INFO - Running setup.py install for docopt 04:01:39 INFO - Successfully installed blobuploader requests docopt 04:01:39 INFO - Cleaning up... 04:01:39 INFO - Return code: 0 04:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:39 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 04:01:39 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 04:01:39 INFO - Using env: {'DISPLAY': ':0', 04:01:39 INFO - 'HOME': '/home/cltbld', 04:01:39 INFO - 'LANG': 'en_US.UTF-8', 04:01:39 INFO - 'LANGUAGE': 'en_US:en', 04:01:39 INFO - 'LOGNAME': 'cltbld', 04:01:39 INFO - 'MAIL': '/var/mail/cltbld', 04:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:39 INFO - 'MOZ_NO_REMOTE': '1', 04:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:39 INFO - 'NO_EM_RESTART': '1', 04:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:39 INFO - 'PWD': '/builds/slave/test', 04:01:39 INFO - 'SHELL': '/bin/bash', 04:01:39 INFO - 'SHLVL': '1', 04:01:39 INFO - 'TERM': 'linux', 04:01:39 INFO - 'TMOUT': '86400', 04:01:39 INFO - 'USER': 'cltbld', 04:01:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:39 INFO - '_': '/tools/buildbot/bin/python'} 04:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:39 INFO - Running setup.py (path:/tmp/pip-C62E5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:39 INFO - Running setup.py (path:/tmp/pip-F4j6sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:40 INFO - Running setup.py (path:/tmp/pip-ERfI4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:40 INFO - Running setup.py (path:/tmp/pip-DifObp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:40 INFO - Running setup.py (path:/tmp/pip-mFz7lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:40 INFO - Running setup.py (path:/tmp/pip-adJB8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:40 INFO - Running setup.py (path:/tmp/pip-WSOrqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:40 INFO - Running setup.py (path:/tmp/pip-hSO60G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:40 INFO - Running setup.py (path:/tmp/pip-y9RQNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:40 INFO - Running setup.py (path:/tmp/pip-H8pXqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:40 INFO - Running setup.py (path:/tmp/pip-iiZACv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:40 INFO - Running setup.py (path:/tmp/pip-2DqMa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:40 INFO - Running setup.py (path:/tmp/pip-zxgqkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:40 INFO - Running setup.py (path:/tmp/pip-znal7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:40 INFO - Running setup.py (path:/tmp/pip-O_IVDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:40 INFO - Running setup.py (path:/tmp/pip-J94TjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:41 INFO - Running setup.py (path:/tmp/pip-w6aRnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:41 INFO - Running setup.py install for manifestparser 04:01:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Running setup.py install for mozcrash 04:01:41 INFO - Running setup.py install for mozdebug 04:01:41 INFO - Running setup.py install for mozdevice 04:01:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Running setup.py install for mozfile 04:01:41 INFO - Running setup.py install for mozhttpd 04:01:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Running setup.py install for mozinfo 04:01:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Running setup.py install for mozInstall 04:01:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:41 INFO - Running setup.py install for mozleak 04:01:42 INFO - Running setup.py install for mozlog 04:01:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Running setup.py install for moznetwork 04:01:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Running setup.py install for mozprocess 04:01:42 INFO - Running setup.py install for mozprofile 04:01:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Running setup.py install for mozrunner 04:01:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Running setup.py install for mozscreenshot 04:01:42 INFO - Running setup.py install for moztest 04:01:42 INFO - Running setup.py install for mozversion 04:01:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:42 INFO - Cleaning up... 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:42 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 04:01:42 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 04:01:42 INFO - Using env: {'DISPLAY': ':0', 04:01:42 INFO - 'HOME': '/home/cltbld', 04:01:42 INFO - 'LANG': 'en_US.UTF-8', 04:01:42 INFO - 'LANGUAGE': 'en_US:en', 04:01:42 INFO - 'LOGNAME': 'cltbld', 04:01:42 INFO - 'MAIL': '/var/mail/cltbld', 04:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:42 INFO - 'MOZ_NO_REMOTE': '1', 04:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:42 INFO - 'NO_EM_RESTART': '1', 04:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:42 INFO - 'PWD': '/builds/slave/test', 04:01:42 INFO - 'SHELL': '/bin/bash', 04:01:42 INFO - 'SHLVL': '1', 04:01:42 INFO - 'TERM': 'linux', 04:01:42 INFO - 'TMOUT': '86400', 04:01:42 INFO - 'USER': 'cltbld', 04:01:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:42 INFO - '_': '/tools/buildbot/bin/python'} 04:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:43 INFO - Running setup.py (path:/tmp/pip-uzCrjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:43 INFO - Running setup.py (path:/tmp/pip-LryGht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:43 INFO - Running setup.py (path:/tmp/pip-n8d7ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:43 INFO - Running setup.py (path:/tmp/pip-RsM1CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:43 INFO - Running setup.py (path:/tmp/pip-wkOBjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:43 INFO - Running setup.py (path:/tmp/pip-aBQBYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:43 INFO - Running setup.py (path:/tmp/pip-v0JCyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:43 INFO - Running setup.py (path:/tmp/pip-zv10FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:43 INFO - Running setup.py (path:/tmp/pip-CWVpPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:43 INFO - Running setup.py (path:/tmp/pip-zrlPRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:43 INFO - Running setup.py (path:/tmp/pip-4cSoZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:43 INFO - Running setup.py (path:/tmp/pip-KfwotZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:43 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)) 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:43 INFO - Running setup.py (path:/tmp/pip-qt11oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:44 INFO - Running setup.py (path:/tmp/pip-7jFkmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:44 INFO - Running setup.py (path:/tmp/pip-zmYftC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:44 INFO - Running setup.py (path:/tmp/pip-khtj6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:44 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)) 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:44 INFO - Running setup.py (path:/tmp/pip-ijZcgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:44 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)) 04:01:44 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)) 04:01:44 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)) 04:01:44 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)) 04:01:44 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)) 04:01:44 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)) 04:01:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:46 INFO - Downloading blessings-1.6.tar.gz 04:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:46 INFO - Installing collected packages: blessings 04:01:46 INFO - Running setup.py install for blessings 04:01:46 INFO - Successfully installed blessings 04:01:46 INFO - Cleaning up... 04:01:46 INFO - Return code: 0 04:01:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:46 INFO - Reading from file tmpfile_stdout 04:01:46 INFO - Current package versions: 04:01:46 INFO - argparse == 1.2.1 04:01:46 INFO - blessings == 1.6 04:01:46 INFO - blobuploader == 1.2.4 04:01:46 INFO - docopt == 0.6.1 04:01:46 INFO - manifestparser == 1.1 04:01:46 INFO - mozInstall == 1.12 04:01:46 INFO - mozcrash == 0.17 04:01:46 INFO - mozdebug == 0.1 04:01:46 INFO - mozdevice == 0.48 04:01:46 INFO - mozfile == 1.2 04:01:46 INFO - mozhttpd == 0.7 04:01:46 INFO - mozinfo == 0.9 04:01:46 INFO - mozleak == 0.1 04:01:46 INFO - mozlog == 3.1 04:01:46 INFO - moznetwork == 0.27 04:01:46 INFO - mozprocess == 0.22 04:01:46 INFO - mozprofile == 0.28 04:01:46 INFO - mozrunner == 6.11 04:01:46 INFO - mozscreenshot == 0.1 04:01:46 INFO - mozsystemmonitor == 0.0 04:01:46 INFO - moztest == 0.7 04:01:46 INFO - mozversion == 1.4 04:01:46 INFO - psutil == 3.1.1 04:01:46 INFO - requests == 1.2.3 04:01:46 INFO - wsgiref == 0.1.2 04:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:46 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:46 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 04:01:46 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 04:01:46 INFO - Using env: {'DISPLAY': ':0', 04:01:46 INFO - 'HOME': '/home/cltbld', 04:01:46 INFO - 'LANG': 'en_US.UTF-8', 04:01:46 INFO - 'LANGUAGE': 'en_US:en', 04:01:46 INFO - 'LOGNAME': 'cltbld', 04:01:46 INFO - 'MAIL': '/var/mail/cltbld', 04:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:46 INFO - 'MOZ_NO_REMOTE': '1', 04:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:46 INFO - 'NO_EM_RESTART': '1', 04:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:46 INFO - 'PWD': '/builds/slave/test', 04:01:46 INFO - 'SHELL': '/bin/bash', 04:01:46 INFO - 'SHLVL': '1', 04:01:46 INFO - 'TERM': 'linux', 04:01:46 INFO - 'TMOUT': '86400', 04:01:46 INFO - 'USER': 'cltbld', 04:01:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:46 INFO - '_': '/tools/buildbot/bin/python'} 04:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 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)) 04:01:46 INFO - Cleaning up... 04:01:46 INFO - Return code: 0 04:01:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:46 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:46 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 04:01:46 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 04:01:46 INFO - Using env: {'DISPLAY': ':0', 04:01:46 INFO - 'HOME': '/home/cltbld', 04:01:46 INFO - 'LANG': 'en_US.UTF-8', 04:01:46 INFO - 'LANGUAGE': 'en_US:en', 04:01:46 INFO - 'LOGNAME': 'cltbld', 04:01:46 INFO - 'MAIL': '/var/mail/cltbld', 04:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:46 INFO - 'MOZ_NO_REMOTE': '1', 04:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:46 INFO - 'NO_EM_RESTART': '1', 04:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:46 INFO - 'PWD': '/builds/slave/test', 04:01:46 INFO - 'SHELL': '/bin/bash', 04:01:46 INFO - 'SHLVL': '1', 04:01:46 INFO - 'TERM': 'linux', 04:01:46 INFO - 'TMOUT': '86400', 04:01:46 INFO - 'USER': 'cltbld', 04:01:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:46 INFO - '_': '/tools/buildbot/bin/python'} 04:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:47 INFO - Downloading/unpacking jsonschema 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:49 INFO - warning: no files found matching '*.txt' 04:01:49 INFO - no previously-included directories found matching 'build' 04:01:49 INFO - no previously-included directories found matching 'dist' 04:01:49 INFO - no previously-included directories found matching '.git*' 04:01:49 INFO - Installing collected packages: jsonschema, functools32 04:01:49 INFO - Running setup.py install for functools32 04:01:49 INFO - warning: no files found matching '*.txt' 04:01:49 INFO - no previously-included directories found matching 'build' 04:01:49 INFO - no previously-included directories found matching 'dist' 04:01:49 INFO - no previously-included directories found matching '.git*' 04:01:49 INFO - Successfully installed jsonschema functools32 04:01:49 INFO - Cleaning up... 04:01:49 INFO - Return code: 0 04:01:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01:49 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')]} 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:49 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')]} 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:49 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 0x7fb78570df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', '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 04:01:49 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 04:01:49 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 04:01:49 INFO - Using env: {'DISPLAY': ':0', 04:01:49 INFO - 'HOME': '/home/cltbld', 04:01:49 INFO - 'LANG': 'en_US.UTF-8', 04:01:49 INFO - 'LANGUAGE': 'en_US:en', 04:01:49 INFO - 'LOGNAME': 'cltbld', 04:01:49 INFO - 'MAIL': '/var/mail/cltbld', 04:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:49 INFO - 'MOZ_NO_REMOTE': '1', 04:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:49 INFO - 'NO_EM_RESTART': '1', 04:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:49 INFO - 'PWD': '/builds/slave/test', 04:01:49 INFO - 'SHELL': '/bin/bash', 04:01:49 INFO - 'SHLVL': '1', 04:01:49 INFO - 'TERM': 'linux', 04:01:49 INFO - 'TMOUT': '86400', 04:01:49 INFO - 'USER': 'cltbld', 04:01:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:49 INFO - '_': '/tools/buildbot/bin/python'} 04:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:49 INFO - Downloading/unpacking flake8 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01:52 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 04:01:52 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 04:01:52 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 04:01:52 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 04:01:52 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 04:01:52 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 04:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:52 INFO - no previously-included directories found matching 'docs/_build' 04:01:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:52 INFO - Running setup.py install for pep8 04:01:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:52 INFO - no previously-included directories found matching 'docs/_build' 04:01:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Running post-action listener: _resource_record_post_action 04:01:52 INFO - Running post-action listener: _start_resource_monitoring 04:01:52 INFO - Starting resource monitoring. 04:01:52 INFO - ##### 04:01:52 INFO - ##### Running install step. 04:01:52 INFO - ##### 04:01:52 INFO - Running pre-action listener: _resource_record_pre_action 04:01:52 INFO - Running main action method: install 04:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:52 INFO - Reading from file tmpfile_stdout 04:01:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:52 INFO - Reading from file tmpfile_stdout 04:01:52 INFO - Output received: 04:01:52 INFO - Usage: mozinstall [options] installer 04:01:52 INFO - Options: 04:01:52 INFO - -h, --help show this help message and exit 04:01:52 INFO - -d DEST, --destination=DEST 04:01:52 INFO - Directory to install application into. [default: 04:01:52 INFO - "/builds/slave/test"] 04:01:52 INFO - --app=APP Application being installed. [default: firefox] 04:01:52 INFO - mkdir: /builds/slave/test/build/application 04:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:02:06 INFO - Reading from file tmpfile_stdout 04:02:06 INFO - Output received: 04:02:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:06 INFO - Running post-action listener: _resource_record_post_action 04:02:06 INFO - ##### 04:02:06 INFO - ##### Running run-tests step. 04:02:06 INFO - ##### 04:02:06 INFO - Running pre-action listener: _resource_record_pre_action 04:02:06 INFO - Running main action method: run_tests 04:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:06 INFO - Python 2.7.3 04:02:06 INFO - Return code: 0 04:02:06 INFO - grabbing minidump binary from tooltool 04:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:06 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 0x2830410>, '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 0x2831310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28317a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:06 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 04:02:06 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 04:02:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:06 INFO - Return code: 0 04:02:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:07 INFO - Return code: 0 04:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 04:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 04:02:07 INFO - Using env: {'DISPLAY': ':0', 04:02:07 INFO - 'HOME': '/home/cltbld', 04:02:07 INFO - 'LANG': 'en_US.UTF-8', 04:02:07 INFO - 'LANGUAGE': 'en_US:en', 04:02:07 INFO - 'LOGNAME': 'cltbld', 04:02:07 INFO - 'MAIL': '/var/mail/cltbld', 04:02:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:07 INFO - 'MOZ_NO_REMOTE': '1', 04:02:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:07 INFO - 'NO_EM_RESTART': '1', 04:02:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:07 INFO - 'PWD': '/builds/slave/test', 04:02:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:07 INFO - 'SHELL': '/bin/bash', 04:02:07 INFO - 'SHLVL': '1', 04:02:07 INFO - 'TERM': 'linux', 04:02:07 INFO - 'TMOUT': '86400', 04:02:07 INFO - 'USER': 'cltbld', 04:02:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033', 04:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:07 INFO - '_': '/tools/buildbot/bin/python'} 04:02:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 04:02:07 INFO - mozversion application_buildid: 20160726073802 04:02:07 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:07 INFO - mozversion application_display_name: Firefox 04:02:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:07 INFO - mozversion application_name: Firefox 04:02:07 INFO - mozversion application_remotingname: firefox 04:02:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:07 INFO - mozversion application_vendor: Mozilla 04:02:07 INFO - mozversion application_version: 48.0 04:02:07 INFO - mozversion platform_buildid: 20160726073802 04:02:07 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:07 INFO - mozversion platform_version: 48.0 04:02:07 INFO - using testdate: 1469617327 04:02:07 INFO - actual date: 1469617327 04:02:07 INFO - starting webserver on 'localhost:58068' 04:02:07 INFO - SUITE-START | Running 2 tests 04:02:07 INFO - TEST-START | dromaeo_css 04:02:07 INFO - operating with platform_type : linux_ 04:02:07 INFO - Initialising browser for dromaeo_css test... 04:02:07 INFO - TEST-INFO | started process 3074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsaAet/profile http://localhost:58068/getInfo.html) 04:02:11 INFO - PROCESS | 3074 | __metrics Screen width/height:1600/1200 04:02:11 INFO - PROCESS | 3074 | colorDepth:24 04:02:11 INFO - PROCESS | 3074 | Browser inner width/height: 1024/697 04:02:11 INFO - PROCESS | 3074 | __metrics 04:02:12 INFO - PROCESS | 3074 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:02:12 ERROR - PROCESS | 3074 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:13 INFO - TEST-INFO | 3074: exit 0 04:02:13 INFO - Browser initialized. 04:02:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:13 INFO - TEST-INFO | started process 3170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsaAet/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:25 INFO - PROCESS | 3170 | RSS: Main: 140025856 04:02:25 INFO - PROCESS | 3170 | 04:03:16 INFO - PROCESS | 3170 | 1469617396053 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] 04:05:23 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58068/tests/dromaeo/cssquery-ext.html) 04:05:24 INFO - PROCESS | 3170 | RSS: Main: 247910400 04:05:24 INFO - PROCESS | 3170 | 04:08:26 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-ext.html (next: http://localhost:58068/tests/dromaeo/cssquery-jquery.html) 04:08:27 INFO - PROCESS | 3170 | RSS: Main: 219537408 04:08:27 INFO - PROCESS | 3170 | 04:11:28 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58068/tests/dromaeo/cssquery-mootools.html) 04:11:29 INFO - PROCESS | 3170 | RSS: Main: 214466560 04:11:29 INFO - PROCESS | 3170 | 04:14:31 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58068/tests/dromaeo/cssquery-prototype.html) 04:14:31 INFO - PROCESS | 3170 | RSS: Main: 221741056 04:14:31 INFO - PROCESS | 3170 | 04:17:34 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58068/tests/dromaeo/cssquery-yui.html) 04:17:34 INFO - PROCESS | 3170 | RSS: Main: 214118400 04:17:34 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | Cycle 1(1): loaded http://localhost:58068/tests/dromaeo/cssquery-yui.html (next: http://localhost:58068/tests/dromaeo/cssquery-dojo.html) 04:20:37 INFO - PROCESS | 3170 | RSS: Main: 252223488 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | __start_tp_report 04:20:37 INFO - PROCESS | 3170 | _x_x_mozilla_page_load 04:20:37 INFO - PROCESS | 3170 | _x_x_mozilla_page_load_details 04:20:37 INFO - PROCESS | 3170 | |i|pagename|runs| 04:20:37 INFO - PROCESS | 3170 | |0;dojo.html;3238.692324229198;3325.0357396355075;3336.4328064229085;3346.063102331345;3363.932721345573;5370.6240563160545;5394.811181608645;5411.702356370398;5412.891742165154;5416.64791788534;5348;5407.486288802567;5412.025835349636;5416.566674666027;5441.619086663935;4875.829345972892;4896.632752543555;4905.583025442842;4995.725235112068;5049.722265275408;4850.951490485085;4916.410030796309;4926.014797040606;4928.876778080558;4929.556339929406;4899.167141585939;4964.627652926027;4986.476419975905;5001.924971125436;5015.974920125394;4954.47977962316;4968.155413579682;4974.42794078682;4975.12935236334;4975.900481990376;4664.65015123867;4816.759162041919;4875.756212189376;4907.705537667715;4925.827596034157;5224.973875130638;5240.34495688039;5301;5306.469353064701;5306.92039619406;5657.603967722261;5657.886842263173;5664.093745000821;5670.064439367499;5673.461021202979;5592.888142237132;5673.773049078032;5696.3733989261145;5698.51562617178;5725.541956643458;5376.032314183445;5406.486383793534;5442.564594832444;5444;5448.210009548593;5579.414161513064;5898.4101589840675;5921.200637913913;5930.28836539618;5937.554683398676;5634.859128521738;5680.005998950167;5693.060644993529;5720.256366672389;5731.799387021434;5728.914066289009;5753.367129615739;5758.654480731169;5758.971205143947;5770.394108618619;5521.3926468088475;5653.773849046074;5695.145728140812;5738.885222295531;5747.655140691572;5698.515626171739;5701.572382071361;5719.084946408638;5723.227364305765;5757.251557297524;4405.691601587858;4405.801738921757;4414.823407063745;4415.227335216325;4439.933400998988;3910.7066969977363;3934.822932967966;3996.7002474814503;3997.960020399817;4004.2592120457807;5323.148296272578;5371.060064488699;5391.649542779785;5397;5434.70109143993;5622.690752008679;5623.184638227434;5626.97186514073;5646.971765141148;5668.404817494186;5297.947020529746;5410.756515956791;5495.450454954473;5589.720513974285;5590.748416321194;4908.288298196741;4922.803087876517;4924.1875090610365;4929.802807887716;4955.851324460272;5827.504662103684;5876.44173803488;5876.676782776988;5877.706114694248;5891.7054147292465;5534.999999999919;5749.770009199585;5839.562032847469;5842.123681447817;5851.882962340815;5823.126531020212;5826.76692932278;5828.970855145697;5834.38738932423;5838.065909454467;5457.7271136443815;5539.169124631338;5546.611737178358;5550.583706221969;5569.721513924369;5681.318241810844;5753.252077229933;5780.768769249183;5783.971080144741;5798.652080875161;5574.386817449996;5585.972070139624;5589.692566908859;5590.301212348457;5593.188987596857;5512;5560.36055853582;5579.023670857665;5579.497845193952;5582.413846546055;5523.033469142964;5577.051901176891;5582.49757521825;5589.720513974366;5604.215409842707;5630.5777066720975;5630.774769009194;5654.519365853948;5665.971670141623;5670.773169073356;5447.945520544902;5450.809221677222;5549.44505549458;5553.972230138824;5586.804461843816 04:20:37 INFO - PROCESS | 3170 | |1;ext.html;593.726885632609;656.1470088884449;667.5494041521971;671.8622682350112;674.2785219814793;32688.673113268862;33421.331573368516;39720;39956.40065399014;39990.40014399786;42821.357679634755;43345.7832710836;43364.78317608408;43366;43393;8207.83584328313;8939.865902011492;9077.228435582983;9086.45481271126;10325.741856453573;10475.790484190311;10593.311434756715;10596.470176491182;10604.946975265113;10609.628662996796;10584.629537966173;10632.946835265813;10633.149348052137;10635.415052172128;10635.840462393031;10576.365418074902;10613.628523001658;10632.415217163052;10651.946740266327;10663.626773062982;10491.213159013105;10554.419506927115;10600.681979540626;10895.182861285357;10908.127349811995;43665.12669746587;44173.77913110414;44201;44227.557724422986;44382.77808610968;3598.118460977051;3723.3670276053135;3744.5132132822832;4064.695147863922;4158.480189976253;33808.323833523435;34718.30563388743;34827;34883.65116348829;35204;4403.581659742319;4442.666799989981;4444.599986001275;4482.618977386926;4487.596116349511;318203.4089829559;319379;322591;323494;324517;39877.407968482534;40866.38700419496;40941.590584094374;65874;66529.33470665329;38216.23567528634;38367.61632383696;38530.6146938527;38570.228595427936;38601.80699096486;15728;15816.28826702801;15828.446004390022;15854.207289635702;15857.207139642971;12192;13899.79150312746;14253.928730356281;14359.92820035893;14379.209143496999;9380.906190938003;9415.905840941503;9431.151196392357;9464.290178236659;9475.289353298393;3527.0829584307753;3543.75193736436;3545.9290814183573;3570.071781336871;3645.052286405554;1057.7567159553346;1118.0217309853879;1161.8315344275034;1224.9265044097383;1296.403654319005;32445.51331729979;32839.83580082132;33145.83427082897;33723.83138084294;34188.65811341904;1183.5147589488267;1191.8569771627288;1203.4343858386544;1221.9816702749465;1272.7645385603694;12348.938255308665;15627;17647.38234161798;17725.822741772674;18233.908830455763;363862;368218;369353;369469;371687;58305.416945830846;59038.40961590415;59449.40550594525;59588;59670.70164649149;1329.4748574313285;1437.4393986345333;1443.6968236670416;1460.1458146984132;1522;29167.416651667274;30199.69800301969;30279.69720302769;30473.171609703488;30483.847580762842;40422.79788601038;40475.79762101288;40869.38695919623;40886.1822763549;40900.59099409087;239258;239277;240394;240692;240770;27859.44281114407;29505.85247073837;31680.207994800316;31976.200594985312;32406.51390229101;44776.55223447854;44886.10227795361;45753.31370029385;53030.73484632552;53767.46232537625;38273.2345353097;38492.230155397294;38495.80752096222;38690.41964370593;38905.2218955625;37286.984656404704;37365.81317093397;38886.222275554894;39007;39229;40194;42435;42462.363064553436;42829.14341713211;43203;34831.30337393187;36788.63211367959;37123.628763713095;37572;37633.623663764105;28506.714932851235;28572.85464010648;28707.53127827254;28866.27834304075;29188.27029324199 04:20:37 INFO - PROCESS | 3170 | |2;jquery.html;420.9936850947236;421.5215730146283;422.5626476596721;430.4318299844207;434.6240501965799;13833.79249311261;18326;18999.240030398785;19051.523711907194;19700.211991520322;15882.52352429426;18513;19304.420867373967;19959.10184041718;20256.392308230777;5559.861003474915;5772.509336706364;5781.4507621775865;5782.3639399666;5787.855303617401;5762.4525670061275;5830.970845145768;5835.854103647422;5842.386549412315;5875.970620146893;5570.080936645449;5769.913451298234;5791.276090488689;5800.854978625526;5809.506191973687;5707.086866101446;5716.514096301819;5718.08510638298;5754.79858204965;5757.165211044396;5013.348264725562;5187.507186817246;5191.0656081905245;5195.740212989335;5204.42751297357;22877.428064298525;23471.41321466977;23768.643470347957;23953.16163934254;23992.760072399225;2548.732383099785;2549.5538280800783;2699.784017278613;2870.067228150859;2960.171152077422;14191.929040354733;14909.254537273202;15095.849041509555;15252.923735381362;15346.539603811903;2000.2898970865278;2037;2059.217497351012;2059.3495165460386;2067.80355866194;69994.30005699929;74014.62992685055;75722.59248333784;76863;77485;10439.94780026095;10606;10955.50700218492;11004.174686898514;11026.779464410667;14007.159570425807;14037.368318425695;14087.788683169761;14090.929545352412;14098.013139080165;7568.924310756932;8081.191880811872;8087.272145506815;8135.511869287861;8152.2662960333855;7709.691612335556;7736.458447908705;7770.844583108419;7776.533407995538;7811.336036436966;4495.505494395614;4690.273007683814;4725.07860967115;4748.335233067373;4797.424309082932;1935.5644979879414;2008.3171721614428;2021.8584699071218;2049.8872562008933;2136.59404713104;997.3268044070223;1019.8164330420595;1041.1670663469195;1096.8903109689127;1135.137295655308;18910.621787564447;18943.526411839815;19070.14184361707;19074.713879291823;19666.311679091163;1002.6490728245202;1014.1430491234895;1059.920505962056;1083.3824719909733;1191.7795207886568;10834.67495975122;11063.280886742335;11070.667879963614;11120.499577519031;11148.944255278671;486764;490046;490913;511730;516527;86611;89602.55198723964;90061.54969225243;92131.53934230286;92559.0744092564;1083.8320060390652;1093.9015488606065;1103.3821060206149;1105.1048650593045;1106.446776611694;17139.400120995706;17170.313187472362;17461.82538174602;17476.912615436842;17534.73697894507;25555.488890222463;38068.80965595154;38169.80915095407;39116;39527;55459.445405545426;56121.15818262811;56353.71823140858;56459.71770141123;56649;8626.137386261575;8629.193290734775;8744.868826967728;8794.164554367326;8841.336899732674;9507.477088760184;12728.872711272768;13688.384022718803;13720.245386503839;13840.169589824643;12262.325572093263;12275.69310767238;12279;12368.319742414255;12463;11078.944605276922;12160.391980400767;12268.631941041425;12344.753104937672;12420.503179873065;11826.231294965799;11945.701357466132;12016.218945768496;12127;12146.210496317712;8192.631331590212;8592.398532102692;8726.563671816257;8827.779305517413;8962.372633915564;11490.88509114898;12158.574449894211;12257.448414821532;12275.079369047178;12514.624561263177 04:20:37 INFO - PROCESS | 3170 | |3;mootools.html;1399.3073428652817;1538.8922775405722;1545.9690806183876;1716.9742453863187;1910.092705964666;7759.728409505668;7957.124716281204;7965.482243654173;7975.641096150673;7984.2015798420125;8064.3951703622315;8244;8248.17518248175;8255.628496717647;8260.545669988163;2343.5664402085667;2366.230974933145;2369.7037870266217;2370.7392186859433;2371;2345.6833327500826;2376.2633583589054;2385.463270764073;2386.367612582667;2409.7469765674614;2345.1557439321914;2359.292212336301;2377.2155188787747;2380.821438392119;2384.95230095398;2292.7707229277107;2313.4910319729634;2322.094383190557;2329.2895666821614;2350.8589484630975;2335.0426325206586;2385.785279324869;2407.16952651335;2410.3853517352964;2431.258466167818;7161.785146445615;7306.378957788595;8394.874076888851;8440;8466.111058338847;4850.369451971256;4886.706797592155;4920.434150072716;4924.729139897304;4930.605551555867;3324.1024923270825;3337.8331083445973;3376.476646119831;3388.3562123196516;3398.422268214385;1208.6253261488966;1217.0507004536476;1226.3745489800176;1232.6795033291319;1249.8875101240842;10918.235723499358;11009.119270458345;11046.447677616086;11160.05139563138;11330.773384532346;4379.474463064453;4392.692511524163;4462.308342206963;4465.843695470643;4506.639468842484;9905.702828915144;9918;9920.503974801231;9921.25590580695;9936.155426788804;4979.800807967713;4994.750262486861;5002.199648056294;5008.198688209869;5064.848054558295;4625.051864367797;4626.745528995937;4633.351330813689;4636.884077898079;4638.397008388888;3812.6187381262207;3938.448617193595;3968.7817170055923;3969.7419667721506;3984.940225896614;1190.0657983482924;1192.1952681939656;1195.1992165249303;1213.5995121609847;1216.7748966441236;833.7373727275889;859.4413631139685;913.7167478081816;920.7526929781534;923.4182465047112;5393.056215162331;5411.404745477994;5442.91835622466;5552.500274975271;5580.1629755537;444.5709889956143;455.9316102584572;460.77652338615746;462.38502791287505;463.72176693984017;3943.921121577552;3992.7005474589523;4011.3180759270995;4035.2131334389514;4059.89850253746;9560.091791279818;9691.12779849817;9696.806063878683;9869.062439068277;9975.152112070555;9581.137697607248;9639.951800240953;9765.462899540451;9779.657711980046;9783.902160978441;7532.887006694904;7678.232176782389;7699.461037727306;7700.306972372513;7772.844543109106;5441.21102440136;5452.863678408072;5490.91763623538;5503.174523821459;5529.253550770594;9073.727788166365;9179.816403671755;9327.207187388876;9335.253179745469;9342.159205671522;8376.916230837614;8564.700235491728;9296.07039296065;9475.05249475047;9501.334906556474;7112.857742845217;7205.243449437734;7236.746713864989;7245.275472452712;7261.5280006799385;7740.14858365568;7762.844743105219;7796.727114550963;7800.765977020698;7806.960965195138;7016.649167541705;7165.24764899678;7174.748883789042;7235.891461627974;7269.3094156055095;7040.647967601702;7209.747658831916;7224.130207555706;7334.193238743627;7336.596487193256;6694.096297000037;6719.865602688016;6757.966210168917;6758.695858686273;6769.424598908951;4955.306257124078;4972.303877457087;4994.300797888226;5059.645824792229;5081.7713202905215;4923.704577725348;4995.675281106716;5031.0441016206805;5083.694978301166;5175.663581867167 04:20:37 INFO - PROCESS | 3170 | |4;prototype.html;340.3499316305855;340.475667472093;348.94068008438563;356.57567494681325;360.06742536829614;6156.81529554113;6195.690215489224;6323.873522529547;6336.112944187812;6345.302016778151;6206.503479721623;6254.312025677172;6263.7494500220055;6266.091416744581;6267.686615669221;4533.2066888294585;4655.2784318430695;4723.055388922212;4782.617390608743;4787.664863459542;4749.905001899977;4759.309900064489;4775.522447755231;4780.043991201774;4788.473267940523;4529.84145554904;4746.976265118669;4747.667663263573;4751.287306903958;4751.667383283171;4593.265077587604;4600.35595016698;4647.326137710013;4665.09030739006;4730.290456431529;4170.47869016373;4179.791010449496;4184.8744537663915;4189.099343641102;4189.539150693421;5932.406759324076;5950.404959504058;5950.642961422329;5953.28560572734;5953.851153721148;5502.477264659851;5503;5505.366882808488;5509.311336082989;5510.228568000483;6376.713047912809;6487.93512064878;6495.090687303781;6552.082708420825;6554.508411869081;4628.236341003731;4649.395578574764;4651.930221046687;4651.953480465186;4662.650301227422;6698.095757072781;6738.124043874314;6781.966090169518;6785.694643741043;6789.490788190856;4487.506374298824;4586.587207151372;4632.444106707149;4748.738819364899;4756.524347565285;4656.371389862393;4660.720356778536;4677.532246775295;4682.180618391768;4687.507811679725;5407.270018547524;5416.51251387377;5417.864553386118;5424.321959755031;5429.538489228381;6578.835529111715;6585.5719378240265;6592.30780768022;6592.901106483407;6600.735970561123;1617.1509957272526;1622.7241368967304;1623.4399132299338;1623.4804862443905;1628;1018;1069.198101423932;1095.8137116690182;1104.928179668319;1122.0294445304917;6290.402411770874;6465.321141280192;6495.7076931538195;6527.706253218616;6541.574797638234;6858.382745552824;6864.759733409307;6878.415334696507;6883.793486195422;6884.965575172092;6453.580517266362;6465.870682586322;6468.450181734511;6472.514561407913;6484.773032943825;3664.9633503665154;3683.7789732615593;3702.444633305026;3703.5555733312176;3708.647678470541;7027.086478757728;7079.504434689626;7167.89248161278;7177.210506844243;7181.245969173266;6943.201531823804;6962.1297337832775;6972.721091156398;6979.371856532936;6979.685914133876;7147.499675022803;7151.570905745672;7155.606441645759;7159.319864612958;7161.713531458683;6848.794536163923;6849.075374824534;6850.212225593921;6858.759943401957;6859.622720750207;6556.2788093310655;6747.156605424322;6764;6767.1879374475375;6781.966090169518;7123.430125589836;7144.3570078693165;7160;7160.391366733886;7165.24764899678;4628.4445866496235;4647.62818974488;4662.696924699883;4663.766811659336;4672.159011377985;6817.2501024888215;6817.522773405814;6822.590644561342;6825.1127353443735;6829.146356705412;6405.807825765234;6635.104260924713;6637.668116594247;6644.501662375438;6663.100481434944;6530.67346632657;6571.507136964842;6637.236717777324;6637.568558043712;6639.966800166161;6516.967415162894;6525.119108920425;6528.477721782341;6533.640649764308;6535.183102112236;6676.265610782907;6681.498887583353;6681.632510211985;6694.6317952511135;6696.430803381767;6424.518161138027;6462.903056454063;6471.676416179078;6476.417122459001;6553.311902250195 04:20:37 INFO - PROCESS | 3170 | |5;yui.html;821.7452589697193;821.9712310069149;822.5248325823401;845.5307304446031;848.3552500099926;13796.793048104273;14029.438822447115;14160.929195354009;14191.92904035481;14203.43186272549;11940.343281119534;12808.679783005406;12844.100912936075;12935.159214651041;12940.094193406465;687.8727435424463;695.7008486350867;696.2619623199399;697.1564407067455;699.136566340569;901.6032945503957;902.6254104546605;908.1372695938851;908.7955210077713;910.3900386740867;950.1116456113556;950.2398081534744;951.0632027452954;951.619352259095;954.1222075690381;795.8766391209343;937.0161330602874;950.4202436513721;958.0036761767753;961.1253759079204;694.930506949306;700.551646945955;703.409136325489;703.9612821294827;704.2112833626371;12796.808047879289;12826.871731282661;12842.422091005927;12888.742225155444;12893.548725794552;12951.352432378344;13759.656008599864;13975.510857119953;14013.439462421491;14031.719365612733;10958.397288149148;11036.724081897937;11092.55629774808;11329.660110196708;11462;3898.4737060496755;3903.7852918089493;3995.60043995601;4026.8187931543152;4036.9394459083137;51362;51538.48461515374;51633;51638.48361516374;51886.7405662973;10282;10624.36253824773;10712.517936692868;10713.83929241062;10992.120630349713;18843;18889.055547222582;18975.62048759017;18996.715049274273;19043.61912761737;7799.961000194962;7925.088614809255;8037.196280372033;8147.714829980922;8399.874001889977;4913.459519452857;4942.258661200849;4949.208126699711;4965.751712414437;5067.898642027212;3249.69127932846;3313.4201514734823;3317.1872891141343;3326.3679900818765;3338.4825352070466;532.8188415938522;566.8242844718151;660.3924389561615;660.5112216959511;665.0987911380107;579.3019411609001;604.9262558957885;689.6207086102623;714.2322003845886;729.32173079037;9270.44377337362;9327.467753426421;9549.42703437782;9619.759506012266;9670.419774813534;680.3298750730527;699.0876905638089;700.2367419512756;712.7469748239404;712.8966299886488;4242.936355954663;4303.289957157034;4366.6506679465565;4374.256376415953;4571.51999040096;59304;61235;61498.38501614927;61605.691971539854;61680;52035.219471707955;52040.739796300775;54451;55503;56425.71787141038;48531.272030919565;49331.26003109956;49729;49796.75101624541;49892.50107498879;9119.772005699911;9129.45223286605;9176.724698259062;9222.723318300461;9246.659234411107;36365;36740.63259367372;37866.242675146896;38007;38868.80565597154;43290.56709432991;43673.56326436822;48417;48801.5119848797;49131;10952.616658416917;11103.333799972028;11170.441477925908;11237.662870113909;11543.538258469567;11844;11980.820287695517;12070.637880863587;12227.755444890874;12458.377081146087;10779.24545281854;11029.338239705643;11071.391073490713;11336.6032188873;11801.114916381133;11363.602273920373;11373;11378.374189419661;11399.544018239178;11503.137264705349;11471.827922581335;11615.36115513621;11693.12301577368;11919.404029798648;12100.939495302468;9685.806283874424;9731.659391921248;9809.411435313905;9917.504124793875;10298.639547615798;9668.129868311886;10130.341527800963;10208.387496750218;10229.59081636756;10293.691189264035 04:20:37 INFO - PROCESS | 3170 | __end_tp_report 04:20:37 INFO - PROCESS | 3170 | __start_cc_report 04:20:37 INFO - PROCESS | 3170 | _x_x_mozilla_cycle_collect,805 04:20:37 INFO - PROCESS | 3170 | __end_cc_report 04:20:37 INFO - PROCESS | 3170 | __startTimestamp1469618437290__endTimestamp 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | ------- Summary: start ------- 04:20:37 INFO - PROCESS | 3170 | Number of tests: 6 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#0] dojo.html Cycles:165 Average:5332.06 Median:5549.45 stddev:560.26 (10.1%) stddev-sans-first:537.37 04:20:37 INFO - PROCESS | 3170 | Values: 3238.7 3325.0 3336.4 3346.1 3363.9 5370.6 5394.8 5411.7 5412.9 5416.6 5348.0 5407.5 5412.0 5416.6 5441.6 4875.8 4896.6 4905.6 4995.7 5049.7 4851.0 4916.4 4926.0 4928.9 4929.6 4899.2 4964.6 4986.5 5001.9 5016.0 4954.5 4968.2 4974.4 4975.1 4975.9 4664.7 4816.8 4875.8 4907.7 4925.8 5225.0 5240.3 5301.0 5306.5 5306.9 5657.6 5657.9 5664.1 5670.1 5673.5 5592.9 5673.8 5696.4 5698.5 5725.5 5376.0 5406.5 5442.6 5444.0 5448.2 5579.4 5898.4 5921.2 5930.3 5937.6 5634.9 5680.0 5693.1 5720.3 5731.8 5728.9 5753.4 5758.7 5759.0 5770.4 5521.4 5653.8 5695.1 5738.9 5747.7 5698.5 5701.6 5719.1 5723.2 5757.3 4405.7 4405.8 4414.8 4415.2 4439.9 3910.7 3934.8 3996.7 3998.0 4004.3 5323.1 5371.1 5391.6 5397.0 5434.7 5622.7 5623.2 5627.0 5647.0 5668.4 5297.9 5410.8 5495.5 5589.7 5590.7 4908.3 4922.8 4924.2 4929.8 4955.9 5827.5 5876.4 5876.7 5877.7 5891.7 5535.0 5749.8 5839.6 5842.1 5851.9 5823.1 5826.8 5829.0 5834.4 5838.1 5457.7 5539.2 5546.6 5550.6 5569.7 5681.3 5753.3 5780.8 5784.0 5798.7 5574.4 5586.0 5589.7 5590.3 5593.2 5512.0 5560.4 5579.0 5579.5 5582.4 5523.0 5577.1 5582.5 5589.7 5604.2 5630.6 5630.8 5654.5 5666.0 5670.8 5447.9 5450.8 5549.4 5554.0 5586.8 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#1] ext.html Cycles:180 Average:48035.33 Median:3544.84 stddev:82434.32 (2325.5%) stddev-sans-first:82588.61 04:20:37 INFO - PROCESS | 3170 | Values: 593.7 656.1 667.5 671.9 674.3 32688.7 33421.3 39720.0 39956.4 39990.4 42821.4 43345.8 43364.8 43366.0 43393.0 8207.8 8939.9 9077.2 9086.5 10325.7 10475.8 10593.3 10596.5 10604.9 10609.6 10584.6 10632.9 10633.1 10635.4 10635.8 10576.4 10613.6 10632.4 10651.9 10663.6 10491.2 10554.4 10600.7 10895.2 10908.1 43665.1 44173.8 44201.0 44227.6 44382.8 3598.1 3723.4 3744.5 4064.7 4158.5 33808.3 34718.3 34827.0 34883.7 35204.0 4403.6 4442.7 4444.6 4482.6 4487.6 318203.4 319379.0 322591.0 323494.0 324517.0 39877.4 40866.4 40941.6 65874.0 66529.3 38216.2 38367.6 38530.6 38570.2 38601.8 15728.0 15816.3 15828.4 15854.2 15857.2 12192.0 13899.8 14253.9 14359.9 14379.2 9380.9 9415.9 9431.2 9464.3 9475.3 3527.1 3543.8 3545.9 3570.1 3645.1 1057.8 1118.0 1161.8 1224.9 1296.4 32445.5 32839.8 33145.8 33723.8 34188.7 1183.5 1191.9 1203.4 1222.0 1272.8 12348.9 15627.0 17647.4 17725.8 18233.9 363862.0 368218.0 369353.0 369469.0 371687.0 58305.4 59038.4 59449.4 59588.0 59670.7 1329.5 1437.4 1443.7 1460.1 1522.0 29167.4 30199.7 30279.7 30473.2 30483.8 40422.8 40475.8 40869.4 40886.2 40900.6 239258.0 239277.0 240394.0 240692.0 240770.0 27859.4 29505.9 31680.2 31976.2 32406.5 44776.6 44886.1 45753.3 53030.7 53767.5 38273.2 38492.2 38495.8 38690.4 38905.2 37287.0 37365.8 38886.2 39007.0 39229.0 40194.0 42435.0 42462.4 42829.1 43203.0 34831.3 36788.6 37123.6 37572.0 37633.6 28506.7 28572.9 28707.5 28866.3 29188.3 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#2] jquery.html Cycles:180 Average:28943.94 Median:23860.90 stddev:82085.76 (344.0%) stddev-sans-first:82288.10 04:20:37 INFO - PROCESS | 3170 | Values: 421.0 421.5 422.6 430.4 434.6 13833.8 18326.0 18999.2 19051.5 19700.2 15882.5 18513.0 19304.4 19959.1 20256.4 5559.9 5772.5 5781.5 5782.4 5787.9 5762.5 5831.0 5835.9 5842.4 5876.0 5570.1 5769.9 5791.3 5800.9 5809.5 5707.1 5716.5 5718.1 5754.8 5757.2 5013.3 5187.5 5191.1 5195.7 5204.4 22877.4 23471.4 23768.6 23953.2 23992.8 2548.7 2549.6 2699.8 2870.1 2960.2 14191.9 14909.3 15095.8 15252.9 15346.5 2000.3 2037.0 2059.2 2059.3 2067.8 69994.3 74014.6 75722.6 76863.0 77485.0 10439.9 10606.0 10955.5 11004.2 11026.8 14007.2 14037.4 14087.8 14090.9 14098.0 7568.9 8081.2 8087.3 8135.5 8152.3 7709.7 7736.5 7770.8 7776.5 7811.3 4495.5 4690.3 4725.1 4748.3 4797.4 1935.6 2008.3 2021.9 2049.9 2136.6 997.3 1019.8 1041.2 1096.9 1135.1 18910.6 18943.5 19070.1 19074.7 19666.3 1002.6 1014.1 1059.9 1083.4 1191.8 10834.7 11063.3 11070.7 11120.5 11148.9 486764.0 490046.0 490913.0 511730.0 516527.0 86611.0 89602.6 90061.5 92131.5 92559.1 1083.8 1093.9 1103.4 1105.1 1106.4 17139.4 17170.3 17461.8 17476.9 17534.7 25555.5 38068.8 38169.8 39116.0 39527.0 55459.4 56121.2 56353.7 56459.7 56649.0 8626.1 8629.2 8744.9 8794.2 8841.3 9507.5 12728.9 13688.4 13720.2 13840.2 12262.3 12275.7 12279.0 12368.3 12463.0 11078.9 12160.4 12268.6 12344.8 12420.5 11826.2 11945.7 12016.2 12127.0 12146.2 8192.6 8592.4 8726.6 8827.8 8962.4 11490.9 12158.6 12257.4 12275.1 12514.6 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#3] mootools.html Cycles:180 Average:5422.84 Median:5062.25 stddev:2957.00 (58.4%) stddev-sans-first:2949.83 04:20:37 INFO - PROCESS | 3170 | Values: 1399.3 1538.9 1546.0 1717.0 1910.1 7759.7 7957.1 7965.5 7975.6 7984.2 8064.4 8244.0 8248.2 8255.6 8260.5 2343.6 2366.2 2369.7 2370.7 2371.0 2345.7 2376.3 2385.5 2386.4 2409.7 2345.2 2359.3 2377.2 2380.8 2385.0 2292.8 2313.5 2322.1 2329.3 2350.9 2335.0 2385.8 2407.2 2410.4 2431.3 7161.8 7306.4 8394.9 8440.0 8466.1 4850.4 4886.7 4920.4 4924.7 4930.6 3324.1 3337.8 3376.5 3388.4 3398.4 1208.6 1217.1 1226.4 1232.7 1249.9 10918.2 11009.1 11046.4 11160.1 11330.8 4379.5 4392.7 4462.3 4465.8 4506.6 9905.7 9918.0 9920.5 9921.3 9936.2 4979.8 4994.8 5002.2 5008.2 5064.8 4625.1 4626.7 4633.4 4636.9 4638.4 3812.6 3938.4 3968.8 3969.7 3984.9 1190.1 1192.2 1195.2 1213.6 1216.8 833.7 859.4 913.7 920.8 923.4 5393.1 5411.4 5442.9 5552.5 5580.2 444.6 455.9 460.8 462.4 463.7 3943.9 3992.7 4011.3 4035.2 4059.9 9560.1 9691.1 9696.8 9869.1 9975.2 9581.1 9640.0 9765.5 9779.7 9783.9 7532.9 7678.2 7699.5 7700.3 7772.8 5441.2 5452.9 5490.9 5503.2 5529.3 9073.7 9179.8 9327.2 9335.3 9342.2 8376.9 8564.7 9296.1 9475.1 9501.3 7112.9 7205.2 7236.7 7245.3 7261.5 7740.1 7762.8 7796.7 7800.8 7807.0 7016.6 7165.2 7174.7 7235.9 7269.3 7040.6 7209.7 7224.1 7334.2 7336.6 6694.1 6719.9 6758.0 6758.7 6769.4 4955.3 4972.3 4994.3 5059.6 5081.8 4923.7 4995.7 5031.0 5083.7 5175.7 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#4] prototype.html Cycles:180 Average:5530.70 Median:6361.01 stddev:1684.50 (26.5%) stddev-sans-first:1643.56 04:20:37 INFO - PROCESS | 3170 | Values: 340.3 340.5 348.9 356.6 360.1 6156.8 6195.7 6323.9 6336.1 6345.3 6206.5 6254.3 6263.7 6266.1 6267.7 4533.2 4655.3 4723.1 4782.6 4787.7 4749.9 4759.3 4775.5 4780.0 4788.5 4529.8 4747.0 4747.7 4751.3 4751.7 4593.3 4600.4 4647.3 4665.1 4730.3 4170.5 4179.8 4184.9 4189.1 4189.5 5932.4 5950.4 5950.6 5953.3 5953.9 5502.5 5503.0 5505.4 5509.3 5510.2 6376.7 6487.9 6495.1 6552.1 6554.5 4628.2 4649.4 4651.9 4652.0 4662.7 6698.1 6738.1 6782.0 6785.7 6789.5 4487.5 4586.6 4632.4 4748.7 4756.5 4656.4 4660.7 4677.5 4682.2 4687.5 5407.3 5416.5 5417.9 5424.3 5429.5 6578.8 6585.6 6592.3 6592.9 6600.7 1617.2 1622.7 1623.4 1623.5 1628.0 1018.0 1069.2 1095.8 1104.9 1122.0 6290.4 6465.3 6495.7 6527.7 6541.6 6858.4 6864.8 6878.4 6883.8 6885.0 6453.6 6465.9 6468.5 6472.5 6484.8 3665.0 3683.8 3702.4 3703.6 3708.6 7027.1 7079.5 7167.9 7177.2 7181.2 6943.2 6962.1 6972.7 6979.4 6979.7 7147.5 7151.6 7155.6 7159.3 7161.7 6848.8 6849.1 6850.2 6858.8 6859.6 6556.3 6747.2 6764.0 6767.2 6782.0 7123.4 7144.4 7160.0 7160.4 7165.2 4628.4 4647.6 4662.7 4663.8 4672.2 6817.3 6817.5 6822.6 6825.1 6829.1 6405.8 6635.1 6637.7 6644.5 6663.1 6530.7 6571.5 6637.2 6637.6 6640.0 6517.0 6525.1 6528.5 6533.6 6535.2 6676.3 6681.5 6681.6 6694.6 6696.4 6424.5 6462.9 6471.7 6476.4 6553.3 04:20:37 INFO - PROCESS | 3170 | 04:20:37 INFO - PROCESS | 3170 | [#5] yui.html Cycles:180 Average:14517.50 Median:27022.23 stddev:16938.34 (62.7%) stddev-sans-first:16954.63 04:20:37 INFO - PROCESS | 3170 | Values: 821.7 822.0 822.5 845.5 848.4 13796.8 14029.4 14160.9 14191.9 14203.4 11940.3 12808.7 12844.1 12935.2 12940.1 687.9 695.7 696.3 697.2 699.1 901.6 902.6 908.1 908.8 910.4 950.1 950.2 951.1 951.6 954.1 795.9 937.0 950.4 958.0 961.1 694.9 700.6 703.4 704.0 704.2 12796.8 12826.9 12842.4 12888.7 12893.5 12951.4 13759.7 13975.5 14013.4 14031.7 10958.4 11036.7 11092.6 11329.7 11462.0 3898.5 3903.8 3995.6 4026.8 4036.9 51362.0 51538.5 51633.0 51638.5 51886.7 10282.0 10624.4 10712.5 10713.8 10992.1 18843.0 18889.1 18975.6 18996.7 19043.6 7800.0 7925.1 8037.2 8147.7 8399.9 4913.5 4942.3 4949.2 4965.8 5067.9 3249.7 3313.4 3317.2 3326.4 3338.5 532.8 566.8 660.4 660.5 665.1 579.3 604.9 689.6 714.2 729.3 9270.4 9327.5 9549.4 9619.8 9670.4 680.3 699.1 700.2 712.7 712.9 4242.9 4303.3 4366.7 4374.3 4571.5 59304.0 61235.0 61498.4 61605.7 61680.0 52035.2 52040.7 54451.0 55503.0 56425.7 48531.3 49331.3 49729.0 49796.8 49892.5 9119.8 9129.5 9176.7 9222.7 9246.7 36365.0 36740.6 37866.2 38007.0 38868.8 43290.6 43673.6 48417.0 48801.5 49131.0 10952.6 11103.3 11170.4 11237.7 11543.5 11844.0 11980.8 12070.6 12227.8 12458.4 10779.2 11029.3 11071.4 11336.6 11801.1 11363.6 11373.0 11378.4 11399.5 11503.1 11471.8 11615.4 11693.1 11919.4 12100.9 9685.8 9731.7 9809.4 9917.5 10298.6 9668.1 10130.3 10208.4 10229.6 10293.7 04:20:37 INFO - PROCESS | 3170 | -------- Summary: end -------- 04:20:37 INFO - PROCESS | 3170 | 04:20:38 INFO - TEST-INFO | 3170: exit 0 04:20:38 INFO - TEST-OK | dromaeo_css | took 1110619ms 04:20:38 INFO - TEST-START | kraken 04:20:38 INFO - operating with platform_type : linux_ 04:20:38 INFO - Initialising browser for kraken test... 04:20:38 INFO - TEST-INFO | started process 3367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFU0Lb/profile http://localhost:58068/getInfo.html) 04:20:41 INFO - PROCESS | 3367 | __metrics Screen width/height:1600/1200 04:20:41 INFO - PROCESS | 3367 | colorDepth:24 04:20:41 INFO - PROCESS | 3367 | Browser inner width/height: 1024/697 04:20:41 INFO - PROCESS | 3367 | __metrics 04:20:42 INFO - PROCESS | 3367 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:20:42 ERROR - PROCESS | 3367 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:43 INFO - TEST-INFO | 3367: exit 0 04:20:43 INFO - Browser initialized. 04:20:43 INFO - Running cycle 1/1 for kraken test... 04:20:43 INFO - TEST-INFO | started process 3458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFU0Lb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:55 INFO - PROCESS | 3458 | RSS: Main: 139153408 04:20:55 INFO - PROCESS | 3458 | 04:20:57 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58068/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:58 INFO - PROCESS | 3458 | RSS: Main: 196640768 04:20:58 INFO - PROCESS | 3458 | 04:21:01 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58068/tests/kraken/driver.html?testName=audio-dft) 04:21:01 INFO - PROCESS | 3458 | RSS: Main: 183955456 04:21:01 INFO - PROCESS | 3458 | 04:21:04 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58068/tests/kraken/driver.html?testName=audio-fft) 04:21:05 INFO - PROCESS | 3458 | RSS: Main: 273641472 04:21:05 INFO - PROCESS | 3458 | 04:21:07 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58068/tests/kraken/driver.html?testName=audio-oscillator) 04:21:07 INFO - PROCESS | 3458 | RSS: Main: 180232192 04:21:07 INFO - PROCESS | 3458 | 04:21:10 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:10 INFO - PROCESS | 3458 | RSS: Main: 177668096 04:21:10 INFO - PROCESS | 3458 | 04:21:13 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58068/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:14 INFO - PROCESS | 3458 | RSS: Main: 212664320 04:21:14 INFO - PROCESS | 3458 | 04:21:17 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58068/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:18 INFO - PROCESS | 3458 | RSS: Main: 213004288 04:21:18 INFO - PROCESS | 3458 | 04:21:20 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58068/tests/kraken/driver.html?testName=json-parse-financial) 04:21:21 INFO - PROCESS | 3458 | RSS: Main: 211931136 04:21:21 INFO - PROCESS | 3458 | 04:21:23 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:23 INFO - PROCESS | 3458 | RSS: Main: 194711552 04:21:23 INFO - PROCESS | 3458 | 04:21:25 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:25 INFO - PROCESS | 3458 | RSS: Main: 200212480 04:21:25 INFO - PROCESS | 3458 | 04:21:27 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:28 INFO - PROCESS | 3458 | RSS: Main: 208363520 04:21:28 INFO - PROCESS | 3458 | 04:21:30 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:31 INFO - PROCESS | 3458 | RSS: Main: 217751552 04:21:31 INFO - PROCESS | 3458 | 04:21:34 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:34 INFO - PROCESS | 3458 | RSS: Main: 214831104 04:21:34 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:58068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58068/tests/kraken/driver.html?testName=ai-astar) 04:21:36 INFO - PROCESS | 3458 | RSS: Main: 274841600 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | __start_tp_report 04:21:36 INFO - PROCESS | 3458 | _x_x_mozilla_page_load 04:21:36 INFO - PROCESS | 3458 | _x_x_mozilla_page_load_details 04:21:36 INFO - PROCESS | 3458 | |i|pagename|runs| 04:21:36 INFO - PROCESS | 3458 | |0;ai-astar;112;111;111;111;113;111;106;109;109;110 04:21:36 INFO - PROCESS | 3458 | |1;audio-beat-detection;155;127;159;178;127;160;159;137;181;128 04:21:36 INFO - PROCESS | 3458 | |2;audio-dft;161;162;161;162;160;161;160;163;159;160 04:21:36 INFO - PROCESS | 3458 | |3;audio-fft;76;74;75;176;73;74;76;73;154;77 04:21:36 INFO - PROCESS | 3458 | |4;audio-oscillator;91;92;151;91;91;91;149;91;91;145 04:21:36 INFO - PROCESS | 3458 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;116;116 04:21:36 INFO - PROCESS | 3458 | |6;imaging-darkroom;145;146;145;145;145;146;145;145;145;145 04:21:36 INFO - PROCESS | 3458 | |7;imaging-desaturate;95;94;95;94;95;94;94;95;94;95 04:21:36 INFO - PROCESS | 3458 | |8;json-parse-financial;54;54;54;56;55;54;54;76;56;52 04:21:36 INFO - PROCESS | 3458 | |9;json-stringify-tinderbox;57;59;58;62;59;57;58;57;57;57 04:21:36 INFO - PROCESS | 3458 | |10;stanford-crypto-aes;73;73;73;72;83;74;74;73;75;74 04:21:36 INFO - PROCESS | 3458 | |11;stanford-crypto-ccm;124;115;113;116;111;114;116;114;130;135 04:21:36 INFO - PROCESS | 3458 | |12;stanford-crypto-pbkdf2;165;166;164;162;159;166;165;161;159;165 04:21:36 INFO - PROCESS | 3458 | |13;stanford-crypto-sha256-iterative;66;68;67;66;65;66;66;65;65;66 04:21:36 INFO - PROCESS | 3458 | __end_tp_report 04:21:36 INFO - PROCESS | 3458 | __start_cc_report 04:21:36 INFO - PROCESS | 3458 | _x_x_mozilla_cycle_collect,1599 04:21:36 INFO - PROCESS | 3458 | __end_cc_report 04:21:36 INFO - PROCESS | 3458 | __startTimestamp1469618496803__endTimestamp 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | ------- Summary: start ------- 04:21:36 INFO - PROCESS | 3458 | Number of tests: 14 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:1.96 04:21:36 INFO - PROCESS | 3458 | Values: 112.0 111.0 111.0 111.0 113.0 111.0 106.0 109.0 109.0 110.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:159.00 stddev:20.36 (12.8%) stddev-sans-first:21.55 04:21:36 INFO - PROCESS | 3458 | Values: 155.0 127.0 159.0 178.0 127.0 160.0 159.0 137.0 181.0 128.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 04:21:36 INFO - PROCESS | 3458 | Values: 161.0 162.0 161.0 162.0 160.0 161.0 160.0 163.0 159.0 160.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:38.43 (51.6%) stddev-sans-first:40.27 04:21:36 INFO - PROCESS | 3458 | Values: 76.0 74.0 75.0 176.0 73.0 74.0 76.0 73.0 154.0 77.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:91.00 stddev:27.66 (30.4%) stddev-sans-first:28.63 04:21:36 INFO - PROCESS | 3458 | Values: 91.0 92.0 151.0 91.0 91.0 91.0 149.0 91.0 91.0 145.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:21:36 INFO - PROCESS | 3458 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:21:36 INFO - PROCESS | 3458 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:21:36 INFO - PROCESS | 3458 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:54.50 stddev:6.95 (12.7%) stddev-sans-first:7.31 04:21:36 INFO - PROCESS | 3458 | Values: 54.0 54.0 54.0 56.0 55.0 54.0 54.0 76.0 56.0 52.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:1.60 (2.8%) stddev-sans-first:1.64 04:21:36 INFO - PROCESS | 3458 | Values: 57.0 59.0 58.0 62.0 59.0 57.0 58.0 57.0 57.0 57.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:3.13 (4.2%) stddev-sans-first:3.28 04:21:36 INFO - PROCESS | 3458 | Values: 73.0 73.0 73.0 72.0 83.0 74.0 74.0 73.0 75.0 74.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:116.00 stddev:8.07 (7.0%) stddev-sans-first:8.33 04:21:36 INFO - PROCESS | 3458 | Values: 124.0 115.0 113.0 116.0 111.0 114.0 116.0 114.0 130.0 135.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:165.00 stddev:2.74 (1.7%) stddev-sans-first:2.83 04:21:36 INFO - PROCESS | 3458 | Values: 165.0 166.0 164.0 162.0 159.0 166.0 165.0 161.0 159.0 165.0 04:21:36 INFO - PROCESS | 3458 | 04:21:36 INFO - PROCESS | 3458 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 04:21:36 INFO - PROCESS | 3458 | Values: 66.0 68.0 67.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 04:21:36 INFO - PROCESS | 3458 | -------- Summary: end -------- 04:21:36 INFO - PROCESS | 3458 | 04:21:37 INFO - TEST-INFO | 3458: exit 0 04:21:37 INFO - TEST-OK | kraken | took 59889ms 04:21:37 INFO - SUITE-END | took 1170s 04:21:37 INFO - Completed test suite (00:19:30) 04:21:37 INFO - javascript benchmark 04:21:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.692324229198, 3325.0357396355075, 3336.4328064229085, 3346.063102331345, 3363.932721345573, 5370.6240563160545, 5394.811181608645, 5411.702356370398, 5412.891742165154, 5416.64791788534, 5348.0, 5407.486288802567, 5412.025835349636, 5416.566674666027, 5441.619086663935, 4875.829345972892, 4896.632752543555, 4905.583025442842, 4995.725235112068, 5049.722265275408, 4850.951490485085, 4916.410030796309, 4926.014797040606, 4928.876778080558, 4929.556339929406, 4899.167141585939, 4964.627652926027, 4986.476419975905, 5001.924971125436, 5015.974920125394, 4954.47977962316, 4968.155413579682, 4974.42794078682, 4975.12935236334, 4975.900481990376, 4664.65015123867, 4816.759162041919, 4875.756212189376, 4907.705537667715, 4925.827596034157, 5224.973875130638, 5240.34495688039, 5301.0, 5306.469353064701, 5306.92039619406, 5657.603967722261, 5657.886842263173, 5664.093745000821, 5670.064439367499, 5673.461021202979, 5592.888142237132, 5673.773049078032, 5696.3733989261145, 5698.51562617178, 5725.541956643458, 5376.032314183445, 5406.486383793534, 5442.564594832444, 5444.0, 5448.210009548593, 5579.414161513064, 5898.4101589840675, 5921.200637913913, 5930.28836539618, 5937.554683398676, 5634.859128521738, 5680.005998950167, 5693.060644993529, 5720.256366672389, 5731.799387021434, 5728.914066289009, 5753.367129615739, 5758.654480731169, 5758.971205143947, 5770.394108618619, 5521.3926468088475, 5653.773849046074, 5695.145728140812, 5738.885222295531, 5747.655140691572, 5698.515626171739, 5701.572382071361, 5719.084946408638, 5723.227364305765, 5757.251557297524, 4405.691601587858, 4405.801738921757, 4414.823407063745, 4415.227335216325, 4439.933400998988, 3910.7066969977363, 3934.822932967966, 3996.7002474814503, 3997.960020399817, 4004.2592120457807, 5323.148296272578, 5371.060064488699, 5391.649542779785, 5397.0, 5434.70109143993, 5622.690752008679, 5623.184638227434, 5626.97186514073, 5646.971765141148, 5668.404817494186, 5297.947020529746, 5410.756515956791, 5495.450454954473, 5589.720513974285, 5590.748416321194, 4908.288298196741, 4922.803087876517, 4924.1875090610365, 4929.802807887716, 4955.851324460272, 5827.504662103684, 5876.44173803488, 5876.676782776988, 5877.706114694248, 5891.7054147292465, 5534.999999999919, 5749.770009199585, 5839.562032847469, 5842.123681447817, 5851.882962340815, 5823.126531020212, 5826.76692932278, 5828.970855145697, 5834.38738932423, 5838.065909454467, 5457.7271136443815, 5539.169124631338, 5546.611737178358, 5550.583706221969, 5569.721513924369, 5681.318241810844, 5753.252077229933, 5780.768769249183, 5783.971080144741, 5798.652080875161, 5574.386817449996, 5585.972070139624, 5589.692566908859, 5590.301212348457, 5593.188987596857, 5512.0, 5560.36055853582, 5579.023670857665, 5579.497845193952, 5582.413846546055, 5523.033469142964, 5577.051901176891, 5582.49757521825, 5589.720513974366, 5604.215409842707, 5630.5777066720975, 5630.774769009194, 5654.519365853948, 5665.971670141623, 5670.773169073356, 5447.945520544902, 5450.809221677222, 5549.44505549458, 5553.972230138824, 5586.804461843816], "value": 5297.861113184488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.726885632609, 656.1470088884449, 667.5494041521971, 671.8622682350112, 674.2785219814793, 32688.673113268862, 33421.331573368516, 39720.0, 39956.40065399014, 39990.40014399786, 42821.357679634755, 43345.7832710836, 43364.78317608408, 43366.0, 43393.0, 8207.83584328313, 8939.865902011492, 9077.228435582983, 9086.45481271126, 10325.741856453573, 10475.790484190311, 10593.311434756715, 10596.470176491182, 10604.946975265113, 10609.628662996796, 10584.629537966173, 10632.946835265813, 10633.149348052137, 10635.415052172128, 10635.840462393031, 10576.365418074902, 10613.628523001658, 10632.415217163052, 10651.946740266327, 10663.626773062982, 10491.213159013105, 10554.419506927115, 10600.681979540626, 10895.182861285357, 10908.127349811995, 43665.12669746587, 44173.77913110414, 44201.0, 44227.557724422986, 44382.77808610968, 3598.118460977051, 3723.3670276053135, 3744.5132132822832, 4064.695147863922, 4158.480189976253, 33808.323833523435, 34718.30563388743, 34827.0, 34883.65116348829, 35204.0, 4403.581659742319, 4442.666799989981, 4444.599986001275, 4482.618977386926, 4487.596116349511, 318203.4089829559, 319379.0, 322591.0, 323494.0, 324517.0, 39877.407968482534, 40866.38700419496, 40941.590584094374, 65874.0, 66529.33470665329, 38216.23567528634, 38367.61632383696, 38530.6146938527, 38570.228595427936, 38601.80699096486, 15728.0, 15816.28826702801, 15828.446004390022, 15854.207289635702, 15857.207139642971, 12192.0, 13899.79150312746, 14253.928730356281, 14359.92820035893, 14379.209143496999, 9380.906190938003, 9415.905840941503, 9431.151196392357, 9464.290178236659, 9475.289353298393, 3527.0829584307753, 3543.75193736436, 3545.9290814183573, 3570.071781336871, 3645.052286405554, 1057.7567159553346, 1118.0217309853879, 1161.8315344275034, 1224.9265044097383, 1296.403654319005, 32445.51331729979, 32839.83580082132, 33145.83427082897, 33723.83138084294, 34188.65811341904, 1183.5147589488267, 1191.8569771627288, 1203.4343858386544, 1221.9816702749465, 1272.7645385603694, 12348.938255308665, 15627.0, 17647.38234161798, 17725.822741772674, 18233.908830455763, 363862.0, 368218.0, 369353.0, 369469.0, 371687.0, 58305.416945830846, 59038.40961590415, 59449.40550594525, 59588.0, 59670.70164649149, 1329.4748574313285, 1437.4393986345333, 1443.6968236670416, 1460.1458146984132, 1522.0, 29167.416651667274, 30199.69800301969, 30279.69720302769, 30473.171609703488, 30483.847580762842, 40422.79788601038, 40475.79762101288, 40869.38695919623, 40886.1822763549, 40900.59099409087, 239258.0, 239277.0, 240394.0, 240692.0, 240770.0, 27859.44281114407, 29505.85247073837, 31680.207994800316, 31976.200594985312, 32406.51390229101, 44776.55223447854, 44886.10227795361, 45753.31370029385, 53030.73484632552, 53767.46232537625, 38273.2345353097, 38492.230155397294, 38495.80752096222, 38690.41964370593, 38905.2218955625, 37286.984656404704, 37365.81317093397, 38886.222275554894, 39007.0, 39229.0, 40194.0, 42435.0, 42462.363064553436, 42829.14341713211, 43203.0, 34831.30337393187, 36788.63211367959, 37123.628763713095, 37572.0, 37633.623663764105, 28506.714932851235, 28572.85464010648, 28707.53127827254, 28866.27834304075, 29188.27029324199], "value": 18981.293429512505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.9936850947236, 421.5215730146283, 422.5626476596721, 430.4318299844207, 434.6240501965799, 13833.79249311261, 18326.0, 18999.240030398785, 19051.523711907194, 19700.211991520322, 15882.52352429426, 18513.0, 19304.420867373967, 19959.10184041718, 20256.392308230777, 5559.861003474915, 5772.509336706364, 5781.4507621775865, 5782.3639399666, 5787.855303617401, 5762.4525670061275, 5830.970845145768, 5835.854103647422, 5842.386549412315, 5875.970620146893, 5570.080936645449, 5769.913451298234, 5791.276090488689, 5800.854978625526, 5809.506191973687, 5707.086866101446, 5716.514096301819, 5718.08510638298, 5754.79858204965, 5757.165211044396, 5013.348264725562, 5187.507186817246, 5191.0656081905245, 5195.740212989335, 5204.42751297357, 22877.428064298525, 23471.41321466977, 23768.643470347957, 23953.16163934254, 23992.760072399225, 2548.732383099785, 2549.5538280800783, 2699.784017278613, 2870.067228150859, 2960.171152077422, 14191.929040354733, 14909.254537273202, 15095.849041509555, 15252.923735381362, 15346.539603811903, 2000.2898970865278, 2037.0, 2059.217497351012, 2059.3495165460386, 2067.80355866194, 69994.30005699929, 74014.62992685055, 75722.59248333784, 76863.0, 77485.0, 10439.94780026095, 10606.0, 10955.50700218492, 11004.174686898514, 11026.779464410667, 14007.159570425807, 14037.368318425695, 14087.788683169761, 14090.929545352412, 14098.013139080165, 7568.924310756932, 8081.191880811872, 8087.272145506815, 8135.511869287861, 8152.2662960333855, 7709.691612335556, 7736.458447908705, 7770.844583108419, 7776.533407995538, 7811.336036436966, 4495.505494395614, 4690.273007683814, 4725.07860967115, 4748.335233067373, 4797.424309082932, 1935.5644979879414, 2008.3171721614428, 2021.8584699071218, 2049.8872562008933, 2136.59404713104, 997.3268044070223, 1019.8164330420595, 1041.1670663469195, 1096.8903109689127, 1135.137295655308, 18910.621787564447, 18943.526411839815, 19070.14184361707, 19074.713879291823, 19666.311679091163, 1002.6490728245202, 1014.1430491234895, 1059.920505962056, 1083.3824719909733, 1191.7795207886568, 10834.67495975122, 11063.280886742335, 11070.667879963614, 11120.499577519031, 11148.944255278671, 486764.0, 490046.0, 490913.0, 511730.0, 516527.0, 86611.0, 89602.55198723964, 90061.54969225243, 92131.53934230286, 92559.0744092564, 1083.8320060390652, 1093.9015488606065, 1103.3821060206149, 1105.1048650593045, 1106.446776611694, 17139.400120995706, 17170.313187472362, 17461.82538174602, 17476.912615436842, 17534.73697894507, 25555.488890222463, 38068.80965595154, 38169.80915095407, 39116.0, 39527.0, 55459.445405545426, 56121.15818262811, 56353.71823140858, 56459.71770141123, 56649.0, 8626.137386261575, 8629.193290734775, 8744.868826967728, 8794.164554367326, 8841.336899732674, 9507.477088760184, 12728.872711272768, 13688.384022718803, 13720.245386503839, 13840.169589824643, 12262.325572093263, 12275.69310767238, 12279.0, 12368.319742414255, 12463.0, 11078.944605276922, 12160.391980400767, 12268.631941041425, 12344.753104937672, 12420.503179873065, 11826.231294965799, 11945.701357466132, 12016.218945768496, 12127.0, 12146.210496317712, 8192.631331590212, 8592.398532102692, 8726.563671816257, 8827.779305517413, 8962.372633915564, 11490.88509114898, 12158.574449894211, 12257.448414821532, 12275.079369047178, 12514.624561263177], "value": 9365.465463012062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.3073428652817, 1538.8922775405722, 1545.9690806183876, 1716.9742453863187, 1910.092705964666, 7759.728409505668, 7957.124716281204, 7965.482243654173, 7975.641096150673, 7984.2015798420125, 8064.3951703622315, 8244.0, 8248.17518248175, 8255.628496717647, 8260.545669988163, 2343.5664402085667, 2366.230974933145, 2369.7037870266217, 2370.7392186859433, 2371.0, 2345.6833327500826, 2376.2633583589054, 2385.463270764073, 2386.367612582667, 2409.7469765674614, 2345.1557439321914, 2359.292212336301, 2377.2155188787747, 2380.821438392119, 2384.95230095398, 2292.7707229277107, 2313.4910319729634, 2322.094383190557, 2329.2895666821614, 2350.8589484630975, 2335.0426325206586, 2385.785279324869, 2407.16952651335, 2410.3853517352964, 2431.258466167818, 7161.785146445615, 7306.378957788595, 8394.874076888851, 8440.0, 8466.111058338847, 4850.369451971256, 4886.706797592155, 4920.434150072716, 4924.729139897304, 4930.605551555867, 3324.1024923270825, 3337.8331083445973, 3376.476646119831, 3388.3562123196516, 3398.422268214385, 1208.6253261488966, 1217.0507004536476, 1226.3745489800176, 1232.6795033291319, 1249.8875101240842, 10918.235723499358, 11009.119270458345, 11046.447677616086, 11160.05139563138, 11330.773384532346, 4379.474463064453, 4392.692511524163, 4462.308342206963, 4465.843695470643, 4506.639468842484, 9905.702828915144, 9918.0, 9920.503974801231, 9921.25590580695, 9936.155426788804, 4979.800807967713, 4994.750262486861, 5002.199648056294, 5008.198688209869, 5064.848054558295, 4625.051864367797, 4626.745528995937, 4633.351330813689, 4636.884077898079, 4638.397008388888, 3812.6187381262207, 3938.448617193595, 3968.7817170055923, 3969.7419667721506, 3984.940225896614, 1190.0657983482924, 1192.1952681939656, 1195.1992165249303, 1213.5995121609847, 1216.7748966441236, 833.7373727275889, 859.4413631139685, 913.7167478081816, 920.7526929781534, 923.4182465047112, 5393.056215162331, 5411.404745477994, 5442.91835622466, 5552.500274975271, 5580.1629755537, 444.5709889956143, 455.9316102584572, 460.77652338615746, 462.38502791287505, 463.72176693984017, 3943.921121577552, 3992.7005474589523, 4011.3180759270995, 4035.2131334389514, 4059.89850253746, 9560.091791279818, 9691.12779849817, 9696.806063878683, 9869.062439068277, 9975.152112070555, 9581.137697607248, 9639.951800240953, 9765.462899540451, 9779.657711980046, 9783.902160978441, 7532.887006694904, 7678.232176782389, 7699.461037727306, 7700.306972372513, 7772.844543109106, 5441.21102440136, 5452.863678408072, 5490.91763623538, 5503.174523821459, 5529.253550770594, 9073.727788166365, 9179.816403671755, 9327.207187388876, 9335.253179745469, 9342.159205671522, 8376.916230837614, 8564.700235491728, 9296.07039296065, 9475.05249475047, 9501.334906556474, 7112.857742845217, 7205.243449437734, 7236.746713864989, 7245.275472452712, 7261.5280006799385, 7740.14858365568, 7762.844743105219, 7796.727114550963, 7800.765977020698, 7806.960965195138, 7016.649167541705, 7165.24764899678, 7174.748883789042, 7235.891461627974, 7269.3094156055095, 7040.647967601702, 7209.747658831916, 7224.130207555706, 7334.193238743627, 7336.596487193256, 6694.096297000037, 6719.865602688016, 6757.966210168917, 6758.695858686273, 6769.424598908951, 4955.306257124078, 4972.303877457087, 4994.300797888226, 5059.645824792229, 5081.7713202905215, 4923.704577725348, 4995.675281106716, 5031.0441016206805, 5083.694978301166, 5175.663581867167], "value": 4354.427666852696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3499316305855, 340.475667472093, 348.94068008438563, 356.57567494681325, 360.06742536829614, 6156.81529554113, 6195.690215489224, 6323.873522529547, 6336.112944187812, 6345.302016778151, 6206.503479721623, 6254.312025677172, 6263.7494500220055, 6266.091416744581, 6267.686615669221, 4533.2066888294585, 4655.2784318430695, 4723.055388922212, 4782.617390608743, 4787.664863459542, 4749.905001899977, 4759.309900064489, 4775.522447755231, 4780.043991201774, 4788.473267940523, 4529.84145554904, 4746.976265118669, 4747.667663263573, 4751.287306903958, 4751.667383283171, 4593.265077587604, 4600.35595016698, 4647.326137710013, 4665.09030739006, 4730.290456431529, 4170.47869016373, 4179.791010449496, 4184.8744537663915, 4189.099343641102, 4189.539150693421, 5932.406759324076, 5950.404959504058, 5950.642961422329, 5953.28560572734, 5953.851153721148, 5502.477264659851, 5503.0, 5505.366882808488, 5509.311336082989, 5510.228568000483, 6376.713047912809, 6487.93512064878, 6495.090687303781, 6552.082708420825, 6554.508411869081, 4628.236341003731, 4649.395578574764, 4651.930221046687, 4651.953480465186, 4662.650301227422, 6698.095757072781, 6738.124043874314, 6781.966090169518, 6785.694643741043, 6789.490788190856, 4487.506374298824, 4586.587207151372, 4632.444106707149, 4748.738819364899, 4756.524347565285, 4656.371389862393, 4660.720356778536, 4677.532246775295, 4682.180618391768, 4687.507811679725, 5407.270018547524, 5416.51251387377, 5417.864553386118, 5424.321959755031, 5429.538489228381, 6578.835529111715, 6585.5719378240265, 6592.30780768022, 6592.901106483407, 6600.735970561123, 1617.1509957272526, 1622.7241368967304, 1623.4399132299338, 1623.4804862443905, 1628.0, 1018.0, 1069.198101423932, 1095.8137116690182, 1104.928179668319, 1122.0294445304917, 6290.402411770874, 6465.321141280192, 6495.7076931538195, 6527.706253218616, 6541.574797638234, 6858.382745552824, 6864.759733409307, 6878.415334696507, 6883.793486195422, 6884.965575172092, 6453.580517266362, 6465.870682586322, 6468.450181734511, 6472.514561407913, 6484.773032943825, 3664.9633503665154, 3683.7789732615593, 3702.444633305026, 3703.5555733312176, 3708.647678470541, 7027.086478757728, 7079.504434689626, 7167.89248161278, 7177.210506844243, 7181.245969173266, 6943.201531823804, 6962.1297337832775, 6972.721091156398, 6979.371856532936, 6979.685914133876, 7147.499675022803, 7151.570905745672, 7155.606441645759, 7159.319864612958, 7161.713531458683, 6848.794536163923, 6849.075374824534, 6850.212225593921, 6858.759943401957, 6859.622720750207, 6556.2788093310655, 6747.156605424322, 6764.0, 6767.1879374475375, 6781.966090169518, 7123.430125589836, 7144.3570078693165, 7160.0, 7160.391366733886, 7165.24764899678, 4628.4445866496235, 4647.62818974488, 4662.696924699883, 4663.766811659336, 4672.159011377985, 6817.2501024888215, 6817.522773405814, 6822.590644561342, 6825.1127353443735, 6829.146356705412, 6405.807825765234, 6635.104260924713, 6637.668116594247, 6644.501662375438, 6663.100481434944, 6530.67346632657, 6571.507136964842, 6637.236717777324, 6637.568558043712, 6639.966800166161, 6516.967415162894, 6525.119108920425, 6528.477721782341, 6533.640649764308, 6535.183102112236, 6676.265610782907, 6681.498887583353, 6681.632510211985, 6694.6317952511135, 6696.430803381767, 6424.518161138027, 6462.903056454063, 6471.676416179078, 6476.417122459001, 6553.311902250195], "value": 4978.208968071314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.7452589697193, 821.9712310069149, 822.5248325823401, 845.5307304446031, 848.3552500099926, 13796.793048104273, 14029.438822447115, 14160.929195354009, 14191.92904035481, 14203.43186272549, 11940.343281119534, 12808.679783005406, 12844.100912936075, 12935.159214651041, 12940.094193406465, 687.8727435424463, 695.7008486350867, 696.2619623199399, 697.1564407067455, 699.136566340569, 901.6032945503957, 902.6254104546605, 908.1372695938851, 908.7955210077713, 910.3900386740867, 950.1116456113556, 950.2398081534744, 951.0632027452954, 951.619352259095, 954.1222075690381, 795.8766391209343, 937.0161330602874, 950.4202436513721, 958.0036761767753, 961.1253759079204, 694.930506949306, 700.551646945955, 703.409136325489, 703.9612821294827, 704.2112833626371, 12796.808047879289, 12826.871731282661, 12842.422091005927, 12888.742225155444, 12893.548725794552, 12951.352432378344, 13759.656008599864, 13975.510857119953, 14013.439462421491, 14031.719365612733, 10958.397288149148, 11036.724081897937, 11092.55629774808, 11329.660110196708, 11462.0, 3898.4737060496755, 3903.7852918089493, 3995.60043995601, 4026.8187931543152, 4036.9394459083137, 51362.0, 51538.48461515374, 51633.0, 51638.48361516374, 51886.7405662973, 10282.0, 10624.36253824773, 10712.517936692868, 10713.83929241062, 10992.120630349713, 18843.0, 18889.055547222582, 18975.62048759017, 18996.715049274273, 19043.61912761737, 7799.961000194962, 7925.088614809255, 8037.196280372033, 8147.714829980922, 8399.874001889977, 4913.459519452857, 4942.258661200849, 4949.208126699711, 4965.751712414437, 5067.898642027212, 3249.69127932846, 3313.4201514734823, 3317.1872891141343, 3326.3679900818765, 3338.4825352070466, 532.8188415938522, 566.8242844718151, 660.3924389561615, 660.5112216959511, 665.0987911380107, 579.3019411609001, 604.9262558957885, 689.6207086102623, 714.2322003845886, 729.32173079037, 9270.44377337362, 9327.467753426421, 9549.42703437782, 9619.759506012266, 9670.419774813534, 680.3298750730527, 699.0876905638089, 700.2367419512756, 712.7469748239404, 712.8966299886488, 4242.936355954663, 4303.289957157034, 4366.6506679465565, 4374.256376415953, 4571.51999040096, 59304.0, 61235.0, 61498.38501614927, 61605.691971539854, 61680.0, 52035.219471707955, 52040.739796300775, 54451.0, 55503.0, 56425.71787141038, 48531.272030919565, 49331.26003109956, 49729.0, 49796.75101624541, 49892.50107498879, 9119.772005699911, 9129.45223286605, 9176.724698259062, 9222.723318300461, 9246.659234411107, 36365.0, 36740.63259367372, 37866.242675146896, 38007.0, 38868.80565597154, 43290.56709432991, 43673.56326436822, 48417.0, 48801.5119848797, 49131.0, 10952.616658416917, 11103.333799972028, 11170.441477925908, 11237.662870113909, 11543.538258469567, 11844.0, 11980.820287695517, 12070.637880863587, 12227.755444890874, 12458.377081146087, 10779.24545281854, 11029.338239705643, 11071.391073490713, 11336.6032188873, 11801.114916381133, 11363.602273920373, 11373.0, 11378.374189419661, 11399.544018239178, 11503.137264705349, 11471.827922581335, 11615.36115513621, 11693.12301577368, 11919.404029798648, 12100.939495302468, 9685.806283874424, 9731.659391921248, 9809.411435313905, 9917.504124793875, 10298.639547615798, 9668.129868311886, 10130.341527800963, 10208.387496750218, 10229.59081636756, 10293.691189264035], "value": 6642.360186198013, "unit": "score"}], "name": "dromaeo_css", "value": 7167.819608212546, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 111.0, 113.0, 111.0, 106.0, 109.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 159.0, 178.0, 127.0, 160.0, 159.0, 137.0, 181.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 163.0, 159.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, 73.0, 74.0, 76.0, 73.0, 154.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 151.0, 91.0, 91.0, 91.0, 149.0, 91.0, 91.0, 145.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 56.0, 55.0, 54.0, 54.0, 76.0, 56.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 62.0, 59.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 83.0, 74.0, 74.0, 73.0, 75.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 115.0, 113.0, 116.0, 111.0, 114.0, 116.0, 114.0, 130.0, 135.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 164.0, 162.0, 159.0, 166.0, 165.0, 161.0, 159.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1516.6999999999998, "alertThreshold": 2.0}]} 04:21:38 INFO - Return code: 0 04:21:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:38 ERROR - # TBPL SUCCESS # 04:21:38 INFO - Running post-action listener: _resource_record_post_action 04:21:38 INFO - Running post-run listener: _resource_record_post_run 04:21:39 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 464302080; Read time: 24; Write time: 419888 04:21:39 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 241725440; Read time: 0; Write time: 270724 04:21:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222576640; Read time: 12; Write time: 149164 04:21:39 INFO - Running post-run listener: _upload_blobber_files 04:21:39 INFO - Blob upload gear active. 04:21:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:39 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 04:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:40 INFO - (blobuploader) - INFO - Done attempting. 04:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:41 INFO - (blobuploader) - INFO - Done attempting. 04:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:41 INFO - Return code: 0 04:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/053b717cec3d7bc31e61b50ff03f3e2b4d7fc50146d36d7ccd2fa627ca53eca2e72c9a68955b0f590f23b85f57877051eaf51de764fc0565f8e8559c13b8053c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0555231342accb0df0310245eac73ce4d6ba5b2deabc737cfa1e50ba26ac26dbe8fd983934a959a4b1b0cd00a57c12b8f6fb9961f63b26b5df798b0092209a28"} 04:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:41 INFO - Contents: 04:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/053b717cec3d7bc31e61b50ff03f3e2b4d7fc50146d36d7ccd2fa627ca53eca2e72c9a68955b0f590f23b85f57877051eaf51de764fc0565f8e8559c13b8053c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0555231342accb0df0310245eac73ce4d6ba5b2deabc737cfa1e50ba26ac26dbe8fd983934a959a4b1b0cd00a57c12b8f6fb9961f63b26b5df798b0092209a28"} 04:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:41 INFO - Copying logs to upload dir... 04:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.857793 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-27 04:21:40.618021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:40.621853) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/053b717cec3d7bc31e61b50ff03f3e2b4d7fc50146d36d7ccd2fa627ca53eca2e72c9a68955b0f590f23b85f57877051eaf51de764fc0565f8e8559c13b8053c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0555231342accb0df0310245eac73ce4d6ba5b2deabc737cfa1e50ba26ac26dbe8fd983934a959a4b1b0cd00a57c12b8f6fb9961f63b26b5df798b0092209a28"} build_url:https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/053b717cec3d7bc31e61b50ff03f3e2b4d7fc50146d36d7ccd2fa627ca53eca2e72c9a68955b0f590f23b85f57877051eaf51de764fc0565f8e8559c13b8053c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0555231342accb0df0310245eac73ce4d6ba5b2deabc737cfa1e50ba26ac26dbe8fd983934a959a4b1b0cd00a57c12b8f6fb9961f63b26b5df798b0092209a28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:40.647238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:40.647574) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469617277.154792-600223033 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-07-27 04:21:40.733123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:40.733487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:40.733808) ========= ========= Total master_lag: 0.17 =========