builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1469617283.36 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.355324) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.355767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.356068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.370617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.370981) ========= 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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:23-- 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% 218M=0s 2016-07-27 04:01:23 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.514744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.515106) ========= 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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:23.564570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:01:23.564919) ========= 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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:24,003 truncating revision to first 12 chars 2016-07-27 04:01:24,003 Setting DEBUG logging. 2016-07-27 04:01:24,003 attempt 1/10 2016-07-27 04:01:24,003 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:24,946 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:01:24.856055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.856428) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.856862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.857318) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.868248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-27 04:01:24.868510) ========= /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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:25 INFO - MultiFileLogger online at 20160727 04:01:25 in /builds/slave/test 04:01:25 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:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:25 INFO - {'append_to_log': False, 04:01:25 INFO - 'base_work_dir': '/builds/slave/test', 04:01:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:01:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:25 INFO - 'branch': 'Mozilla-Beta', 04:01:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:25 INFO - 'config_files': ('talos/linux_config.py',), 04:01:25 INFO - 'default_actions': ('clobber', 04:01:25 INFO - 'read-buildbot-config', 04:01:25 INFO - 'download-and-extract', 04:01:25 INFO - 'populate-webroot', 04:01:25 INFO - 'create-virtualenv', 04:01:25 INFO - 'install', 04:01:25 INFO - 'run-tests'), 04:01:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:25 INFO - 'download_minidump_stackwalk': True, 04:01:25 INFO - 'download_symbols': 'ondemand', 04:01:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:25 INFO - 'installer_path': 'installer.exe', 04:01:25 INFO - 'log_level': 'info', 04:01:25 INFO - 'log_name': 'talos', 04:01:25 INFO - 'log_to_console': True, 04:01:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:25 INFO - 'opt_config_files': (), 04:01:25 INFO - 'pip_index': False, 04:01:25 INFO - 'sps_profile': False, 04:01:25 INFO - 'sps_profile_interval': 0, 04:01:25 INFO - 'suite': 'dromaeojs', 04:01:25 INFO - 'system_bits': '32', 04:01:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:25 INFO - 'title': 'talos-linux64-ix-063', 04:01:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:25 INFO - 'use_talos_json': True, 04:01:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:25 INFO - 'work_dir': 'build'} 04:01:25 INFO - ##### 04:01:25 INFO - ##### Running clobber step. 04:01:25 INFO - ##### 04:01:25 INFO - Running pre-action listener: _resource_record_pre_action 04:01:25 INFO - Running main action method: clobber 04:01:25 INFO - rmtree: /builds/slave/test/build 04:01:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:25 INFO - Running post-action listener: _resource_record_post_action 04:01:25 INFO - ##### 04:01:25 INFO - ##### Running read-buildbot-config step. 04:01:25 INFO - ##### 04:01:25 INFO - Running pre-action listener: _resource_record_pre_action 04:01:25 INFO - Running main action method: read_buildbot_config 04:01:25 INFO - Using buildbot properties: 04:01:25 INFO - { 04:01:25 INFO - "project": "", 04:01:25 INFO - "product": "firefox", 04:01:25 INFO - "script_repo_revision": "production", 04:01:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:01:25 INFO - "repository": "", 04:01:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:01:25 INFO - "buildid": "20160726073802", 04:01:25 INFO - "pgo_build": "True", 04:01:25 INFO - "basedir": "/builds/slave/test", 04:01:25 INFO - "buildnumber": 180, 04:01:25 INFO - "slavename": "talos-linux64-ix-063", 04:01:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:01:25 INFO - "platform": "ubuntu64_hw", 04:01:25 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:25 INFO - "branch": "mozilla-beta", 04:01:25 INFO - "repo_path": "releases/mozilla-beta", 04:01:25 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:25 INFO - "stage_platform": "linux64-pgo", 04:01:25 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:25 INFO - "slavebuilddir": "test" 04:01:25 INFO - } 04:01:25 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:25 INFO - Running post-action listener: _resource_record_post_action 04:01:25 INFO - ##### 04:01:25 INFO - ##### Running download-and-extract step. 04:01:25 INFO - ##### 04:01:25 INFO - Running pre-action listener: _resource_record_pre_action 04:01:25 INFO - Running main action method: download_and_extract 04:01:25 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:25 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:26 INFO - Downloaded 1327 bytes. 04:01:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:26 INFO - Using the following test package requirements: 04:01:26 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:26 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:26 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'jsshell-linux-x86_64.zip'], 04:01:26 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:26 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:26 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:26 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:26 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:26 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:26 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:27 INFO - Downloaded 24199952 bytes. 04:01:27 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:27 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:28 INFO - Return code: 0 04:01:28 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:28 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:28 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:28 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:28 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:28 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:28 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:29 INFO - Downloaded 24199952 bytes. 04:01:29 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:29 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:33 INFO - Return code: 0 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 - 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:33 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:33 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:33 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:33 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:35 INFO - Downloaded 10840145 bytes. 04:01:35 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:35 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:35 INFO - Return code: 0 04:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:35 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:35 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:35 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:35 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:35 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:36 INFO - Downloaded 56024276 bytes. 04:01:36 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:36 INFO - mkdir: /builds/slave/test/properties 04:01:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:36 INFO - Contents: 04:01:36 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:37 INFO - Running post-action listener: _resource_record_post_action 04:01:37 INFO - Running post-action listener: set_extra_try_arguments 04:01:37 INFO - ##### 04:01:37 INFO - ##### Running populate-webroot step. 04:01:37 INFO - ##### 04:01:37 INFO - Running pre-action listener: _resource_record_pre_action 04:01:37 INFO - Running main action method: populate_webroot 04:01:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:37 INFO - '--tppagecycles', 04:01:37 INFO - '7'], 04:01:37 INFO - 'tests': ['tsvgm']}}, 04:01:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['damp', 'tps']}, 04:01:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'tests': ['damp', 'tps']}, 04:01:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['dromaeo_dom']}, 04:01:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['a11yr', 04:01:37 INFO - 'ts_paint', 04:01:37 INFO - 'tpaint', 04:01:37 INFO - 'sessionrestore', 04:01:37 INFO - 'sessionrestore_no_auto_restore', 04:01:37 INFO - 'tabpaint']}, 04:01:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['tsvgx', 04:01:37 INFO - 'tsvgr_opacity', 04:01:37 INFO - 'tart', 04:01:37 INFO - 'tscrollx', 04:01:37 INFO - 'cart']}, 04:01:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:37 INFO - 'tsvgr_opacity', 04:01:37 INFO - 'tart', 04:01:37 INFO - 'tscrollx', 04:01:37 INFO - 'cart']}, 04:01:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'talos_options': ['--disable-e10s'], 04:01:37 INFO - 'tests': ['tp5o']}, 04:01:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'tests': ['tp5o']}, 04:01:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'talos_options': ['--disable-e10s', 04:01:37 INFO - '--xperf_path', 04:01:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:37 INFO - 'tests': ['tp5n']}, 04:01:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:37 INFO - 'talos_options': ['--xperf_path', 04:01:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:37 INFO - 'tests': ['tp5n']}}, 04:01:37 INFO - 'talos.zip': {'path': '', 04:01:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:37 INFO - Running post-action listener: _resource_record_post_action 04:01:37 INFO - ##### 04:01:37 INFO - ##### Running create-virtualenv step. 04:01:37 INFO - ##### 04:01:37 INFO - Running pre-action listener: _resource_record_pre_action 04:01:37 INFO - Running main action method: create_virtualenv 04:01:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:37 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:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:37 INFO - Using real prefix '/usr' 04:01:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:40 INFO - Installing pip.................done. 04:01:40 INFO - Return code: 0 04:01:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:40 INFO - Using env: {'DISPLAY': ':0', 04:01:40 INFO - 'HOME': '/home/cltbld', 04:01:40 INFO - 'LANG': 'en_US.UTF-8', 04:01:40 INFO - 'LANGUAGE': 'en_US:en', 04:01:40 INFO - 'LOGNAME': 'cltbld', 04:01:40 INFO - 'MAIL': '/var/mail/cltbld', 04:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:40 INFO - 'MOZ_NO_REMOTE': '1', 04:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:40 INFO - 'NO_EM_RESTART': '1', 04:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:40 INFO - 'PWD': '/builds/slave/test', 04:01:40 INFO - 'SHELL': '/bin/bash', 04:01:40 INFO - 'SHLVL': '1', 04:01:40 INFO - 'TERM': 'linux', 04:01:40 INFO - 'TMOUT': '86400', 04:01:40 INFO - 'USER': 'cltbld', 04:01:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:40 INFO - '_': '/tools/buildbot/bin/python'} 04:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:40 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:40 INFO - Cleaning up... 04:01:40 INFO - Return code: 0 04:01:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:01:40 INFO - Using env: {'DISPLAY': ':0', 04:01:40 INFO - 'HOME': '/home/cltbld', 04:01:40 INFO - 'LANG': 'en_US.UTF-8', 04:01:40 INFO - 'LANGUAGE': 'en_US:en', 04:01:40 INFO - 'LOGNAME': 'cltbld', 04:01:40 INFO - 'MAIL': '/var/mail/cltbld', 04:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:40 INFO - 'MOZ_NO_REMOTE': '1', 04:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:40 INFO - 'NO_EM_RESTART': '1', 04:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:40 INFO - 'PWD': '/builds/slave/test', 04:01:40 INFO - 'SHELL': '/bin/bash', 04:01:40 INFO - 'SHLVL': '1', 04:01:40 INFO - 'TERM': 'linux', 04:01:40 INFO - 'TMOUT': '86400', 04:01:40 INFO - 'USER': 'cltbld', 04:01:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:40 INFO - '_': '/tools/buildbot/bin/python'} 04:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:40 INFO - Downloading/unpacking psutil>=0.7.1 04:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:42 INFO - Installing collected packages: psutil 04:01:42 INFO - Running setup.py install for psutil 04:01:42 INFO - building 'psutil._psutil_linux' extension 04:01:42 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 04:01:43 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:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:43 INFO - Successfully installed psutil 04:01:43 INFO - Cleaning up... 04:01:43 INFO - Return code: 0 04:01:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:01:43 INFO - Using env: {'DISPLAY': ':0', 04:01:43 INFO - 'HOME': '/home/cltbld', 04:01:43 INFO - 'LANG': 'en_US.UTF-8', 04:01:43 INFO - 'LANGUAGE': 'en_US:en', 04:01:43 INFO - 'LOGNAME': 'cltbld', 04:01:43 INFO - 'MAIL': '/var/mail/cltbld', 04:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:43 INFO - 'MOZ_NO_REMOTE': '1', 04:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:43 INFO - 'NO_EM_RESTART': '1', 04:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:43 INFO - 'PWD': '/builds/slave/test', 04:01:43 INFO - 'SHELL': '/bin/bash', 04:01:43 INFO - 'SHLVL': '1', 04:01:43 INFO - 'TERM': 'linux', 04:01:43 INFO - 'TMOUT': '86400', 04:01:43 INFO - 'USER': 'cltbld', 04:01:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:43 INFO - '_': '/tools/buildbot/bin/python'} 04:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:45 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:45 INFO - Installing collected packages: mozsystemmonitor 04:01:45 INFO - Running setup.py install for mozsystemmonitor 04:01:45 INFO - Successfully installed mozsystemmonitor 04:01:45 INFO - Cleaning up... 04:01:45 INFO - Return code: 0 04:01:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:01:45 INFO - Using env: {'DISPLAY': ':0', 04:01:45 INFO - 'HOME': '/home/cltbld', 04:01:45 INFO - 'LANG': 'en_US.UTF-8', 04:01:45 INFO - 'LANGUAGE': 'en_US:en', 04:01:45 INFO - 'LOGNAME': 'cltbld', 04:01:45 INFO - 'MAIL': '/var/mail/cltbld', 04:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:45 INFO - 'MOZ_NO_REMOTE': '1', 04:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:45 INFO - 'NO_EM_RESTART': '1', 04:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:45 INFO - 'PWD': '/builds/slave/test', 04:01:45 INFO - 'SHELL': '/bin/bash', 04:01:45 INFO - 'SHLVL': '1', 04:01:45 INFO - 'TERM': 'linux', 04:01:45 INFO - 'TMOUT': '86400', 04:01:45 INFO - 'USER': 'cltbld', 04:01:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:45 INFO - '_': '/tools/buildbot/bin/python'} 04:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:48 INFO - Downloading docopt-0.6.1.tar.gz 04:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:48 INFO - Running setup.py install for blobuploader 04:01:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:48 INFO - Running setup.py install for requests 04:01:49 INFO - Running setup.py install for docopt 04:01:49 INFO - Successfully installed blobuploader requests docopt 04:01:49 INFO - Cleaning up... 04:01:49 INFO - Return code: 0 04:01:49 INFO - Installing None 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', '--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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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', '--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:49 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: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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:49 INFO - Running setup.py (path:/tmp/pip-duyDXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:49 INFO - Running setup.py (path:/tmp/pip-d_tmNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:49 INFO - Running setup.py (path:/tmp/pip-eNPRBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:49 INFO - Running setup.py (path:/tmp/pip-hE1zz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:49 INFO - Running setup.py (path:/tmp/pip-jcPlys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:49 INFO - Running setup.py (path:/tmp/pip-NrbuAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:49 INFO - Running setup.py (path:/tmp/pip-yu0tTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:49 INFO - Running setup.py (path:/tmp/pip-wqZo5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:50 INFO - Running setup.py (path:/tmp/pip-QVGWJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:50 INFO - Running setup.py (path:/tmp/pip-LjHv9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:50 INFO - Running setup.py (path:/tmp/pip-0ra3Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:50 INFO - Running setup.py (path:/tmp/pip-eNE0Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:50 INFO - Running setup.py (path:/tmp/pip-pmJBHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:50 INFO - Running setup.py (path:/tmp/pip-TvfCG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:50 INFO - Running setup.py (path:/tmp/pip-7tuyw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:50 INFO - Running setup.py (path:/tmp/pip-BfmsLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:50 INFO - Running setup.py (path:/tmp/pip-9tTQUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:50 INFO - Running setup.py install for manifestparser 04:01:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozcrash 04:01:50 INFO - Running setup.py install for mozdebug 04:01:50 INFO - Running setup.py install for mozdevice 04:01:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozfile 04:01:51 INFO - Running setup.py install for mozhttpd 04:01:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozinfo 04:01:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozInstall 04:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozleak 04:01:51 INFO - Running setup.py install for mozlog 04:01:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for moznetwork 04:01:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozprocess 04:01:51 INFO - Running setup.py install for mozprofile 04:01:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozrunner 04:01:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozscreenshot 04:01:52 INFO - Running setup.py install for moztest 04:01:52 INFO - Running setup.py install for mozversion 04:01:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:52 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:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 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:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:52 INFO - 'LANG': 'en_US.UTF-8', 04:01:52 INFO - 'LANGUAGE': 'en_US:en', 04:01:52 INFO - 'LOGNAME': 'cltbld', 04:01:52 INFO - 'MAIL': '/var/mail/cltbld', 04:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:52 INFO - 'MOZ_NO_REMOTE': '1', 04:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:52 INFO - 'NO_EM_RESTART': '1', 04:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:52 INFO - 'PWD': '/builds/slave/test', 04:01:52 INFO - 'SHELL': '/bin/bash', 04:01:52 INFO - 'SHLVL': '1', 04:01:52 INFO - 'TERM': 'linux', 04:01:52 INFO - 'TMOUT': '86400', 04:01:52 INFO - 'USER': 'cltbld', 04:01:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:52 INFO - '_': '/tools/buildbot/bin/python'} 04:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:52 INFO - Running setup.py (path:/tmp/pip-BMnHUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:52 INFO - Running setup.py (path:/tmp/pip-XiPOvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:52 INFO - Running setup.py (path:/tmp/pip-au63Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:52 INFO - Running setup.py (path:/tmp/pip-skwkhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:52 INFO - Running setup.py (path:/tmp/pip-E8VYuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:53 INFO - Running setup.py (path:/tmp/pip-ti0uX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:53 INFO - Running setup.py (path:/tmp/pip-nCVYgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:53 INFO - Running setup.py (path:/tmp/pip-qLkp7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:53 INFO - Running setup.py (path:/tmp/pip-YGgbM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:53 INFO - Running setup.py (path:/tmp/pip-BUlMLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:53 INFO - Running setup.py (path:/tmp/pip-6fmQEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:53 INFO - Running setup.py (path:/tmp/pip-pjoOYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:53 INFO - Running setup.py (path:/tmp/pip-sJ_qNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:53 INFO - Running setup.py (path:/tmp/pip-N6ae9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:53 INFO - Running setup.py (path:/tmp/pip-nK809i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:53 INFO - Running setup.py (path:/tmp/pip-RfUgQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:53 INFO - Running setup.py (path:/tmp/pip-efbo9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:53 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:53 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:53 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:53 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:53 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:53 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:56 INFO - Downloading blessings-1.6.tar.gz 04:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:56 INFO - Installing collected packages: blessings 04:01:56 INFO - Running setup.py install for blessings 04:01:57 INFO - Successfully installed blessings 04:01:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:57 INFO - Reading from file tmpfile_stdout 04:01:57 INFO - Current package versions: 04:01:57 INFO - argparse == 1.2.1 04:01:57 INFO - blessings == 1.6 04:01:57 INFO - blobuploader == 1.2.4 04:01:57 INFO - docopt == 0.6.1 04:01:57 INFO - manifestparser == 1.1 04:01:57 INFO - mozInstall == 1.12 04:01:57 INFO - mozcrash == 0.17 04:01:57 INFO - mozdebug == 0.1 04:01:57 INFO - mozdevice == 0.48 04:01:57 INFO - mozfile == 1.2 04:01:57 INFO - mozhttpd == 0.7 04:01:57 INFO - mozinfo == 0.9 04:01:57 INFO - mozleak == 0.1 04:01:57 INFO - mozlog == 3.1 04:01:57 INFO - moznetwork == 0.27 04:01:57 INFO - mozprocess == 0.22 04:01:57 INFO - mozprofile == 0.28 04:01:57 INFO - mozrunner == 6.11 04:01:57 INFO - mozscreenshot == 0.1 04:01:57 INFO - mozsystemmonitor == 0.0 04:01:57 INFO - moztest == 0.7 04:01:57 INFO - mozversion == 1.4 04:01:57 INFO - psutil == 3.1.1 04:01:57 INFO - requests == 1.2.3 04:01:57 INFO - wsgiref == 0.1.2 04:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 INFO - Downloading/unpacking jsonschema 04:01:57 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:57 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:57 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:57 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:57 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:57 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:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:59 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:59 INFO - warning: no files found matching '*.txt' 04:01:59 INFO - no previously-included directories found matching 'build' 04:01:59 INFO - no previously-included directories found matching 'dist' 04:01:59 INFO - no previously-included directories found matching '.git*' 04:01:59 INFO - Installing collected packages: jsonschema, functools32 04:01:59 INFO - Running setup.py install for functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:00 INFO - Successfully installed jsonschema functools32 04:02:00 INFO - Cleaning up... 04:02:00 INFO - Return code: 0 04:02:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 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 0x7f2929187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', '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:02:00 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:02:00 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:02:00 INFO - Using env: {'DISPLAY': ':0', 04:02:00 INFO - 'HOME': '/home/cltbld', 04:02:00 INFO - 'LANG': 'en_US.UTF-8', 04:02:00 INFO - 'LANGUAGE': 'en_US:en', 04:02:00 INFO - 'LOGNAME': 'cltbld', 04:02:00 INFO - 'MAIL': '/var/mail/cltbld', 04:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:00 INFO - 'MOZ_NO_REMOTE': '1', 04:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:00 INFO - 'NO_EM_RESTART': '1', 04:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:00 INFO - 'PWD': '/builds/slave/test', 04:02:00 INFO - 'SHELL': '/bin/bash', 04:02:00 INFO - 'SHLVL': '1', 04:02:00 INFO - 'TERM': 'linux', 04:02:00 INFO - 'TMOUT': '86400', 04:02:00 INFO - 'USER': 'cltbld', 04:02:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:00 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Downloading/unpacking flake8 04:02:00 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:02:00 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:02:00 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:02:00 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:02:00 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:02:00 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:02:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 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:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:03 INFO - no previously-included directories found matching 'docs/_build' 04:02:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:03 INFO - Running setup.py install for pep8 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:03 INFO - no previously-included directories found matching 'docs/_build' 04:02:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:03 INFO - Cleaning up... 04:02:03 INFO - Return code: 0 04:02:03 INFO - Running post-action listener: _resource_record_post_action 04:02:03 INFO - Running post-action listener: _start_resource_monitoring 04:02:03 INFO - Starting resource monitoring. 04:02:03 INFO - ##### 04:02:03 INFO - ##### Running install step. 04:02:03 INFO - ##### 04:02:03 INFO - Running pre-action listener: _resource_record_pre_action 04:02:03 INFO - Running main action method: install 04:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:03 INFO - Reading from file tmpfile_stdout 04:02:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:03 INFO - Reading from file tmpfile_stdout 04:02:03 INFO - Output received: 04:02:03 INFO - Usage: mozinstall [options] installer 04:02:03 INFO - Options: 04:02:03 INFO - -h, --help show this help message and exit 04:02:03 INFO - -d DEST, --destination=DEST 04:02:03 INFO - Directory to install application into. [default: 04:02:03 INFO - "/builds/slave/test"] 04:02:03 INFO - --app=APP Application being installed. [default: firefox] 04:02:03 INFO - mkdir: /builds/slave/test/build/application 04:02:03 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:02:03 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:21 INFO - Reading from file tmpfile_stdout 04:02:26 INFO - Output received: 04:02:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:27 INFO - Running post-action listener: _resource_record_post_action 04:02:27 INFO - ##### 04:02:27 INFO - ##### Running run-tests step. 04:02:27 INFO - ##### 04:02:27 INFO - Running pre-action listener: _resource_record_pre_action 04:02:27 INFO - Running main action method: run_tests 04:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:27 INFO - Python 2.7.3 04:02:27 INFO - Return code: 0 04:02:27 INFO - grabbing minidump binary from tooltool 04:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:27 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 0x14e9410>, '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 0x14ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:27 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:27 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:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:27 INFO - Return code: 0 04:02:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:29 INFO - Return code: 0 04:02:29 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-063', '--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:29 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-063 --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:29 INFO - Using env: {'DISPLAY': ':0', 04:02:29 INFO - 'HOME': '/home/cltbld', 04:02:29 INFO - 'LANG': 'en_US.UTF-8', 04:02:29 INFO - 'LANGUAGE': 'en_US:en', 04:02:29 INFO - 'LOGNAME': 'cltbld', 04:02:29 INFO - 'MAIL': '/var/mail/cltbld', 04:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:29 INFO - 'MOZ_NO_REMOTE': '1', 04:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:29 INFO - 'NO_EM_RESTART': '1', 04:02:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:29 INFO - 'PWD': '/builds/slave/test', 04:02:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:29 INFO - 'SHELL': '/bin/bash', 04:02:29 INFO - 'SHLVL': '1', 04:02:29 INFO - 'TERM': 'linux', 04:02:29 INFO - 'TMOUT': '86400', 04:02:29 INFO - 'USER': 'cltbld', 04:02:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346', 04:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:29 INFO - '_': '/tools/buildbot/bin/python'} 04:02:29 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-063', '--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:30 INFO - mozversion application_buildid: 20160726073802 04:02:30 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:30 INFO - mozversion application_display_name: Firefox 04:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:30 INFO - mozversion application_name: Firefox 04:02:30 INFO - mozversion application_remotingname: firefox 04:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:30 INFO - mozversion application_vendor: Mozilla 04:02:30 INFO - mozversion application_version: 48.0 04:02:30 INFO - mozversion platform_buildid: 20160726073802 04:02:30 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:30 INFO - mozversion platform_version: 48.0 04:02:30 INFO - using testdate: 1469617350 04:02:30 INFO - actual date: 1469617350 04:02:30 INFO - starting webserver on 'localhost:41656' 04:02:30 INFO - SUITE-START | Running 2 tests 04:02:30 INFO - TEST-START | dromaeo_css 04:02:30 INFO - operating with platform_type : linux_ 04:02:30 INFO - Initialising browser for dromaeo_css test... 04:02:30 INFO - TEST-INFO | started process 16524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCz_U3v/profile http://localhost:41656/getInfo.html) 04:02:36 INFO - PROCESS | 16524 | __metrics Screen width/height:1600/1200 04:02:36 INFO - PROCESS | 16524 | colorDepth:24 04:02:36 INFO - PROCESS | 16524 | Browser inner width/height: 1024/697 04:02:36 INFO - PROCESS | 16524 | __metrics 04:02:38 INFO - PROCESS | 16524 | 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:38 ERROR - PROCESS | 16524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:39 INFO - TEST-INFO | 16524: exit 0 04:02:39 INFO - Browser initialized. 04:02:39 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:39 INFO - TEST-INFO | started process 16617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCz_U3v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:51 INFO - PROCESS | 16617 | RSS: Main: 139370496 04:02:51 INFO - PROCESS | 16617 | 04:03:42 INFO - PROCESS | 16617 | 1469617422412 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:51 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41656/tests/dromaeo/cssquery-ext.html) 04:05:52 INFO - PROCESS | 16617 | RSS: Main: 246312960 04:05:52 INFO - PROCESS | 16617 | 04:08:54 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-ext.html (next: http://localhost:41656/tests/dromaeo/cssquery-jquery.html) 04:08:54 INFO - PROCESS | 16617 | RSS: Main: 218918912 04:08:54 INFO - PROCESS | 16617 | 04:11:56 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41656/tests/dromaeo/cssquery-mootools.html) 04:11:57 INFO - PROCESS | 16617 | RSS: Main: 210378752 04:11:57 INFO - PROCESS | 16617 | 04:14:59 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41656/tests/dromaeo/cssquery-prototype.html) 04:14:59 INFO - PROCESS | 16617 | RSS: Main: 217735168 04:14:59 INFO - PROCESS | 16617 | 04:18:02 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41656/tests/dromaeo/cssquery-yui.html) 04:18:02 INFO - PROCESS | 16617 | RSS: Main: 208961536 04:18:02 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:41656/tests/dromaeo/cssquery-yui.html (next: http://localhost:41656/tests/dromaeo/cssquery-dojo.html) 04:21:05 INFO - PROCESS | 16617 | RSS: Main: 255750144 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | __start_tp_report 04:21:05 INFO - PROCESS | 16617 | _x_x_mozilla_page_load 04:21:05 INFO - PROCESS | 16617 | _x_x_mozilla_page_load_details 04:21:05 INFO - PROCESS | 16617 | |i|pagename|runs| 04:21:05 INFO - PROCESS | 16617 | |0;dojo.html;3263.314703912178;3334.1331253873986;3337.8164200968936;3348.1294863335556;3369.0398236502615;5384.784608615656;5386.569074474042;5386.596005299603;5388.353397592285;5401.972990135054;5397.568194544427;5405.432320063728;5406.756695948682;5410.864728381793;5455.290812194419;4903.239997800347;4911.214205727084;4954.504549545053;4985.551300382965;5007.974960125212;4855.271709243606;4975.925361119568;4980.178270585349;5014.598832093442;5061.6962982221;4948.752562371885;4972.477889821571;4977.50224977503;4983.302337672711;5011.398632164145;4934;4943.703377797344;4966.826161084345;4981.327520784684;4989.600831933455;4864.8297309594345;4875.073735990186;4963;4966.627502937295;4983.651144419892;5291.074062039166;5315.548178404841;5319.654222475527;5329.973350133225;5347.304850369427;5662.09406494963;5803.47768700819;5803.912941305884;5810.6513609183585;5845.357010728816;5735.885282294331;5754.97122514389;5800.622959507618;5829.446202610745;5845.620034697731;5490.313710786152;5496.972515137439;5498.037843377433;5499.615026948155;5502.532284755801;5705.286839145107;5768.567357448208;5937.495312898452;5950.9702451487465;5951.256092988377;5735.340435849847;5739.62692424991;5759.049756790083;5773.39379365169;5773.624714393551;5816.505597024216;5825.242718446575;5829.387914269026;5829.650220986754;5835.328937172279;5670.149477578396;5685.971570142206;5799.710014499258;5815.360310365856;5815.82552523425;5780.479756821906;5797.565182611321;5801.7389217485315;5812.9709351452975;5842.036064049469;4430.047539778899;4465.0623369092855;4467.128909862546;4472.44094488189;4496.730196188174;3919.862804801818;3946.4080387941463;3995.760254384746;4031.07285324377;4075.449814275094;5566.916496252559;5573.136163894603;5597.328320601472;5601.383847776741;5606.831795046155;5830.096335068071;5835.562332825055;5846.29844418664;5847.473727364472;5854;5443.673379597237;5531.197976293415;5573.777048918079;5608.383077861432;5626.549876009909;5033.471485494044;5050.04049230645;5051.6716413433005;5051.772670229849;5057.747112644353;6085.847853803691;6090;6091.604045737013;6093.39066093396;6113.480354169946;5651.067573850269;5727.226824378656;5803.129530570448;5804.535637148933;5806.883862322815;6049.425304596057;6052.636841789506;6053.878922421615;6057.939420605738;6058.333583305921;5575.219469274224;5733.054046082517;5739.569532285179;5744.712764361681;5757.65454072757;5732.742026608729;5815.912761308499;5825.330087040044;5843;5851.356350801323;5632.155176723524;5642.520385767091;5645.774169033357;5658.7736490541565;5676;5480.095784195563;5672.60291779588;5677.460641239076;5684.914726279192;5691.032524470767;5511.145772405283;5573.944260557342;5576.33084029919;5582.0231459495235;5608.355039170385;5660.801871934463;5667.064934285797;5672.319321681424;5673.858153546194;5683.318001839806;5469.453054694499;5525.11598144295;5535.529479994246;5575;5593.384727680033 04:21:05 INFO - PROCESS | 16617 | |1;ext.html;591.6479694581725;646.7833275852589;653.689497488693;659.4526542969335;665.9833504162399;33097.834510827444;33730.15674608133;39470.802645986805;40509.797451012775;40512.392314115314;43137.568624313746;43409.78295108528;43673.7816310918;43866.56133438665;43943.12113757723;8093.231143041402;8825.602847871829;9050.32122590805;9055.230305424015;10377.377357358544;10471.895281047167;10626.14990800734;10628.36229826213;10628.521716522775;10631.946840265788;10583.417912014836;10669.146468282557;10676.306040107407;10677.305975111592;10677.78644427111;10548.683539493828;10608.893911060906;10610.098141657969;10624.840627390595;10626.734331641694;10472.633457828939;10561.73595660107;10580.735481612945;10891.727706807314;10892.673219803419;41777;42285.78857105726;42307.57692423067;42310.57689423097;42315.36526952098;3633.927321453556;3723.1809002019513;3725.2735716535285;3762.1347090169415;3932.960670393317;29277.56083658747;29637.407251855057;30026;30054.398912021858;30382.84808575965;4365.257906155961;4432.312991486325;4453.955460445386;4457.866264012052;4489.371487991683;205506;205848;206158;206216;206737.966310169;39424.40863387052;57777.711111445016;63365.36634633687;63399.68300158469;63421.36578634154;37164;37298.627013729514;37405.25189496195;37435;37459.62540374562;17131.400400986156;17372;17377.04426256543;17381.391651292397;17383.130843457777;13354.46582136723;14254.572362829133;14599.78100328496;14648.853511464962;14717.264136793117;9236.399634023766;9286.489243091695;9296.72109836706;9348.158665719982;9349.39228950116;3540.2211513466996;3580.15866271426;3611.8013509257244;3673.3020726061964;3691.7969511677115;1084.251866212311;1090;1127.143371038017;1128.3244382092587;1144.6279959013355;32459.675403246136;32653.346933061206;32884.83557582197;33808.15479613029;33810.32379352399;1220.383706228349;1241.6523373455448;1255.4413286087604;1326.2175316563082;1363.195714528433;17302.394416195373;17687.115644217738;17938;18043.18805653749;18095;495009;497784;499269;499800;501054;62548.687256563426;62999.37000630027;63096;63429.36570634327;63465.68267158727;1384.252503648039;1514.954551363439;1574.6063484128968;1580.8498192671448;1633.0691505841794;29032.56451153192;29396.706032939397;29638.259043523223;31438.214044648154;31906.6809331913;49153.75423123004;49233.75383123061;49647;50030.74984625054;50105;368464;369936;372344;372788;486074;29339.41321173607;29791.106266812032;29819.701802981694;29825.70174298229;29829.254268643457;41229.1754164909;41668.58331416647;41817;42785.786071069444;42813.143737125705;35275;35537;35589.644103559665;35711.28577428489;36246;34650.30699386049;34816.651833481345;35292.823535882155;37849.81075094607;38199.427008594335;39002.2199556013;39314.410283845194;40093;44702.552974469836;45690.54309456863;32664;33396.833015835735;34012.149696257795;34018.65981340155;34135.65864341325;26496.735032649427;26876;26935.730642694107;27320.137548441653;28043.719562804927 04:21:05 INFO - PROCESS | 16617 | |2;jquery.html;426.94663167104113;431.71291091424195;432.146093259915;438.50887006552665;443.5852477933133;18333.26666933323;19096.236150553977;19103.61792764144;19210.615787684237;20019.799802002013;12199.207051541644;12254.326012069332;12585.244885306887;13043.478260869553;13065.804012939814;5420.674759514432;5423.105187644034;5473.753681084341;5483.561315094803;5578.330600327946;4045.37296719009;4294.978525107385;5441.455854414547;5992.221011268529;6073.119397687333;6048.2137322148055;6064.545159113062;6067.362926892679;6077.969610151943;6086.2087928569445;4122.319817230154;5704.629199102045;5985.1022346647915;5998.370171132034;6010.789622363218;5631.60578759487;5939.049752039653;5939.049752039653;5939.970300148515;5956.047032474827;13741.793873091912;14119.152850828881;14122.576322710334;14226.644333891632;14585.635359116;2460.3726049857173;2723.5914612808037;3016.8039077459894;3067.5858759067687;3083.784135110543;10455.58177672892;10642.680719578426;10760.13918886495;10769.676909692722;10897.237193396466;1970.3202395173641;2074.1806986240504;2129.2121914891436;2133.0721136305756;2146.259540458555;71795.64102179508;78126.60936695337;79669.60165199195;80153.59923200405;83447.58276208641;10868.130549556017;11248.100151987821;11367.54529818798;11415.657530273938;11469.942650286863;16316.265768040466;16357.754633680504;16477.83522164763;16478.6704265914;16482.83517164837;8926.821463570823;8946;9072.228860546928;9084.40951338161;9120.954395227982;8704.260137888225;8743.825123497621;8761.080086590817;8793.340499462565;8984.955075224712;5100.897982040413;5158.63889527737;5159.974200128975;5175.378954525481;5179.119549676564;1974.2399176316935;2063.4428704249767;2106.8946552672305;2133.989330053371;2139.433050241656;1018.3279035836313;1021.6015753856002;1051.458498873081;1126.4930781148353;1129.3562669278597;18484.72272915907;19028.388644542294;19295.8070419294;19364.128614212394;19389.8061019388;1022.7852151048214;1056.8309070548828;1068.2201992545486;1071.5499490214129;1100.6312885183393;10779.514921828537;11093.112550996062;11114.444277786079;11239.988401043782;11396.373199473943;175046;404402;488263;507628;510147;89474.55262723645;89832;91263;92677.5366123165;93466;1082.0802318029769;1089.3082892363407;1102.393683474102;1122.680036189682;1128.4019469680918;17075.573110672332;17154.914225428794;17163.7425438616;17190.31238750436;17506.387276445264;39590;39952.800235998635;40849;41551.376729349686;41589.58410415857;57567.712161438925;58033.4196658028;58873.11690324734;59214.40785592089;59313.703431482565;8850.380473366802;8908.198262156437;8938.910610893809;9043.095690430904;9232.261419086322;11421;13526.25605591702;13606;13644.795328070286;13648.24934628605;11717.414129293671;12012.459439325427;12069.456874440846;12346.691332716395;12493.437795299415;7781.883271750815;11012.39431831257;11468.139889508488;11740.119491038036;11963.581274655346;6667.833304167435;9211.447313161232;12193.390330483262;12210.511579536718;12536.498540058661;9004.639814407612;9020.413673111227;9089.818203636023;9258.95370523143;9260.953695231481;9992.450415227233;11472.598459053894;12357.567485137977;12406.565770198;12493.25040497573 04:21:05 INFO - PROCESS | 16617 | |3;mootools.html;1396.5670642100956;1526.8854835887307;1590.0141912014553;1778.759867417899;1913.2633935934662;7892.6448309826055;8079.798005049869;8109.351251899849;8114.148014458486;8117.472364296316;7929.286364227219;8090.838183236332;8096.43324967251;8101.675932962675;8107.18928107189;2279.908803647856;2324.2213858357472;2327.8137748980125;2327.9534409311887;2331.1258278145697;2349.283468542094;2364.137089962169;2426.4904370082304;2455.1897873701637;2465.272744540356;2326.895289711967;2388.7133543974746;2391.7129944406697;2397.1729753235104;2412.360724408033;2376.4296568823356;2380.1788383007834;2398.2205783120557;2406.879656017201;2422.345966589011;2339.520398318358;2376.4415362389823;2391.7129944406784;2394.904203831845;2407.386116540271;7098.041764361797;7585.317321441042;8375.623096960651;8409.747707568782;8432.114627964036;5013.824516141954;5086.1353569892835;5110.207917772714;5118.846434606968;5121.2574176744165;3200.1199670090678;3268.754843386732;3297.1097803592897;3307.1897385140555;3334.6331903490595;1107.413071072333;1113.4432783608195;1148.6853989211745;1157.2188772578477;1163.575295017321;10702.983216594412;10878.510467029002;10880.347179169275;11137.443127843575;11154;4278.2085314216965;4304.526502084768;4347.456567929009;4388.912221755547;4435.290353543418;9622.13400793932;9640.276979226586;9656.32405731592;9659.082387173208;9662.9033709662;5035.546800787946;5037.647364684511;5038.647294689336;5042.974785126051;5044.545990860766;4628.190066738374;4628.583427491542;4630.189716799547;4634.629229661619;4638.97680511602;3664.212194378168;3854.8820841955517;3872.4772155759174;3890.2025084857537;3898.142408670088;1198.9580364687195;1230.4217018001525;1237.9257244565356;1238.4365113873346;1246.4764798784352;902.251131560803;908.7864351877304;954.3748844506721;962.7938963252353;970.9951450242703;5509.972450137724;5531.8340449785765;5606.943930560724;5607.102863541813;5737.91393129095;475.89768199837204;477.07447551749493;477.7420193095759;477.7706700783574;486.25117319327836;4076.5923407658997;4094.3653733671326;4103.158852435244;4103.302438585448;4128.958710412918;9722.222222222204;9911.15755160805;9965;10051.145652619463;10066.848997265048;9885.752856178653;9952.80094398108;9966.103050725469;10005.949970250102;10017.098461138532;7738.961305193438;7857.685692572233;7874.6850125994315;7988.960055199803;8009.0789559200275;5460.781568737365;5520.475554822286;5551.666899986014;5562.610617256915;5664.575156863334;8944.776380590538;9026.052264512131;9128.224100951493;9164.725058248263;9226.677066302647;8844.823103538021;9163.175314221751;9361.531923403667;9428.669996550088;9470.052994700474;7330.193678695446;7379.151397589346;7416.332530072319;7418.36943859778;7419.703211871681;7712.38300935935;7794.610269486389;7795.883061754192;7795.961020194863;7798.688052477837;7094;7261.927380726125;7312.707491700273;7371.226021267904;7482;7108.786736397917;7116.323949224816;7210.315020073294;7218.747343842941;7283.308085731847;6184.6598437086395;6810.795676129724;6819.829504262433;6838.111045564045;6854.074699915447;4174.269502836931;4867.342908707279;4964.230544265644;5192.428832828461;5274.235235890697;5059.949400506095;5096.413912400121;5153.871153221199;5156.071907056766;5326.627136100436 04:21:05 INFO - PROCESS | 16617 | |4;prototype.html;354.38514177901345;354.99645003549966;362.81133810418584;369.2872755581726;371.75092687899104;6020;6030.065339872322;6078.817635470938;6104.603200791946;6113.144159817618;6024.006039003571;6031.215941927554;6037.154798328226;6057.848553786146;6060.575759696823;4476.776161191944;4598.862034138964;4699.9895022570145;4743.430788305391;4759.309900064489;4712.269598212282;4717.2924061390895;4731.077439899221;4738.715677059387;4741.075490279397;4481.46222453306;4700.811967521295;4701.78841952113;4704.553067458586;4706.082313948764;4586.885327866813;4664.277037059244;4669;4703.576678098988;4717.952820471785;4134.607212314855;4143.005678637105;4147.04617937873;4151.356539736345;4161.334186530171;5866.325372582165;5904.114382842608;5904.380040095771;5905.350411454737;5911.142884281798;5433.239346491494;5436.619436639437;5463.7814487420455;5466.781328746845;5468.398476167618;6387.489000879918;6410.583312084699;6415.101885736;6418.03729440583;6425;4366.214081465335;4497.865064048084;4499.347594598765;4504.549545045502;4507.549245075466;6620.106285651472;6698.062271282024;6728.596284222962;6735.730570777163;6738.4609231261875;4610.40064791575;4634.582887540138;4637.9536204637525;4642.37327960721;4644.651651126179;4694.0611877624615;4702.811887524529;4725.976370118127;4738.384010078667;4739;5414.269073675082;5421;5424.593155513273;5430.402655707869;5433.429489903582;6365.872682546323;6470.741170353133;6493.642849643221;6511.479081673455;6513.641749703812;1633.4201358517794;1633.501781956491;1645.6873194093084;1649.6700659868075;1652.6529428819842;991.5736233419699;1074.5379486820586;1075.0646937164718;1100.5982816272003;1100.7743412600398;6275.5920865144535;6303.401176888188;6317.431431171217;6332.271788744353;6391.776287829996;6609.405153536205;6614.338566143443;6616.437602803816;6619.536632435779;6624.244575187579;6292.874142517124;6294.716737746812;6299.874002519924;6308.936910630927;6314.210723659543;3544.078539579676;3577.3918433866306;3581.3374525712825;3581.7850928944345;3583.9104022399647;6789.0834737310815;6813.727450901908;6880.174379074443;6940;6964.4428445724225;6706.362895524917;6724.3611856874495;6732.798016059526;6734;6742.966285168641;6921.342472465108;6932.202796678345;6934.133233345932;6936.895946560806;6938.722451102;6620.172478440195;6621;6627.1716035495565;6629.171353580802;6636.0377745225705;6412.267119524574;6517.185351831021;6519.771807986698;6530.8367290818105;6535.117759102651;6882.449404047764;6902.033715279765;6911.516193866582;6913.861722765617;6924.6537673117155;4617.722936623813;4620.306953956933;4630.398048253705;4638;4638.165130276582;6512.511561632802;6519.08732777402;6537.444317233088;6611.933880661132;6613.27254002069;6306.747730090745;6329.873402531832;6401.7119229633845;6412.6793660317735;6416.518761092843;6391.520635952229;6401.103845461546;6413.775517856852;6418.550701450854;6433.388828061326;6316.178896743394;6331.651759153291;6332.778352757631;6333.493320534254;6337.524685648503;6452.096706461005;6456.483481321389;6472.029195620695;6472.676366181578;6474.643894585843;6139.6009259398;6276.592021518587;6298.118263443213;6308.495320374451;6330.746770129327 04:21:05 INFO - PROCESS | 16617 | |5;yui.html;845.2899564365931;908.2915326045684;939.8966113727491;943.8206740719268;955.1642312976146;14131.505397311095;14197.29013549321;14279.78580321296;14311.212883291428;14383.928080359598;13255.27096009719;13262.469501219965;13284.335783210849;13291.468341266362;13394.866051339484;774.7753151586033;908.0783005249676;911.4622372800063;919.5264438814016;923.6674797073048;915.6612053540166;916.2990312410977;917.0325306801321;917.3945196170529;917.8623206519043;947.5262368815593;953.3945944325369;953.771094937217;954.5036580977887;956.942583444992;789.7157023471574;924.1267002682467;944.4380593546829;946.1957336264189;948.3456415073578;705.3299365602646;705.7635692043172;705.9611721355324;706.2055187913597;707.3598393453932;14708.705825883422;14771.335289911873;14794.334254958552;14805.407783688639;14819.259037048105;14127.081739686888;14211.147331160164;14554.12675239489;14556.417743290362;14678.412863485448;10521.421321827296;10557.260991730582;10611.363318200933;10633.202509811796;10752.354858708502;4045.5145382553987;4057.918841623151;4095.631393174599;4112.835486580563;4176.436181115541;54357.728211359085;54395.184072238946;54406.911861762936;54686.72656636731;54921.176182357296;11293.54825806975;11493.195476316745;11621.53513859453;11671.59149429766;11693.298402095901;19585.608287834162;19602.509937251398;19660.70508942367;19676.114574844167;19677.212911483668;8088.555129467818;8184.427090103635;8201.83596328082;8314.251717345347;8521.659133634708;4766.285057241442;4823.9517604824205;4827.396575428072;4934.7285899275885;4951.603871690256;3248.171716212351;3285.392202442508;3301.7853839500835;3307.570015897918;3308.751843611739;628.2115944489636;683.2654895986834;741.5810067311952;748.4835463530147;766.0998326965793;696.373264062348;733.3583114774573;758.768575584452;761.0410882288356;776.5263189454429;8641.827163456695;9079.319051071196;9505.66730164441;10093.596256149818;10247.180225581935;758.836850077236;763.2177018556024;813.259933460548;829.1749709039544;835.4653022065883;4385.846495372647;4497.820087196541;4552.704074235164;4583.816647334069;4633.162488154192;61473.38526614766;62640.68679656572;62650.686746565974;62710.68644656747;62752.37247627557;49617.50382496201;52440.47559524356;52774.20838687423;54179.18731219035;54209.457905420444;44309.33535996963;44684.329735054;44792.77603612026;46094.30858537125;48601.027979440216;8986.640534378552;8995.325350598601;9040.095990400907;9249.768755781159;9261.44431334122;36280.81859590685;37140.81429592835;37325.25349493049;37336.25327493489;37998.240035198585;42786.78606606947;42840;46249;47810.521894780606;47850.76074619604;12430.689232769253;12633.557825476064;12751.74496510046;12876.420561074587;13294.468221271427;12751.936240318739;12809.61571152867;12877.162984405984;13348.399322030338;13460.394282257126;13786.586402407944;13899.861001389856;14031.719365612427;14116;14168.574942751733;12754.744905102032;13353.933230333787;13545.05184637066;13728.862711372758;14155.117363432164;12011.279323240633;12259.877401225873;12654;12716.554920577735;12794.360281985677;10915.181361397768;11010.50452729613;11040.33757974524;11055.668329950115;11173.273737207055;11088.942979130894;11134.610288640182;11214.887851121384;11404.828927565926;11414.714632133931 04:21:05 INFO - PROCESS | 16617 | __end_tp_report 04:21:05 INFO - PROCESS | 16617 | __start_cc_report 04:21:05 INFO - PROCESS | 16617 | _x_x_mozilla_cycle_collect,776 04:21:05 INFO - PROCESS | 16617 | __end_cc_report 04:21:05 INFO - PROCESS | 16617 | __startTimestamp1469618465388__endTimestamp 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | ------- Summary: start ------- 04:21:05 INFO - PROCESS | 16617 | Number of tests: 6 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#0] dojo.html Cycles:165 Average:5404.48 Median:5601.38 stddev:585.05 (10.4%) stddev-sans-first:562.21 04:21:05 INFO - PROCESS | 16617 | Values: 3263.3 3334.1 3337.8 3348.1 3369.0 5384.8 5386.6 5386.6 5388.4 5402.0 5397.6 5405.4 5406.8 5410.9 5455.3 4903.2 4911.2 4954.5 4985.6 5008.0 4855.3 4975.9 4980.2 5014.6 5061.7 4948.8 4972.5 4977.5 4983.3 5011.4 4934.0 4943.7 4966.8 4981.3 4989.6 4864.8 4875.1 4963.0 4966.6 4983.7 5291.1 5315.5 5319.7 5330.0 5347.3 5662.1 5803.5 5803.9 5810.7 5845.4 5735.9 5755.0 5800.6 5829.4 5845.6 5490.3 5497.0 5498.0 5499.6 5502.5 5705.3 5768.6 5937.5 5951.0 5951.3 5735.3 5739.6 5759.0 5773.4 5773.6 5816.5 5825.2 5829.4 5829.7 5835.3 5670.1 5686.0 5799.7 5815.4 5815.8 5780.5 5797.6 5801.7 5813.0 5842.0 4430.0 4465.1 4467.1 4472.4 4496.7 3919.9 3946.4 3995.8 4031.1 4075.4 5566.9 5573.1 5597.3 5601.4 5606.8 5830.1 5835.6 5846.3 5847.5 5854.0 5443.7 5531.2 5573.8 5608.4 5626.5 5033.5 5050.0 5051.7 5051.8 5057.7 6085.8 6090.0 6091.6 6093.4 6113.5 5651.1 5727.2 5803.1 5804.5 5806.9 6049.4 6052.6 6053.9 6057.9 6058.3 5575.2 5733.1 5739.6 5744.7 5757.7 5732.7 5815.9 5825.3 5843.0 5851.4 5632.2 5642.5 5645.8 5658.8 5676.0 5480.1 5672.6 5677.5 5684.9 5691.0 5511.1 5573.9 5576.3 5582.0 5608.4 5660.8 5667.1 5672.3 5673.9 5683.3 5469.5 5525.1 5535.5 5575.0 5593.4 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#1] ext.html Cycles:180 Average:52656.93 Median:35283.91 stddev:102773.77 (291.3%) stddev-sans-first:102987.74 04:21:05 INFO - PROCESS | 16617 | Values: 591.6 646.8 653.7 659.5 666.0 33097.8 33730.2 39470.8 40509.8 40512.4 43137.6 43409.8 43673.8 43866.6 43943.1 8093.2 8825.6 9050.3 9055.2 10377.4 10471.9 10626.1 10628.4 10628.5 10631.9 10583.4 10669.1 10676.3 10677.3 10677.8 10548.7 10608.9 10610.1 10624.8 10626.7 10472.6 10561.7 10580.7 10891.7 10892.7 41777.0 42285.8 42307.6 42310.6 42315.4 3633.9 3723.2 3725.3 3762.1 3933.0 29277.6 29637.4 30026.0 30054.4 30382.8 4365.3 4432.3 4454.0 4457.9 4489.4 205506.0 205848.0 206158.0 206216.0 206738.0 39424.4 57777.7 63365.4 63399.7 63421.4 37164.0 37298.6 37405.3 37435.0 37459.6 17131.4 17372.0 17377.0 17381.4 17383.1 13354.5 14254.6 14599.8 14648.9 14717.3 9236.4 9286.5 9296.7 9348.2 9349.4 3540.2 3580.2 3611.8 3673.3 3691.8 1084.3 1090.0 1127.1 1128.3 1144.6 32459.7 32653.3 32884.8 33808.2 33810.3 1220.4 1241.7 1255.4 1326.2 1363.2 17302.4 17687.1 17938.0 18043.2 18095.0 495009.0 497784.0 499269.0 499800.0 501054.0 62548.7 62999.4 63096.0 63429.4 63465.7 1384.3 1515.0 1574.6 1580.8 1633.1 29032.6 29396.7 29638.3 31438.2 31906.7 49153.8 49233.8 49647.0 50030.7 50105.0 368464.0 369936.0 372344.0 372788.0 486074.0 29339.4 29791.1 29819.7 29825.7 29829.3 41229.2 41668.6 41817.0 42785.8 42813.1 35275.0 35537.0 35589.6 35711.3 36246.0 34650.3 34816.7 35292.8 37849.8 38199.4 39002.2 39314.4 40093.0 44702.6 45690.5 32664.0 33396.8 34012.1 34018.7 34135.7 26496.7 26876.0 26935.7 27320.1 28043.7 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#2] jquery.html Cycles:180 Average:26571.22 Median:2142.85 stddev:72384.52 (3378.0%) stddev-sans-first:72560.95 04:21:05 INFO - PROCESS | 16617 | Values: 426.9 431.7 432.1 438.5 443.6 18333.3 19096.2 19103.6 19210.6 20019.8 12199.2 12254.3 12585.2 13043.5 13065.8 5420.7 5423.1 5473.8 5483.6 5578.3 4045.4 4295.0 5441.5 5992.2 6073.1 6048.2 6064.5 6067.4 6078.0 6086.2 4122.3 5704.6 5985.1 5998.4 6010.8 5631.6 5939.0 5939.0 5940.0 5956.0 13741.8 14119.2 14122.6 14226.6 14585.6 2460.4 2723.6 3016.8 3067.6 3083.8 10455.6 10642.7 10760.1 10769.7 10897.2 1970.3 2074.2 2129.2 2133.1 2146.3 71795.6 78126.6 79669.6 80153.6 83447.6 10868.1 11248.1 11367.5 11415.7 11469.9 16316.3 16357.8 16477.8 16478.7 16482.8 8926.8 8946.0 9072.2 9084.4 9121.0 8704.3 8743.8 8761.1 8793.3 8985.0 5100.9 5158.6 5160.0 5175.4 5179.1 1974.2 2063.4 2106.9 2134.0 2139.4 1018.3 1021.6 1051.5 1126.5 1129.4 18484.7 19028.4 19295.8 19364.1 19389.8 1022.8 1056.8 1068.2 1071.5 1100.6 10779.5 11093.1 11114.4 11240.0 11396.4 175046.0 404402.0 488263.0 507628.0 510147.0 89474.6 89832.0 91263.0 92677.5 93466.0 1082.1 1089.3 1102.4 1122.7 1128.4 17075.6 17154.9 17163.7 17190.3 17506.4 39590.0 39952.8 40849.0 41551.4 41589.6 57567.7 58033.4 58873.1 59214.4 59313.7 8850.4 8908.2 8938.9 9043.1 9232.3 11421.0 13526.3 13606.0 13644.8 13648.2 11717.4 12012.5 12069.5 12346.7 12493.4 7781.9 11012.4 11468.1 11740.1 11963.6 6667.8 9211.4 12193.4 12210.5 12536.5 9004.6 9020.4 9089.8 9259.0 9261.0 9992.5 11472.6 12357.6 12406.6 12493.3 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#3] mootools.html Cycles:180 Average:5446.76 Median:5103.31 stddev:2966.79 (58.1%) stddev-sans-first:2959.49 04:21:05 INFO - PROCESS | 16617 | Values: 1396.6 1526.9 1590.0 1778.8 1913.3 7892.6 8079.8 8109.4 8114.1 8117.5 7929.3 8090.8 8096.4 8101.7 8107.2 2279.9 2324.2 2327.8 2328.0 2331.1 2349.3 2364.1 2426.5 2455.2 2465.3 2326.9 2388.7 2391.7 2397.2 2412.4 2376.4 2380.2 2398.2 2406.9 2422.3 2339.5 2376.4 2391.7 2394.9 2407.4 7098.0 7585.3 8375.6 8409.7 8432.1 5013.8 5086.1 5110.2 5118.8 5121.3 3200.1 3268.8 3297.1 3307.2 3334.6 1107.4 1113.4 1148.7 1157.2 1163.6 10703.0 10878.5 10880.3 11137.4 11154.0 4278.2 4304.5 4347.5 4388.9 4435.3 9622.1 9640.3 9656.3 9659.1 9662.9 5035.5 5037.6 5038.6 5043.0 5044.5 4628.2 4628.6 4630.2 4634.6 4639.0 3664.2 3854.9 3872.5 3890.2 3898.1 1199.0 1230.4 1237.9 1238.4 1246.5 902.3 908.8 954.4 962.8 971.0 5510.0 5531.8 5606.9 5607.1 5737.9 475.9 477.1 477.7 477.8 486.3 4076.6 4094.4 4103.2 4103.3 4129.0 9722.2 9911.2 9965.0 10051.1 10066.8 9885.8 9952.8 9966.1 10005.9 10017.1 7739.0 7857.7 7874.7 7989.0 8009.1 5460.8 5520.5 5551.7 5562.6 5664.6 8944.8 9026.1 9128.2 9164.7 9226.7 8844.8 9163.2 9361.5 9428.7 9470.1 7330.2 7379.2 7416.3 7418.4 7419.7 7712.4 7794.6 7795.9 7796.0 7798.7 7094.0 7261.9 7312.7 7371.2 7482.0 7108.8 7116.3 7210.3 7218.7 7283.3 6184.7 6810.8 6819.8 6838.1 6854.1 4174.3 4867.3 4964.2 5192.4 5274.2 5059.9 5096.4 5153.9 5156.1 5326.6 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#4] prototype.html Cycles:180 Average:5407.44 Median:6276.09 stddev:1614.25 (25.7%) stddev-sans-first:1573.59 04:21:05 INFO - PROCESS | 16617 | Values: 354.4 355.0 362.8 369.3 371.8 6020.0 6030.1 6078.8 6104.6 6113.1 6024.0 6031.2 6037.2 6057.8 6060.6 4476.8 4598.9 4700.0 4743.4 4759.3 4712.3 4717.3 4731.1 4738.7 4741.1 4481.5 4700.8 4701.8 4704.6 4706.1 4586.9 4664.3 4669.0 4703.6 4718.0 4134.6 4143.0 4147.0 4151.4 4161.3 5866.3 5904.1 5904.4 5905.4 5911.1 5433.2 5436.6 5463.8 5466.8 5468.4 6387.5 6410.6 6415.1 6418.0 6425.0 4366.2 4497.9 4499.3 4504.5 4507.5 6620.1 6698.1 6728.6 6735.7 6738.5 4610.4 4634.6 4638.0 4642.4 4644.7 4694.1 4702.8 4726.0 4738.4 4739.0 5414.3 5421.0 5424.6 5430.4 5433.4 6365.9 6470.7 6493.6 6511.5 6513.6 1633.4 1633.5 1645.7 1649.7 1652.7 991.6 1074.5 1075.1 1100.6 1100.8 6275.6 6303.4 6317.4 6332.3 6391.8 6609.4 6614.3 6616.4 6619.5 6624.2 6292.9 6294.7 6299.9 6308.9 6314.2 3544.1 3577.4 3581.3 3581.8 3583.9 6789.1 6813.7 6880.2 6940.0 6964.4 6706.4 6724.4 6732.8 6734.0 6743.0 6921.3 6932.2 6934.1 6936.9 6938.7 6620.2 6621.0 6627.2 6629.2 6636.0 6412.3 6517.2 6519.8 6530.8 6535.1 6882.4 6902.0 6911.5 6913.9 6924.7 4617.7 4620.3 4630.4 4638.0 4638.2 6512.5 6519.1 6537.4 6611.9 6613.3 6306.7 6329.9 6401.7 6412.7 6416.5 6391.5 6401.1 6413.8 6418.6 6433.4 6316.2 6331.7 6332.8 6333.5 6337.5 6452.1 6456.5 6472.0 6472.7 6474.6 6139.6 6276.6 6298.1 6308.5 6330.7 04:21:05 INFO - PROCESS | 16617 | 04:21:05 INFO - PROCESS | 16617 | [#5] yui.html Cycles:180 Average:14888.42 Median:44496.83 stddev:16795.42 (37.7%) stddev-sans-first:16809.42 04:21:05 INFO - PROCESS | 16617 | Values: 845.3 908.3 939.9 943.8 955.2 14131.5 14197.3 14279.8 14311.2 14383.9 13255.3 13262.5 13284.3 13291.5 13394.9 774.8 908.1 911.5 919.5 923.7 915.7 916.3 917.0 917.4 917.9 947.5 953.4 953.8 954.5 956.9 789.7 924.1 944.4 946.2 948.3 705.3 705.8 706.0 706.2 707.4 14708.7 14771.3 14794.3 14805.4 14819.3 14127.1 14211.1 14554.1 14556.4 14678.4 10521.4 10557.3 10611.4 10633.2 10752.4 4045.5 4057.9 4095.6 4112.8 4176.4 54357.7 54395.2 54406.9 54686.7 54921.2 11293.5 11493.2 11621.5 11671.6 11693.3 19585.6 19602.5 19660.7 19676.1 19677.2 8088.6 8184.4 8201.8 8314.3 8521.7 4766.3 4824.0 4827.4 4934.7 4951.6 3248.2 3285.4 3301.8 3307.6 3308.8 628.2 683.3 741.6 748.5 766.1 696.4 733.4 758.8 761.0 776.5 8641.8 9079.3 9505.7 10093.6 10247.2 758.8 763.2 813.3 829.2 835.5 4385.8 4497.8 4552.7 4583.8 4633.2 61473.4 62640.7 62650.7 62710.7 62752.4 49617.5 52440.5 52774.2 54179.2 54209.5 44309.3 44684.3 44792.8 46094.3 48601.0 8986.6 8995.3 9040.1 9249.8 9261.4 36280.8 37140.8 37325.3 37336.3 37998.2 42786.8 42840.0 46249.0 47810.5 47850.8 12430.7 12633.6 12751.7 12876.4 13294.5 12751.9 12809.6 12877.2 13348.4 13460.4 13786.6 13899.9 14031.7 14116.0 14168.6 12754.7 13353.9 13545.1 13728.9 14155.1 12011.3 12259.9 12654.0 12716.6 12794.4 10915.2 11010.5 11040.3 11055.7 11173.3 11088.9 11134.6 11214.9 11404.8 11414.7 04:21:05 INFO - PROCESS | 16617 | -------- Summary: end -------- 04:21:05 INFO - PROCESS | 16617 | 04:21:06 INFO - TEST-INFO | 16617: exit 0 04:21:06 INFO - TEST-OK | dromaeo_css | took 1116220ms 04:21:06 INFO - TEST-START | kraken 04:21:06 INFO - operating with platform_type : linux_ 04:21:06 INFO - Initialising browser for kraken test... 04:21:06 INFO - TEST-INFO | started process 16811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaIc_A/profile http://localhost:41656/getInfo.html) 04:21:12 INFO - PROCESS | 16811 | __metrics Screen width/height:1600/1200 04:21:12 INFO - PROCESS | 16811 | colorDepth:24 04:21:12 INFO - PROCESS | 16811 | Browser inner width/height: 1024/697 04:21:12 INFO - PROCESS | 16811 | __metrics 04:21:13 INFO - PROCESS | 16811 | 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:21:13 ERROR - PROCESS | 16811 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:21:14 INFO - TEST-INFO | 16811: exit 0 04:21:14 INFO - Browser initialized. 04:21:14 INFO - Running cycle 1/1 for kraken test... 04:21:14 INFO - TEST-INFO | started process 16902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHaIc_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:26 INFO - PROCESS | 16902 | RSS: Main: 139825152 04:21:26 INFO - PROCESS | 16902 | 04:21:29 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41656/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:30 INFO - PROCESS | 16902 | RSS: Main: 197660672 04:21:30 INFO - PROCESS | 16902 | 04:21:32 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41656/tests/kraken/driver.html?testName=audio-dft) 04:21:33 INFO - PROCESS | 16902 | RSS: Main: 184709120 04:21:33 INFO - PROCESS | 16902 | 04:21:36 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41656/tests/kraken/driver.html?testName=audio-fft) 04:21:36 INFO - PROCESS | 16902 | RSS: Main: 273424384 04:21:36 INFO - PROCESS | 16902 | 04:21:38 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41656/tests/kraken/driver.html?testName=audio-oscillator) 04:21:39 INFO - PROCESS | 16902 | RSS: Main: 179384320 04:21:39 INFO - PROCESS | 16902 | 04:21:41 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:42 INFO - PROCESS | 16902 | RSS: Main: 177868800 04:21:42 INFO - PROCESS | 16902 | 04:21:45 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41656/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:45 INFO - PROCESS | 16902 | RSS: Main: 212406272 04:21:45 INFO - PROCESS | 16902 | 04:21:49 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41656/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:49 INFO - PROCESS | 16902 | RSS: Main: 212258816 04:21:49 INFO - PROCESS | 16902 | 04:21:52 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41656/tests/kraken/driver.html?testName=json-parse-financial) 04:21:53 INFO - PROCESS | 16902 | RSS: Main: 212463616 04:21:53 INFO - PROCESS | 16902 | 04:21:54 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:55 INFO - PROCESS | 16902 | RSS: Main: 195985408 04:21:55 INFO - PROCESS | 16902 | 04:21:56 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:57 INFO - PROCESS | 16902 | RSS: Main: 199454720 04:21:57 INFO - PROCESS | 16902 | 04:21:59 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:00 INFO - PROCESS | 16902 | RSS: Main: 209682432 04:22:00 INFO - PROCESS | 16902 | 04:22:02 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:03 INFO - PROCESS | 16902 | RSS: Main: 217939968 04:22:03 INFO - PROCESS | 16902 | 04:22:05 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:06 INFO - PROCESS | 16902 | RSS: Main: 215535616 04:22:06 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | Cycle 1(1): loaded http://localhost:41656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41656/tests/kraken/driver.html?testName=ai-astar) 04:22:08 INFO - PROCESS | 16902 | RSS: Main: 276271104 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | __start_tp_report 04:22:08 INFO - PROCESS | 16902 | _x_x_mozilla_page_load 04:22:08 INFO - PROCESS | 16902 | _x_x_mozilla_page_load_details 04:22:08 INFO - PROCESS | 16902 | |i|pagename|runs| 04:22:08 INFO - PROCESS | 16902 | |0;ai-astar;111;111;111;110;111;111;105;110;110;110 04:22:08 INFO - PROCESS | 16902 | |1;audio-beat-detection;152;126;157;179;129;153;154;127;185;138 04:22:08 INFO - PROCESS | 16902 | |2;audio-dft;160;160;161;160;162;161;162;161;159;160 04:22:08 INFO - PROCESS | 16902 | |3;audio-fft;75;74;76;172;74;75;74;77;169;75 04:22:08 INFO - PROCESS | 16902 | |4;audio-oscillator;92;91;163;91;91;91;147;91;93;151 04:22:08 INFO - PROCESS | 16902 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;116;117;118 04:22:08 INFO - PROCESS | 16902 | |6;imaging-darkroom;145;146;145;145;145;146;146;146;145;147 04:22:08 INFO - PROCESS | 16902 | |7;imaging-desaturate;94;94;95;95;96;94;95;95;94;95 04:22:08 INFO - PROCESS | 16902 | |8;json-parse-financial;53;54;54;55;54;55;57;77;54;52 04:22:08 INFO - PROCESS | 16902 | |9;json-stringify-tinderbox;57;58;58;58;58;58;58;58;58;58 04:22:08 INFO - PROCESS | 16902 | |10;stanford-crypto-aes;71;82;74;74;81;74;74;75;74;74 04:22:08 INFO - PROCESS | 16902 | |11;stanford-crypto-ccm;112;118;112;115;114;118;113;112;130;133 04:22:08 INFO - PROCESS | 16902 | |12;stanford-crypto-pbkdf2;168;161;176;164;166;163;161;167;164;159 04:22:08 INFO - PROCESS | 16902 | |13;stanford-crypto-sha256-iterative;66;66;67;68;69;66;65;69;67;67 04:22:08 INFO - PROCESS | 16902 | __end_tp_report 04:22:08 INFO - PROCESS | 16902 | __start_cc_report 04:22:08 INFO - PROCESS | 16902 | _x_x_mozilla_cycle_collect,1587 04:22:08 INFO - PROCESS | 16902 | __end_cc_report 04:22:08 INFO - PROCESS | 16902 | __startTimestamp1469618528296__endTimestamp 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | ------- Summary: start ------- 04:22:08 INFO - PROCESS | 16902 | Number of tests: 14 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.83 (1.6%) stddev-sans-first:1.90 04:22:08 INFO - PROCESS | 16902 | Values: 111.0 111.0 111.0 110.0 111.0 111.0 105.0 110.0 110.0 110.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:153.50 stddev:20.64 (13.4%) stddev-sans-first:21.88 04:22:08 INFO - PROCESS | 16902 | Values: 152.0 126.0 157.0 179.0 129.0 153.0 154.0 127.0 185.0 138.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 04:22:08 INFO - PROCESS | 16902 | Values: 160.0 160.0 161.0 160.0 162.0 161.0 162.0 161.0 159.0 160.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.28 (53.7%) stddev-sans-first:42.13 04:22:08 INFO - PROCESS | 16902 | Values: 75.0 74.0 76.0 172.0 74.0 75.0 74.0 77.0 169.0 75.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:91.00 stddev:30.33 (33.3%) stddev-sans-first:31.45 04:22:08 INFO - PROCESS | 16902 | Values: 92.0 91.0 163.0 91.0 91.0 91.0 147.0 91.0 93.0 151.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:22:08 INFO - PROCESS | 16902 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 118.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:22:08 INFO - PROCESS | 16902 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 147.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:22:08 INFO - PROCESS | 16902 | Values: 94.0 94.0 95.0 95.0 96.0 94.0 95.0 95.0 94.0 95.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:54.50 stddev:7.32 (13.4%) stddev-sans-first:7.66 04:22:08 INFO - PROCESS | 16902 | Values: 53.0 54.0 54.0 55.0 54.0 55.0 57.0 77.0 54.0 52.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 04:22:08 INFO - PROCESS | 16902 | Values: 57.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.00 stddev:3.43 (4.6%) stddev-sans-first:3.27 04:22:08 INFO - PROCESS | 16902 | Values: 71.0 82.0 74.0 74.0 81.0 74.0 74.0 75.0 74.0 74.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:116.50 stddev:7.65 (6.6%) stddev-sans-first:7.83 04:22:08 INFO - PROCESS | 16902 | Values: 112.0 118.0 112.0 115.0 114.0 118.0 113.0 112.0 130.0 133.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.00 stddev:4.82 (2.9%) stddev-sans-first:4.98 04:22:08 INFO - PROCESS | 16902 | Values: 168.0 161.0 176.0 164.0 166.0 163.0 161.0 167.0 164.0 159.0 04:22:08 INFO - PROCESS | 16902 | 04:22:08 INFO - PROCESS | 16902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 04:22:08 INFO - PROCESS | 16902 | Values: 66.0 66.0 67.0 68.0 69.0 66.0 65.0 69.0 67.0 67.0 04:22:08 INFO - PROCESS | 16902 | -------- Summary: end -------- 04:22:08 INFO - PROCESS | 16902 | 04:22:09 INFO - TEST-INFO | 16902: exit 0 04:22:09 INFO - TEST-OK | kraken | took 63046ms 04:22:09 INFO - SUITE-END | took 1179s 04:22:09 INFO - Completed test suite (00:19:39) 04:22:09 INFO - javascript benchmark 04:22:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.314703912178, 3334.1331253873986, 3337.8164200968936, 3348.1294863335556, 3369.0398236502615, 5384.784608615656, 5386.569074474042, 5386.596005299603, 5388.353397592285, 5401.972990135054, 5397.568194544427, 5405.432320063728, 5406.756695948682, 5410.864728381793, 5455.290812194419, 4903.239997800347, 4911.214205727084, 4954.504549545053, 4985.551300382965, 5007.974960125212, 4855.271709243606, 4975.925361119568, 4980.178270585349, 5014.598832093442, 5061.6962982221, 4948.752562371885, 4972.477889821571, 4977.50224977503, 4983.302337672711, 5011.398632164145, 4934.0, 4943.703377797344, 4966.826161084345, 4981.327520784684, 4989.600831933455, 4864.8297309594345, 4875.073735990186, 4963.0, 4966.627502937295, 4983.651144419892, 5291.074062039166, 5315.548178404841, 5319.654222475527, 5329.973350133225, 5347.304850369427, 5662.09406494963, 5803.47768700819, 5803.912941305884, 5810.6513609183585, 5845.357010728816, 5735.885282294331, 5754.97122514389, 5800.622959507618, 5829.446202610745, 5845.620034697731, 5490.313710786152, 5496.972515137439, 5498.037843377433, 5499.615026948155, 5502.532284755801, 5705.286839145107, 5768.567357448208, 5937.495312898452, 5950.9702451487465, 5951.256092988377, 5735.340435849847, 5739.62692424991, 5759.049756790083, 5773.39379365169, 5773.624714393551, 5816.505597024216, 5825.242718446575, 5829.387914269026, 5829.650220986754, 5835.328937172279, 5670.149477578396, 5685.971570142206, 5799.710014499258, 5815.360310365856, 5815.82552523425, 5780.479756821906, 5797.565182611321, 5801.7389217485315, 5812.9709351452975, 5842.036064049469, 4430.047539778899, 4465.0623369092855, 4467.128909862546, 4472.44094488189, 4496.730196188174, 3919.862804801818, 3946.4080387941463, 3995.760254384746, 4031.07285324377, 4075.449814275094, 5566.916496252559, 5573.136163894603, 5597.328320601472, 5601.383847776741, 5606.831795046155, 5830.096335068071, 5835.562332825055, 5846.29844418664, 5847.473727364472, 5854.0, 5443.673379597237, 5531.197976293415, 5573.777048918079, 5608.383077861432, 5626.549876009909, 5033.471485494044, 5050.04049230645, 5051.6716413433005, 5051.772670229849, 5057.747112644353, 6085.847853803691, 6090.0, 6091.604045737013, 6093.39066093396, 6113.480354169946, 5651.067573850269, 5727.226824378656, 5803.129530570448, 5804.535637148933, 5806.883862322815, 6049.425304596057, 6052.636841789506, 6053.878922421615, 6057.939420605738, 6058.333583305921, 5575.219469274224, 5733.054046082517, 5739.569532285179, 5744.712764361681, 5757.65454072757, 5732.742026608729, 5815.912761308499, 5825.330087040044, 5843.0, 5851.356350801323, 5632.155176723524, 5642.520385767091, 5645.774169033357, 5658.7736490541565, 5676.0, 5480.095784195563, 5672.60291779588, 5677.460641239076, 5684.914726279192, 5691.032524470767, 5511.145772405283, 5573.944260557342, 5576.33084029919, 5582.0231459495235, 5608.355039170385, 5660.801871934463, 5667.064934285797, 5672.319321681424, 5673.858153546194, 5683.318001839806, 5469.453054694499, 5525.11598144295, 5535.529479994246, 5575.0, 5593.384727680033], "value": 5367.644243603837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6479694581725, 646.7833275852589, 653.689497488693, 659.4526542969335, 665.9833504162399, 33097.834510827444, 33730.15674608133, 39470.802645986805, 40509.797451012775, 40512.392314115314, 43137.568624313746, 43409.78295108528, 43673.7816310918, 43866.56133438665, 43943.12113757723, 8093.231143041402, 8825.602847871829, 9050.32122590805, 9055.230305424015, 10377.377357358544, 10471.895281047167, 10626.14990800734, 10628.36229826213, 10628.521716522775, 10631.946840265788, 10583.417912014836, 10669.146468282557, 10676.306040107407, 10677.305975111592, 10677.78644427111, 10548.683539493828, 10608.893911060906, 10610.098141657969, 10624.840627390595, 10626.734331641694, 10472.633457828939, 10561.73595660107, 10580.735481612945, 10891.727706807314, 10892.673219803419, 41777.0, 42285.78857105726, 42307.57692423067, 42310.57689423097, 42315.36526952098, 3633.927321453556, 3723.1809002019513, 3725.2735716535285, 3762.1347090169415, 3932.960670393317, 29277.56083658747, 29637.407251855057, 30026.0, 30054.398912021858, 30382.84808575965, 4365.257906155961, 4432.312991486325, 4453.955460445386, 4457.866264012052, 4489.371487991683, 205506.0, 205848.0, 206158.0, 206216.0, 206737.966310169, 39424.40863387052, 57777.711111445016, 63365.36634633687, 63399.68300158469, 63421.36578634154, 37164.0, 37298.627013729514, 37405.25189496195, 37435.0, 37459.62540374562, 17131.400400986156, 17372.0, 17377.04426256543, 17381.391651292397, 17383.130843457777, 13354.46582136723, 14254.572362829133, 14599.78100328496, 14648.853511464962, 14717.264136793117, 9236.399634023766, 9286.489243091695, 9296.72109836706, 9348.158665719982, 9349.39228950116, 3540.2211513466996, 3580.15866271426, 3611.8013509257244, 3673.3020726061964, 3691.7969511677115, 1084.251866212311, 1090.0, 1127.143371038017, 1128.3244382092587, 1144.6279959013355, 32459.675403246136, 32653.346933061206, 32884.83557582197, 33808.15479613029, 33810.32379352399, 1220.383706228349, 1241.6523373455448, 1255.4413286087604, 1326.2175316563082, 1363.195714528433, 17302.394416195373, 17687.115644217738, 17938.0, 18043.18805653749, 18095.0, 495009.0, 497784.0, 499269.0, 499800.0, 501054.0, 62548.687256563426, 62999.37000630027, 63096.0, 63429.36570634327, 63465.68267158727, 1384.252503648039, 1514.954551363439, 1574.6063484128968, 1580.8498192671448, 1633.0691505841794, 29032.56451153192, 29396.706032939397, 29638.259043523223, 31438.214044648154, 31906.6809331913, 49153.75423123004, 49233.75383123061, 49647.0, 50030.74984625054, 50105.0, 368464.0, 369936.0, 372344.0, 372788.0, 486074.0, 29339.41321173607, 29791.106266812032, 29819.701802981694, 29825.70174298229, 29829.254268643457, 41229.1754164909, 41668.58331416647, 41817.0, 42785.786071069444, 42813.143737125705, 35275.0, 35537.0, 35589.644103559665, 35711.28577428489, 36246.0, 34650.30699386049, 34816.651833481345, 35292.823535882155, 37849.81075094607, 38199.427008594335, 39002.2199556013, 39314.410283845194, 40093.0, 44702.552974469836, 45690.54309456863, 32664.0, 33396.833015835735, 34012.149696257795, 34018.65981340155, 34135.65864341325, 26496.735032649427, 26876.0, 26935.730642694107, 27320.137548441653, 28043.719562804927], "value": 19140.546287906047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.94663167104113, 431.71291091424195, 432.146093259915, 438.50887006552665, 443.5852477933133, 18333.26666933323, 19096.236150553977, 19103.61792764144, 19210.615787684237, 20019.799802002013, 12199.207051541644, 12254.326012069332, 12585.244885306887, 13043.478260869553, 13065.804012939814, 5420.674759514432, 5423.105187644034, 5473.753681084341, 5483.561315094803, 5578.330600327946, 4045.37296719009, 4294.978525107385, 5441.455854414547, 5992.221011268529, 6073.119397687333, 6048.2137322148055, 6064.545159113062, 6067.362926892679, 6077.969610151943, 6086.2087928569445, 4122.319817230154, 5704.629199102045, 5985.1022346647915, 5998.370171132034, 6010.789622363218, 5631.60578759487, 5939.049752039653, 5939.049752039653, 5939.970300148515, 5956.047032474827, 13741.793873091912, 14119.152850828881, 14122.576322710334, 14226.644333891632, 14585.635359116, 2460.3726049857173, 2723.5914612808037, 3016.8039077459894, 3067.5858759067687, 3083.784135110543, 10455.58177672892, 10642.680719578426, 10760.13918886495, 10769.676909692722, 10897.237193396466, 1970.3202395173641, 2074.1806986240504, 2129.2121914891436, 2133.0721136305756, 2146.259540458555, 71795.64102179508, 78126.60936695337, 79669.60165199195, 80153.59923200405, 83447.58276208641, 10868.130549556017, 11248.100151987821, 11367.54529818798, 11415.657530273938, 11469.942650286863, 16316.265768040466, 16357.754633680504, 16477.83522164763, 16478.6704265914, 16482.83517164837, 8926.821463570823, 8946.0, 9072.228860546928, 9084.40951338161, 9120.954395227982, 8704.260137888225, 8743.825123497621, 8761.080086590817, 8793.340499462565, 8984.955075224712, 5100.897982040413, 5158.63889527737, 5159.974200128975, 5175.378954525481, 5179.119549676564, 1974.2399176316935, 2063.4428704249767, 2106.8946552672305, 2133.989330053371, 2139.433050241656, 1018.3279035836313, 1021.6015753856002, 1051.458498873081, 1126.4930781148353, 1129.3562669278597, 18484.72272915907, 19028.388644542294, 19295.8070419294, 19364.128614212394, 19389.8061019388, 1022.7852151048214, 1056.8309070548828, 1068.2201992545486, 1071.5499490214129, 1100.6312885183393, 10779.514921828537, 11093.112550996062, 11114.444277786079, 11239.988401043782, 11396.373199473943, 175046.0, 404402.0, 488263.0, 507628.0, 510147.0, 89474.55262723645, 89832.0, 91263.0, 92677.5366123165, 93466.0, 1082.0802318029769, 1089.3082892363407, 1102.393683474102, 1122.680036189682, 1128.4019469680918, 17075.573110672332, 17154.914225428794, 17163.7425438616, 17190.31238750436, 17506.387276445264, 39590.0, 39952.800235998635, 40849.0, 41551.376729349686, 41589.58410415857, 57567.712161438925, 58033.4196658028, 58873.11690324734, 59214.40785592089, 59313.703431482565, 8850.380473366802, 8908.198262156437, 8938.910610893809, 9043.095690430904, 9232.261419086322, 11421.0, 13526.25605591702, 13606.0, 13644.795328070286, 13648.24934628605, 11717.414129293671, 12012.459439325427, 12069.456874440846, 12346.691332716395, 12493.437795299415, 7781.883271750815, 11012.39431831257, 11468.139889508488, 11740.119491038036, 11963.581274655346, 6667.833304167435, 9211.447313161232, 12193.390330483262, 12210.511579536718, 12536.498540058661, 9004.639814407612, 9020.413673111227, 9089.818203636023, 9258.95370523143, 9260.953695231481, 9992.450415227233, 11472.598459053894, 12357.567485137977, 12406.565770198, 12493.25040497573], "value": 9197.9396223526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.5670642100956, 1526.8854835887307, 1590.0141912014553, 1778.759867417899, 1913.2633935934662, 7892.6448309826055, 8079.798005049869, 8109.351251899849, 8114.148014458486, 8117.472364296316, 7929.286364227219, 8090.838183236332, 8096.43324967251, 8101.675932962675, 8107.18928107189, 2279.908803647856, 2324.2213858357472, 2327.8137748980125, 2327.9534409311887, 2331.1258278145697, 2349.283468542094, 2364.137089962169, 2426.4904370082304, 2455.1897873701637, 2465.272744540356, 2326.895289711967, 2388.7133543974746, 2391.7129944406697, 2397.1729753235104, 2412.360724408033, 2376.4296568823356, 2380.1788383007834, 2398.2205783120557, 2406.879656017201, 2422.345966589011, 2339.520398318358, 2376.4415362389823, 2391.7129944406784, 2394.904203831845, 2407.386116540271, 7098.041764361797, 7585.317321441042, 8375.623096960651, 8409.747707568782, 8432.114627964036, 5013.824516141954, 5086.1353569892835, 5110.207917772714, 5118.846434606968, 5121.2574176744165, 3200.1199670090678, 3268.754843386732, 3297.1097803592897, 3307.1897385140555, 3334.6331903490595, 1107.413071072333, 1113.4432783608195, 1148.6853989211745, 1157.2188772578477, 1163.575295017321, 10702.983216594412, 10878.510467029002, 10880.347179169275, 11137.443127843575, 11154.0, 4278.2085314216965, 4304.526502084768, 4347.456567929009, 4388.912221755547, 4435.290353543418, 9622.13400793932, 9640.276979226586, 9656.32405731592, 9659.082387173208, 9662.9033709662, 5035.546800787946, 5037.647364684511, 5038.647294689336, 5042.974785126051, 5044.545990860766, 4628.190066738374, 4628.583427491542, 4630.189716799547, 4634.629229661619, 4638.97680511602, 3664.212194378168, 3854.8820841955517, 3872.4772155759174, 3890.2025084857537, 3898.142408670088, 1198.9580364687195, 1230.4217018001525, 1237.9257244565356, 1238.4365113873346, 1246.4764798784352, 902.251131560803, 908.7864351877304, 954.3748844506721, 962.7938963252353, 970.9951450242703, 5509.972450137724, 5531.8340449785765, 5606.943930560724, 5607.102863541813, 5737.91393129095, 475.89768199837204, 477.07447551749493, 477.7420193095759, 477.7706700783574, 486.25117319327836, 4076.5923407658997, 4094.3653733671326, 4103.158852435244, 4103.302438585448, 4128.958710412918, 9722.222222222204, 9911.15755160805, 9965.0, 10051.145652619463, 10066.848997265048, 9885.752856178653, 9952.80094398108, 9966.103050725469, 10005.949970250102, 10017.098461138532, 7738.961305193438, 7857.685692572233, 7874.6850125994315, 7988.960055199803, 8009.0789559200275, 5460.781568737365, 5520.475554822286, 5551.666899986014, 5562.610617256915, 5664.575156863334, 8944.776380590538, 9026.052264512131, 9128.224100951493, 9164.725058248263, 9226.677066302647, 8844.823103538021, 9163.175314221751, 9361.531923403667, 9428.669996550088, 9470.052994700474, 7330.193678695446, 7379.151397589346, 7416.332530072319, 7418.36943859778, 7419.703211871681, 7712.38300935935, 7794.610269486389, 7795.883061754192, 7795.961020194863, 7798.688052477837, 7094.0, 7261.927380726125, 7312.707491700273, 7371.226021267904, 7482.0, 7108.786736397917, 7116.323949224816, 7210.315020073294, 7218.747343842941, 7283.308085731847, 6184.6598437086395, 6810.795676129724, 6819.829504262433, 6838.111045564045, 6854.074699915447, 4174.269502836931, 4867.342908707279, 4964.230544265644, 5192.428832828461, 5274.235235890697, 5059.949400506095, 5096.413912400121, 5153.871153221199, 5156.071907056766, 5326.627136100436], "value": 4377.002590634867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.38514177901345, 354.99645003549966, 362.81133810418584, 369.2872755581726, 371.75092687899104, 6020.0, 6030.065339872322, 6078.817635470938, 6104.603200791946, 6113.144159817618, 6024.006039003571, 6031.215941927554, 6037.154798328226, 6057.848553786146, 6060.575759696823, 4476.776161191944, 4598.862034138964, 4699.9895022570145, 4743.430788305391, 4759.309900064489, 4712.269598212282, 4717.2924061390895, 4731.077439899221, 4738.715677059387, 4741.075490279397, 4481.46222453306, 4700.811967521295, 4701.78841952113, 4704.553067458586, 4706.082313948764, 4586.885327866813, 4664.277037059244, 4669.0, 4703.576678098988, 4717.952820471785, 4134.607212314855, 4143.005678637105, 4147.04617937873, 4151.356539736345, 4161.334186530171, 5866.325372582165, 5904.114382842608, 5904.380040095771, 5905.350411454737, 5911.142884281798, 5433.239346491494, 5436.619436639437, 5463.7814487420455, 5466.781328746845, 5468.398476167618, 6387.489000879918, 6410.583312084699, 6415.101885736, 6418.03729440583, 6425.0, 4366.214081465335, 4497.865064048084, 4499.347594598765, 4504.549545045502, 4507.549245075466, 6620.106285651472, 6698.062271282024, 6728.596284222962, 6735.730570777163, 6738.4609231261875, 4610.40064791575, 4634.582887540138, 4637.9536204637525, 4642.37327960721, 4644.651651126179, 4694.0611877624615, 4702.811887524529, 4725.976370118127, 4738.384010078667, 4739.0, 5414.269073675082, 5421.0, 5424.593155513273, 5430.402655707869, 5433.429489903582, 6365.872682546323, 6470.741170353133, 6493.642849643221, 6511.479081673455, 6513.641749703812, 1633.4201358517794, 1633.501781956491, 1645.6873194093084, 1649.6700659868075, 1652.6529428819842, 991.5736233419699, 1074.5379486820586, 1075.0646937164718, 1100.5982816272003, 1100.7743412600398, 6275.5920865144535, 6303.401176888188, 6317.431431171217, 6332.271788744353, 6391.776287829996, 6609.405153536205, 6614.338566143443, 6616.437602803816, 6619.536632435779, 6624.244575187579, 6292.874142517124, 6294.716737746812, 6299.874002519924, 6308.936910630927, 6314.210723659543, 3544.078539579676, 3577.3918433866306, 3581.3374525712825, 3581.7850928944345, 3583.9104022399647, 6789.0834737310815, 6813.727450901908, 6880.174379074443, 6940.0, 6964.4428445724225, 6706.362895524917, 6724.3611856874495, 6732.798016059526, 6734.0, 6742.966285168641, 6921.342472465108, 6932.202796678345, 6934.133233345932, 6936.895946560806, 6938.722451102, 6620.172478440195, 6621.0, 6627.1716035495565, 6629.171353580802, 6636.0377745225705, 6412.267119524574, 6517.185351831021, 6519.771807986698, 6530.8367290818105, 6535.117759102651, 6882.449404047764, 6902.033715279765, 6911.516193866582, 6913.861722765617, 6924.6537673117155, 4617.722936623813, 4620.306953956933, 4630.398048253705, 4638.0, 4638.165130276582, 6512.511561632802, 6519.08732777402, 6537.444317233088, 6611.933880661132, 6613.27254002069, 6306.747730090745, 6329.873402531832, 6401.7119229633845, 6412.6793660317735, 6416.518761092843, 6391.520635952229, 6401.103845461546, 6413.775517856852, 6418.550701450854, 6433.388828061326, 6316.178896743394, 6331.651759153291, 6332.778352757631, 6333.493320534254, 6337.524685648503, 6452.096706461005, 6456.483481321389, 6472.029195620695, 6472.676366181578, 6474.643894585843, 6139.6009259398, 6276.592021518587, 6298.118263443213, 6308.495320374451, 6330.746770129327], "value": 4885.676240358061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.2899564365931, 908.2915326045684, 939.8966113727491, 943.8206740719268, 955.1642312976146, 14131.505397311095, 14197.29013549321, 14279.78580321296, 14311.212883291428, 14383.928080359598, 13255.27096009719, 13262.469501219965, 13284.335783210849, 13291.468341266362, 13394.866051339484, 774.7753151586033, 908.0783005249676, 911.4622372800063, 919.5264438814016, 923.6674797073048, 915.6612053540166, 916.2990312410977, 917.0325306801321, 917.3945196170529, 917.8623206519043, 947.5262368815593, 953.3945944325369, 953.771094937217, 954.5036580977887, 956.942583444992, 789.7157023471574, 924.1267002682467, 944.4380593546829, 946.1957336264189, 948.3456415073578, 705.3299365602646, 705.7635692043172, 705.9611721355324, 706.2055187913597, 707.3598393453932, 14708.705825883422, 14771.335289911873, 14794.334254958552, 14805.407783688639, 14819.259037048105, 14127.081739686888, 14211.147331160164, 14554.12675239489, 14556.417743290362, 14678.412863485448, 10521.421321827296, 10557.260991730582, 10611.363318200933, 10633.202509811796, 10752.354858708502, 4045.5145382553987, 4057.918841623151, 4095.631393174599, 4112.835486580563, 4176.436181115541, 54357.728211359085, 54395.184072238946, 54406.911861762936, 54686.72656636731, 54921.176182357296, 11293.54825806975, 11493.195476316745, 11621.53513859453, 11671.59149429766, 11693.298402095901, 19585.608287834162, 19602.509937251398, 19660.70508942367, 19676.114574844167, 19677.212911483668, 8088.555129467818, 8184.427090103635, 8201.83596328082, 8314.251717345347, 8521.659133634708, 4766.285057241442, 4823.9517604824205, 4827.396575428072, 4934.7285899275885, 4951.603871690256, 3248.171716212351, 3285.392202442508, 3301.7853839500835, 3307.570015897918, 3308.751843611739, 628.2115944489636, 683.2654895986834, 741.5810067311952, 748.4835463530147, 766.0998326965793, 696.373264062348, 733.3583114774573, 758.768575584452, 761.0410882288356, 776.5263189454429, 8641.827163456695, 9079.319051071196, 9505.66730164441, 10093.596256149818, 10247.180225581935, 758.836850077236, 763.2177018556024, 813.259933460548, 829.1749709039544, 835.4653022065883, 4385.846495372647, 4497.820087196541, 4552.704074235164, 4583.816647334069, 4633.162488154192, 61473.38526614766, 62640.68679656572, 62650.686746565974, 62710.68644656747, 62752.37247627557, 49617.50382496201, 52440.47559524356, 52774.20838687423, 54179.18731219035, 54209.457905420444, 44309.33535996963, 44684.329735054, 44792.77603612026, 46094.30858537125, 48601.027979440216, 8986.640534378552, 8995.325350598601, 9040.095990400907, 9249.768755781159, 9261.44431334122, 36280.81859590685, 37140.81429592835, 37325.25349493049, 37336.25327493489, 37998.240035198585, 42786.78606606947, 42840.0, 46249.0, 47810.521894780606, 47850.76074619604, 12430.689232769253, 12633.557825476064, 12751.74496510046, 12876.420561074587, 13294.468221271427, 12751.936240318739, 12809.61571152867, 12877.162984405984, 13348.399322030338, 13460.394282257126, 13786.586402407944, 13899.861001389856, 14031.719365612427, 14116.0, 14168.574942751733, 12754.744905102032, 13353.933230333787, 13545.05184637066, 13728.862711372758, 14155.117363432164, 12011.279323240633, 12259.877401225873, 12654.0, 12716.554920577735, 12794.360281985677, 10915.181361397768, 11010.50452729613, 11040.33757974524, 11055.668329950115, 11173.273737207055, 11088.942979130894, 11134.610288640182, 11214.887851121384, 11404.828927565926, 11414.714632133931], "value": 7008.133824413832, "unit": "score"}], "name": "dromaeo_css", "value": 7219.859434480333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 110.0, 111.0, 111.0, 105.0, 110.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 157.0, 179.0, 129.0, 153.0, 154.0, 127.0, 185.0, 138.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 159.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 172.0, 74.0, 75.0, 74.0, 77.0, 169.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 163.0, 91.0, 91.0, 91.0, 147.0, 91.0, 93.0, 151.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 118.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, 146.0, 146.0, 145.0, 147.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 54.0, 55.0, 57.0, 77.0, 54.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 82.0, 74.0, 74.0, 81.0, 74.0, 74.0, 75.0, 74.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 112.0, 115.0, 114.0, 118.0, 113.0, 112.0, 130.0, 133.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 176.0, 164.0, 166.0, 163.0, 161.0, 167.0, 164.0, 159.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 68.0, 69.0, 66.0, 65.0, 69.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1521.0000000000005, "alertThreshold": 2.0}]} 04:22:09 INFO - Return code: 0 04:22:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:22:09 ERROR - # TBPL SUCCESS # 04:22:09 INFO - Running post-action listener: _resource_record_post_action 04:22:09 INFO - Running post-run listener: _resource_record_post_run 04:22:10 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 28672; Write bytes: 449880064; Read time: 156; Write time: 2510896 04:22:10 INFO - install - Wall time: 24s; CPU: 22.0%; Read bytes: 0; Write bytes: 215715840; Read time: 0; Write time: 1510200 04:22:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 28672; Write bytes: 224886784; Read time: 156; Write time: 608852 04:22:10 INFO - Running post-run listener: _upload_blobber_files 04:22:10 INFO - Blob upload gear active. 04:22:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:10 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:22:10 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:22:10 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:22:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:11 INFO - (blobuploader) - INFO - Done attempting. 04:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:12 INFO - (blobuploader) - INFO - Done attempting. 04:22:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:12 INFO - Return code: 0 04:22:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2feb822e7d3239bbfb7fb0f1ac089b2b43196f12ecdf0baf53a2b2cb6798745fba1b07a7022e37382cb61f8f69132d50e6d6f92695d1291935a4ba88bd4cae51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35bbda8d4bc830a43435387be30d3d21c733510db267ab567c36d069090f29ceb685ca82bd3b6225d5b5c1c415cf23be6b45b03eec4ef65d815ef5257dbc4542"} 04:22:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:12 INFO - Contents: 04:22:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2feb822e7d3239bbfb7fb0f1ac089b2b43196f12ecdf0baf53a2b2cb6798745fba1b07a7022e37382cb61f8f69132d50e6d6f92695d1291935a4ba88bd4cae51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35bbda8d4bc830a43435387be30d3d21c733510db267ab567c36d069090f29ceb685ca82bd3b6225d5b5c1c415cf23be6b45b03eec4ef65d815ef5257dbc4542"} 04:22:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:12 INFO - Copying logs to upload dir... 04:22:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.410074 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-27 04:22:12.282144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:22:12.285285) ========= 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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 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/2feb822e7d3239bbfb7fb0f1ac089b2b43196f12ecdf0baf53a2b2cb6798745fba1b07a7022e37382cb61f8f69132d50e6d6f92695d1291935a4ba88bd4cae51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35bbda8d4bc830a43435387be30d3d21c733510db267ab567c36d069090f29ceb685ca82bd3b6225d5b5c1c415cf23be6b45b03eec4ef65d815ef5257dbc4542"} 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.011263 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/2feb822e7d3239bbfb7fb0f1ac089b2b43196f12ecdf0baf53a2b2cb6798745fba1b07a7022e37382cb61f8f69132d50e6d6f92695d1291935a4ba88bd4cae51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35bbda8d4bc830a43435387be30d3d21c733510db267ab567c36d069090f29ceb685ca82bd3b6225d5b5c1c415cf23be6b45b03eec4ef65d815ef5257dbc4542"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:22:12.314424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:22:12.314717) ========= 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=33d5923976266a1c518c4bf7000001ab-1469617282.776647-1495808346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:22:12.399849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:22:12.400501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:22:12.401094) ========= ========= Total master_lag: 0.16 =========