builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1469617284.62 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.618478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.618877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.619156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.630848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.631214) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2016-07-27 04:01:25 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121178 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.764829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.765156) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016795 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.819115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:24.819480) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:25,183 truncating revision to first 12 chars 2016-07-27 04:01:25,183 Setting DEBUG logging. 2016-07-27 04:01:25,183 attempt 1/10 2016-07-27 04:01:25,183 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:25,483 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668747 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:25.505635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:25.506225) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:25.506794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:25.507177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:25.517589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-27 04:01:25.517937) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 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-013', 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:26 INFO - Running post-action listener: _resource_record_post_action 04:01:26 INFO - ##### 04:01:26 INFO - ##### Running read-buildbot-config step. 04:01:26 INFO - ##### 04:01:26 INFO - Running pre-action listener: _resource_record_pre_action 04:01:26 INFO - Running main action method: read_buildbot_config 04:01:26 INFO - Using buildbot properties: 04:01:26 INFO - { 04:01:26 INFO - "project": "", 04:01:26 INFO - "product": "firefox", 04:01:26 INFO - "script_repo_revision": "production", 04:01:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:01:26 INFO - "repository": "", 04:01:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:01:26 INFO - "buildid": "20160726073802", 04:01:26 INFO - "pgo_build": "True", 04:01:26 INFO - "basedir": "/builds/slave/test", 04:01:26 INFO - "buildnumber": 113, 04:01:26 INFO - "slavename": "talos-linux64-ix-013", 04:01:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:01:26 INFO - "platform": "ubuntu64_hw", 04:01:26 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:26 INFO - "branch": "mozilla-beta", 04:01:26 INFO - "repo_path": "releases/mozilla-beta", 04:01:26 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:26 INFO - "stage_platform": "linux64-pgo", 04:01:26 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:26 INFO - "slavebuilddir": "test" 04:01:26 INFO - } 04:01:26 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:26 INFO - Running post-action listener: _resource_record_post_action 04:01:26 INFO - ##### 04:01:26 INFO - ##### Running download-and-extract step. 04:01:26 INFO - ##### 04:01:26 INFO - Running pre-action listener: _resource_record_pre_action 04:01:26 INFO - Running main action method: download_and_extract 04:01:26 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:01:27 INFO - Downloaded 1327 bytes. 04:01:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:27 INFO - Using the following test package requirements: 04:01:27 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:27 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:27 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'jsshell-linux-x86_64.zip'], 04:01:27 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:27 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:27 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:27 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:27 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:27 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:27 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01: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:01:27 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:27 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:27 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:27 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:27 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:28 INFO - Downloaded 24199952 bytes. 04:01:28 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:28 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:29 INFO - Return code: 0 04:01:29 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:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:29 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:29 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:29 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:29 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:29 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:32 INFO - Downloaded 24199952 bytes. 04:01:32 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:32 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:34 INFO - Downloaded 10840145 bytes. 04:01:34 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:34 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:34 INFO - Return code: 0 04:01:34 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:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 56024276 bytes. 04:01:35 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:35 INFO - mkdir: /builds/slave/test/properties 04:01:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:35 INFO - Contents: 04:01:35 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:36 INFO - Running post-action listener: _resource_record_post_action 04:01:36 INFO - Running post-action listener: set_extra_try_arguments 04:01:36 INFO - ##### 04:01:36 INFO - ##### Running populate-webroot step. 04:01:36 INFO - ##### 04:01:36 INFO - Running pre-action listener: _resource_record_pre_action 04:01:36 INFO - Running main action method: populate_webroot 04:01:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:36 INFO - '--tppagecycles', 04:01:36 INFO - '7'], 04:01:36 INFO - 'tests': ['tsvgm']}}, 04:01:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['damp', 'tps']}, 04:01:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'tests': ['damp', 'tps']}, 04:01:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['dromaeo_dom']}, 04:01:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['a11yr', 04:01:36 INFO - 'ts_paint', 04:01:36 INFO - 'tpaint', 04:01:36 INFO - 'sessionrestore', 04:01:36 INFO - 'sessionrestore_no_auto_restore', 04:01:36 INFO - 'tabpaint']}, 04:01:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['tsvgx', 04:01:36 INFO - 'tsvgr_opacity', 04:01:36 INFO - 'tart', 04:01:36 INFO - 'tscrollx', 04:01:36 INFO - 'cart']}, 04:01:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:36 INFO - 'tsvgr_opacity', 04:01:36 INFO - 'tart', 04:01:36 INFO - 'tscrollx', 04:01:36 INFO - 'cart']}, 04:01:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'talos_options': ['--disable-e10s'], 04:01:36 INFO - 'tests': ['tp5o']}, 04:01:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'tests': ['tp5o']}, 04:01:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'talos_options': ['--disable-e10s', 04:01:36 INFO - '--xperf_path', 04:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:36 INFO - 'tests': ['tp5n']}, 04:01:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:36 INFO - 'talos_options': ['--xperf_path', 04:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:36 INFO - 'tests': ['tp5n']}}, 04:01:36 INFO - 'talos.zip': {'path': '', 04:01:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:36 INFO - Running post-action listener: _resource_record_post_action 04:01:36 INFO - ##### 04:01:36 INFO - ##### Running create-virtualenv step. 04:01:36 INFO - ##### 04:01:36 INFO - Running pre-action listener: _resource_record_pre_action 04:01:36 INFO - Running main action method: create_virtualenv 04:01:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:36 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:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:36 INFO - Using real prefix '/usr' 04:01:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:39 INFO - Installing pip.................done. 04:01:39 INFO - Return code: 0 04:01:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:01:39 INFO - 'HOME': '/home/cltbld', 04:01:39 INFO - 'LANG': 'en_US.UTF-8', 04:01:39 INFO - 'LANGUAGE': 'en_US:en', 04:01:39 INFO - 'LOGNAME': 'cltbld', 04:01:39 INFO - 'MAIL': '/var/mail/cltbld', 04:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:39 INFO - 'MOZ_NO_REMOTE': '1', 04:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:39 INFO - 'NO_EM_RESTART': '1', 04:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:39 INFO - 'PWD': '/builds/slave/test', 04:01:39 INFO - 'SHELL': '/bin/bash', 04:01:39 INFO - 'SHLVL': '1', 04:01:39 INFO - 'TERM': 'linux', 04:01:39 INFO - 'TMOUT': '86400', 04:01:39 INFO - 'USER': 'cltbld', 04:01:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:39 INFO - '_': '/tools/buildbot/bin/python'} 04:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:39 INFO - 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:39 INFO - Cleaning up... 04:01:39 INFO - Return code: 0 04:01:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:01:39 INFO - 'HOME': '/home/cltbld', 04:01:39 INFO - 'LANG': 'en_US.UTF-8', 04:01:39 INFO - 'LANGUAGE': 'en_US:en', 04:01:39 INFO - 'LOGNAME': 'cltbld', 04:01:39 INFO - 'MAIL': '/var/mail/cltbld', 04:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:39 INFO - 'MOZ_NO_REMOTE': '1', 04:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:39 INFO - 'NO_EM_RESTART': '1', 04:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:39 INFO - 'PWD': '/builds/slave/test', 04:01:39 INFO - 'SHELL': '/bin/bash', 04:01:39 INFO - 'SHLVL': '1', 04:01:39 INFO - 'TERM': 'linux', 04:01:39 INFO - 'TMOUT': '86400', 04:01:39 INFO - 'USER': 'cltbld', 04:01:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:39 INFO - '_': '/tools/buildbot/bin/python'} 04:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:39 INFO - Downloading/unpacking psutil>=0.7.1 04:01:39 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:39 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:39 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:39 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:39 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:39 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:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:41 INFO - Installing collected packages: psutil 04:01:41 INFO - Running setup.py install for psutil 04:01:41 INFO - building 'psutil._psutil_linux' extension 04:01:41 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:41 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:42 INFO - building 'psutil._psutil_posix' extension 04:01:42 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:42 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: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 - Successfully installed psutil 04:01:42 INFO - Cleaning up... 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:01:42 INFO - Using env: {'DISPLAY': ':0', 04:01:42 INFO - 'HOME': '/home/cltbld', 04:01:42 INFO - 'LANG': 'en_US.UTF-8', 04:01:42 INFO - 'LANGUAGE': 'en_US:en', 04:01:42 INFO - 'LOGNAME': 'cltbld', 04:01:42 INFO - 'MAIL': '/var/mail/cltbld', 04:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:42 INFO - 'MOZ_NO_REMOTE': '1', 04:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:42 INFO - 'NO_EM_RESTART': '1', 04:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:42 INFO - 'PWD': '/builds/slave/test', 04:01:42 INFO - 'SHELL': '/bin/bash', 04:01:42 INFO - 'SHLVL': '1', 04:01:42 INFO - 'TERM': 'linux', 04:01:42 INFO - 'TMOUT': '86400', 04:01:42 INFO - 'USER': 'cltbld', 04:01:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:42 INFO - '_': '/tools/buildbot/bin/python'} 04:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:44 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:44 INFO - Installing collected packages: mozsystemmonitor 04:01:44 INFO - Running setup.py install for mozsystemmonitor 04:01:44 INFO - Successfully installed mozsystemmonitor 04:01:44 INFO - Cleaning up... 04:01:44 INFO - Return code: 0 04:01:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:44 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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:44 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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:44 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 04:01:44 INFO - 'HOME': '/home/cltbld', 04:01:44 INFO - 'LANG': 'en_US.UTF-8', 04:01:44 INFO - 'LANGUAGE': 'en_US:en', 04:01:44 INFO - 'LOGNAME': 'cltbld', 04:01:44 INFO - 'MAIL': '/var/mail/cltbld', 04:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:44 INFO - 'MOZ_NO_REMOTE': '1', 04:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:44 INFO - 'NO_EM_RESTART': '1', 04:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:44 INFO - 'PWD': '/builds/slave/test', 04:01:44 INFO - 'SHELL': '/bin/bash', 04:01:44 INFO - 'SHLVL': '1', 04:01:44 INFO - 'TERM': 'linux', 04:01:44 INFO - 'TMOUT': '86400', 04:01:44 INFO - 'USER': 'cltbld', 04:01:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:44 INFO - '_': '/tools/buildbot/bin/python'} 04:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:46 INFO - 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:46 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:46 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:46 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:47 INFO - Downloading/unpacking docopt==0.6.1 (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:47 INFO - Downloading docopt-0.6.1.tar.gz 04:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:47 INFO - Running setup.py install for blobuploader 04:01:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:47 INFO - Running setup.py install for requests 04:01:47 INFO - Running setup.py install for docopt 04:01:48 INFO - Successfully installed blobuploader requests docopt 04:01:48 INFO - Cleaning up... 04:01:48 INFO - Return code: 0 04:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:48 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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:48 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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:48 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 04:01:48 INFO - 'HOME': '/home/cltbld', 04:01:48 INFO - 'LANG': 'en_US.UTF-8', 04:01:48 INFO - 'LANGUAGE': 'en_US:en', 04:01:48 INFO - 'LOGNAME': 'cltbld', 04:01:48 INFO - 'MAIL': '/var/mail/cltbld', 04:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:48 INFO - 'MOZ_NO_REMOTE': '1', 04:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:48 INFO - 'NO_EM_RESTART': '1', 04:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:48 INFO - 'PWD': '/builds/slave/test', 04:01:48 INFO - 'SHELL': '/bin/bash', 04:01:48 INFO - 'SHLVL': '1', 04:01:48 INFO - 'TERM': 'linux', 04:01:48 INFO - 'TMOUT': '86400', 04:01:48 INFO - 'USER': 'cltbld', 04:01:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:48 INFO - '_': '/tools/buildbot/bin/python'} 04:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:48 INFO - Running setup.py (path:/tmp/pip-XU__8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:48 INFO - Running setup.py (path:/tmp/pip-Ukizsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:48 INFO - Running setup.py (path:/tmp/pip-hek_vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:48 INFO - Running setup.py (path:/tmp/pip-WfEqAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:48 INFO - Running setup.py (path:/tmp/pip-mENN3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:48 INFO - Running setup.py (path:/tmp/pip-Y4maSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:48 INFO - Running setup.py (path:/tmp/pip-HRsNw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:48 INFO - Running setup.py (path:/tmp/pip-gTQUlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:48 INFO - Running setup.py (path:/tmp/pip-pQhqjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:49 INFO - Running setup.py (path:/tmp/pip-hPWry7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:49 INFO - Running setup.py (path:/tmp/pip-ucl8Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:49 INFO - Running setup.py (path:/tmp/pip-jwkdUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:49 INFO - Running setup.py (path:/tmp/pip-n3JjKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:49 INFO - Running setup.py (path:/tmp/pip-uf6B8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:49 INFO - Running setup.py (path:/tmp/pip-4UUDkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:49 INFO - Running setup.py (path:/tmp/pip-2j3lVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:49 INFO - Running setup.py (path:/tmp/pip-Ev2tfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:49 INFO - Running setup.py install for manifestparser 04:01:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:49 INFO - Running setup.py install for mozcrash 04:01:49 INFO - Running setup.py install for mozdebug 04:01:49 INFO - Running setup.py install for mozdevice 04:01:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozfile 04:01:50 INFO - Running setup.py install for mozhttpd 04:01:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozinfo 04:01:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozInstall 04:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozleak 04:01:50 INFO - Running setup.py install for mozlog 04:01:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for moznetwork 04:01:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozprocess 04:01:50 INFO - Running setup.py install for mozprofile 04:01:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:50 INFO - Running setup.py install for mozrunner 04:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Running setup.py install for mozscreenshot 04:01:51 INFO - Running setup.py install for moztest 04:01:51 INFO - Running setup.py install for mozversion 04:01:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:51 INFO - Cleaning up... 04:01:51 INFO - Return code: 0 04:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:51 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 04:01:51 INFO - 'HOME': '/home/cltbld', 04:01:51 INFO - 'LANG': 'en_US.UTF-8', 04:01:51 INFO - 'LANGUAGE': 'en_US:en', 04:01:51 INFO - 'LOGNAME': 'cltbld', 04:01:51 INFO - 'MAIL': '/var/mail/cltbld', 04:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:51 INFO - 'MOZ_NO_REMOTE': '1', 04:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:51 INFO - 'NO_EM_RESTART': '1', 04:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:51 INFO - 'PWD': '/builds/slave/test', 04:01:51 INFO - 'SHELL': '/bin/bash', 04:01:51 INFO - 'SHLVL': '1', 04:01:51 INFO - 'TERM': 'linux', 04:01:51 INFO - 'TMOUT': '86400', 04:01:51 INFO - 'USER': 'cltbld', 04:01:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:51 INFO - '_': '/tools/buildbot/bin/python'} 04:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:51 INFO - Running setup.py (path:/tmp/pip-9PMUAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 INFO - Running setup.py (path:/tmp/pip-yJp01w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 INFO - Running setup.py (path:/tmp/pip-byxt5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 INFO - Running setup.py (path:/tmp/pip-dB_F8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:51 INFO - Running setup.py (path:/tmp/pip-GIGYAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:51 INFO - Running setup.py (path:/tmp/pip-fXwUGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:52 INFO - Running setup.py (path:/tmp/pip-4h_eYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:52 INFO - Running setup.py (path:/tmp/pip-mjWeWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:52 INFO - Running setup.py (path:/tmp/pip-2WGt7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:52 INFO - Running setup.py (path:/tmp/pip-zWZLab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:52 INFO - Running setup.py (path:/tmp/pip-LeNdUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:52 INFO - Running setup.py (path:/tmp/pip-N47Spl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:52 INFO - Running setup.py (path:/tmp/pip-N1ePi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:52 INFO - Running setup.py (path:/tmp/pip-bZm1NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 INFO - Running setup.py (path:/tmp/pip-XvKIU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:52 INFO - Running setup.py (path:/tmp/pip-_a7Q9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:52 INFO - Running setup.py (path:/tmp/pip-iok8Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:52 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:52 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:52 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:52 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:52 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:52 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:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:54 INFO - Downloading blessings-1.6.tar.gz 04:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:54 INFO - Installing collected packages: blessings 04:01:54 INFO - Running setup.py install for blessings 04:01:54 INFO - Successfully installed blessings 04:01:54 INFO - Cleaning up... 04:01:55 INFO - Return code: 0 04:01:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:55 INFO - Reading from file tmpfile_stdout 04:01:55 INFO - Current package versions: 04:01:55 INFO - argparse == 1.2.1 04:01:55 INFO - blessings == 1.6 04:01:55 INFO - blobuploader == 1.2.4 04:01:55 INFO - docopt == 0.6.1 04:01:55 INFO - manifestparser == 1.1 04:01:55 INFO - mozInstall == 1.12 04:01:55 INFO - mozcrash == 0.17 04:01:55 INFO - mozdebug == 0.1 04:01:55 INFO - mozdevice == 0.48 04:01:55 INFO - mozfile == 1.2 04:01:55 INFO - mozhttpd == 0.7 04:01:55 INFO - mozinfo == 0.9 04:01:55 INFO - mozleak == 0.1 04:01:55 INFO - mozlog == 3.1 04:01:55 INFO - moznetwork == 0.27 04:01:55 INFO - mozprocess == 0.22 04:01:55 INFO - mozprofile == 0.28 04:01:55 INFO - mozrunner == 6.11 04:01:55 INFO - mozscreenshot == 0.1 04:01:55 INFO - mozsystemmonitor == 0.0 04:01:55 INFO - moztest == 0.7 04:01:55 INFO - mozversion == 1.4 04:01:55 INFO - psutil == 3.1.1 04:01:55 INFO - requests == 1.2.3 04:01:55 INFO - wsgiref == 0.1.2 04:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 04:01:55 INFO - 'HOME': '/home/cltbld', 04:01:55 INFO - 'LANG': 'en_US.UTF-8', 04:01:55 INFO - 'LANGUAGE': 'en_US:en', 04:01:55 INFO - 'LOGNAME': 'cltbld', 04:01:55 INFO - 'MAIL': '/var/mail/cltbld', 04:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:55 INFO - 'MOZ_NO_REMOTE': '1', 04:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:55 INFO - 'NO_EM_RESTART': '1', 04:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:55 INFO - 'PWD': '/builds/slave/test', 04:01:55 INFO - 'SHELL': '/bin/bash', 04:01:55 INFO - 'SHLVL': '1', 04:01:55 INFO - 'TERM': 'linux', 04:01:55 INFO - 'TMOUT': '86400', 04:01:55 INFO - 'USER': 'cltbld', 04:01:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:55 INFO - '_': '/tools/buildbot/bin/python'} 04:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Cleaning up... 04:01:55 INFO - Return code: 0 04:01:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 04:01:55 INFO - 'HOME': '/home/cltbld', 04:01:55 INFO - 'LANG': 'en_US.UTF-8', 04:01:55 INFO - 'LANGUAGE': 'en_US:en', 04:01:55 INFO - 'LOGNAME': 'cltbld', 04:01:55 INFO - 'MAIL': '/var/mail/cltbld', 04:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:55 INFO - 'MOZ_NO_REMOTE': '1', 04:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:55 INFO - 'NO_EM_RESTART': '1', 04:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:55 INFO - 'PWD': '/builds/slave/test', 04:01:55 INFO - 'SHELL': '/bin/bash', 04:01:55 INFO - 'SHLVL': '1', 04:01:55 INFO - 'TERM': 'linux', 04:01:55 INFO - 'TMOUT': '86400', 04:01:55 INFO - 'USER': 'cltbld', 04:01:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:55 INFO - '_': '/tools/buildbot/bin/python'} 04:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:55 INFO - Downloading/unpacking jsonschema 04:01:55 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:55 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:55 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:55 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:55 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:55 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:57 INFO - Downloading/unpacking functools32 (from 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:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:57 INFO - warning: no files found matching '*.txt' 04:01:57 INFO - no previously-included directories found matching 'build' 04:01:57 INFO - no previously-included directories found matching 'dist' 04:01:57 INFO - no previously-included directories found matching '.git*' 04:01:57 INFO - Installing collected packages: jsonschema, functools32 04:01:57 INFO - Running setup.py install for functools32 04:01:57 INFO - warning: no files found matching '*.txt' 04:01:57 INFO - no previously-included directories found matching 'build' 04:01:57 INFO - no previously-included directories found matching 'dist' 04:01:57 INFO - no previously-included directories found matching '.git*' 04:01:57 INFO - Successfully installed jsonschema functools32 04:01:57 INFO - Cleaning up... 04:01:58 INFO - Return code: 0 04:01:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:58 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 0x7fd47d8f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', '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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:01:58 INFO - Using env: {'DISPLAY': ':0', 04:01:58 INFO - 'HOME': '/home/cltbld', 04:01:58 INFO - 'LANG': 'en_US.UTF-8', 04:01:58 INFO - 'LANGUAGE': 'en_US:en', 04:01:58 INFO - 'LOGNAME': 'cltbld', 04:01:58 INFO - 'MAIL': '/var/mail/cltbld', 04:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:58 INFO - 'MOZ_NO_REMOTE': '1', 04:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:58 INFO - 'NO_EM_RESTART': '1', 04:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:58 INFO - 'PWD': '/builds/slave/test', 04:01:58 INFO - 'SHELL': '/bin/bash', 04:01:58 INFO - 'SHLVL': '1', 04:01:58 INFO - 'TERM': 'linux', 04:01:58 INFO - 'TMOUT': '86400', 04:01:58 INFO - 'USER': 'cltbld', 04:01:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:58 INFO - '_': '/tools/buildbot/bin/python'} 04:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:58 INFO - Downloading/unpacking flake8 04:01:58 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:58 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:58 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:58 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:58 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:58 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from 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:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from 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:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from 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:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:00 INFO - no previously-included directories found matching 'docs/_build' 04:02:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:00 INFO - Running setup.py install for pep8 04:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:01 INFO - no previously-included directories found matching 'docs/_build' 04:02:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:01 INFO - Cleaning up... 04:02:01 INFO - Return code: 0 04:02:01 INFO - Running post-action listener: _resource_record_post_action 04:02:01 INFO - Running post-action listener: _start_resource_monitoring 04:02:01 INFO - Starting resource monitoring. 04:02:01 INFO - ##### 04:02:01 INFO - ##### Running install step. 04:02:01 INFO - ##### 04:02:01 INFO - Running pre-action listener: _resource_record_pre_action 04:02:01 INFO - Running main action method: install 04:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:01 INFO - Reading from file tmpfile_stdout 04:02:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:01 INFO - Reading from file tmpfile_stdout 04:02:01 INFO - Output received: 04:02:01 INFO - Usage: mozinstall [options] installer 04:02:01 INFO - Options: 04:02:01 INFO - -h, --help show this help message and exit 04:02:01 INFO - -d DEST, --destination=DEST 04:02:01 INFO - Directory to install application into. [default: 04:02:01 INFO - "/builds/slave/test"] 04:02:01 INFO - --app=APP Application being installed. [default: firefox] 04:02:01 INFO - mkdir: /builds/slave/test/build/application 04:02:01 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:01 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:14 INFO - Reading from file tmpfile_stdout 04:02:14 INFO - Output received: 04:02:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:14 INFO - Running post-action listener: _resource_record_post_action 04:02:14 INFO - ##### 04:02:14 INFO - ##### Running run-tests step. 04:02:14 INFO - ##### 04:02:14 INFO - Running pre-action listener: _resource_record_pre_action 04:02:14 INFO - Running main action method: run_tests 04:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:14 INFO - Python 2.7.3 04:02:14 INFO - Return code: 0 04:02:14 INFO - grabbing minidump binary from tooltool 04:02:14 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:14 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 0xede410>, '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 0xedf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:14 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:14 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:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:14 INFO - Return code: 0 04:02:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:15 INFO - Return code: 0 04:02:15 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-013', '--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:15 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-013 --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:15 INFO - Using env: {'DISPLAY': ':0', 04:02:15 INFO - 'HOME': '/home/cltbld', 04:02:15 INFO - 'LANG': 'en_US.UTF-8', 04:02:15 INFO - 'LANGUAGE': 'en_US:en', 04:02:15 INFO - 'LOGNAME': 'cltbld', 04:02:15 INFO - 'MAIL': '/var/mail/cltbld', 04:02:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:15 INFO - 'MOZ_NO_REMOTE': '1', 04:02:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:15 INFO - 'NO_EM_RESTART': '1', 04:02:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:15 INFO - 'PWD': '/builds/slave/test', 04:02:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:15 INFO - 'SHELL': '/bin/bash', 04:02:15 INFO - 'SHLVL': '1', 04:02:15 INFO - 'TERM': 'linux', 04:02:15 INFO - 'TMOUT': '86400', 04:02:15 INFO - 'USER': 'cltbld', 04:02:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790', 04:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:15 INFO - '_': '/tools/buildbot/bin/python'} 04:02:15 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-013', '--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:15 INFO - mozversion application_buildid: 20160726073802 04:02:15 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:15 INFO - mozversion application_display_name: Firefox 04:02:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:15 INFO - mozversion application_name: Firefox 04:02:15 INFO - mozversion application_remotingname: firefox 04:02:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:15 INFO - mozversion application_vendor: Mozilla 04:02:15 INFO - mozversion application_version: 48.0 04:02:15 INFO - mozversion platform_buildid: 20160726073802 04:02:15 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:15 INFO - mozversion platform_version: 48.0 04:02:15 INFO - using testdate: 1469617335 04:02:15 INFO - actual date: 1469617335 04:02:15 INFO - starting webserver on 'localhost:44254' 04:02:15 INFO - SUITE-START | Running 2 tests 04:02:15 INFO - TEST-START | dromaeo_css 04:02:15 INFO - operating with platform_type : linux_ 04:02:15 INFO - Initialising browser for dromaeo_css test... 04:02:15 INFO - TEST-INFO | started process 22300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbsD_aw/profile http://localhost:44254/getInfo.html) 04:02:19 INFO - PROCESS | 22300 | __metrics Screen width/height:1600/1200 04:02:19 INFO - PROCESS | 22300 | colorDepth:24 04:02:19 INFO - PROCESS | 22300 | Browser inner width/height: 1024/697 04:02:19 INFO - PROCESS | 22300 | __metrics 04:02:20 INFO - PROCESS | 22300 | 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:21 ERROR - PROCESS | 22300 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:21 INFO - TEST-INFO | 22300: exit 0 04:02:21 INFO - Browser initialized. 04:02:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:21 INFO - TEST-INFO | started process 22393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbsD_aw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:33 INFO - PROCESS | 22393 | RSS: Main: 139620352 04:02:33 INFO - PROCESS | 22393 | 04:03:25 INFO - PROCESS | 22393 | 1469617405163 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:31 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44254/tests/dromaeo/cssquery-ext.html) 04:05:32 INFO - PROCESS | 22393 | RSS: Main: 250187776 04:05:32 INFO - PROCESS | 22393 | 04:08:35 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-ext.html (next: http://localhost:44254/tests/dromaeo/cssquery-jquery.html) 04:08:35 INFO - PROCESS | 22393 | RSS: Main: 229294080 04:08:35 INFO - PROCESS | 22393 | 04:11:37 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44254/tests/dromaeo/cssquery-mootools.html) 04:11:37 INFO - PROCESS | 22393 | RSS: Main: 226357248 04:11:37 INFO - PROCESS | 22393 | 04:14:39 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44254/tests/dromaeo/cssquery-prototype.html) 04:14:40 INFO - PROCESS | 22393 | RSS: Main: 221556736 04:14:40 INFO - PROCESS | 22393 | 04:17:42 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44254/tests/dromaeo/cssquery-yui.html) 04:17:43 INFO - PROCESS | 22393 | RSS: Main: 180785152 04:17:43 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | Cycle 1(1): loaded http://localhost:44254/tests/dromaeo/cssquery-yui.html (next: http://localhost:44254/tests/dromaeo/cssquery-dojo.html) 04:20:45 INFO - PROCESS | 22393 | RSS: Main: 255406080 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | __start_tp_report 04:20:45 INFO - PROCESS | 22393 | _x_x_mozilla_page_load 04:20:45 INFO - PROCESS | 22393 | _x_x_mozilla_page_load_details 04:20:45 INFO - PROCESS | 22393 | |i|pagename|runs| 04:20:45 INFO - PROCESS | 22393 | |0;dojo.html;3210.6468288488263;3289.2270316475624;3294.752893532984;3308.4044871923043;3328.134684981904;5280.1815718563685;5315.14957606783;5320.547753440953;5321.4412486688925;5339.492748188921;5328.040952628526;5330.440303768097;5333.4399888011785;5334.279872217249;5334.786608535664;4861.562459378664;4889.119958407486;4907.656464047518;4923.310736496894;4983.975080124595;4903.9754801225945;4922.901541969159;4971.726555039471;4988.127077761395;5041.3194218780545;4994;5056.19100943849;5061.620378471611;5076.162433198518;5109.310243117169;4977.104121258172;4983.576396006344;5011.323471331379;5044.520770526794;5046.873828154289;4816.084943860656;4866.562009419134;4956.776945037482;4967.751612419364;4974.602031837444;5294.629375943686;5302.814401495968;5313.707746073965;5335.6798592084215;5340.198970154469;5660.688662123582;5779.508741756914;5786.826395208151;5818.8254352369495;5825;5658.886822263532;5728.312602487728;5746.712664366765;5779.682117483537;5789.044807606782;5446.782128714846;5475.753591088411;5475.890482190373;5476.479734425223;5477.123660214386;5743.10981797822;5890.263717035371;5926.496247818897;5935.376785437553;5949.762009519657;5674.4892959633835;5676;5684.403137670485;5690.800821971211;5717.542596592262;5756.65460072397;5759.049756790167;5770.451807078321;5773.364929857712;5775.48020678141;5585.720713964367;5630.042892708249;5691.9146212806845;5722.084466485342;5726.885462290731;5781.075027995501;5782.5663075268685;5786.479216870502;5792.420757924174;5797.072468405119;4456.286994080931;4486.7083639563325;4492.797824097858;4496.258117410591;4500.122476117192;3895.668868146183;3966.6231707987695;4013;4024.71826972115;4047.4535937648043;5542.944570554324;5583.664980101207;5591;5606.383297837235;5640.689762063126;5665.943340566541;5841.561882858802;5844.912326315109;5849.327327357323;5853.414658534112;5482.5613950883835;5533.142362933751;5566.415526369754;5587.469190426903;5595.272614560081;5030.119729047476;5040.7731652075745;5058.215976523645;5066.417362003417;5089.083964886282;5838.766449341979;6033.3664965178905;6034.758609655652;6044.576879618385;6045.274567051982;5728.226689396878;5811;5814.5639077068545;5817.040188368872;5832.154337621106;6002.069679199731;6017.127516510169;6019.909701354396;6023.5181185505935;6031.336552979256;5530.97234513841;5578.776848925998;5664.773409063756;5698.430156984268;5704.80033198836;5707.172459993195;5708.457696518824;5739.655620662774;5745.626534275259;5798.739056742541;5581;5592.692401917933;5615.410381910004;5616.1856530803625;5620.831375058755;5534.667919924817;5594.4964953152785;5619.409961953936;5625.21247025425;5646.632968857176;5586.972065139648;5588.720563971704;5593.608447408805;5593.776248949996;5613.859653508695;5697.971510142588;5717.885642287214;5720.513756330759;5724.141378793214;5728.914066288926;5405.108157154183;5425.728713564385;5562.3047119110115;5602.243697100839;5607.607467477401 04:20:45 INFO - PROCESS | 22393 | |1;ext.html;596.8478038100284;658.8616390557983;669.6885948034164;673.1047706550289;735.8307589254468;32911.341773164524;33436;33444.331113377746;39999;40911.59088409115;43603.78198109005;43944;43946.78026609871;44094.33858492125;44112;8856.158664926837;8991.550422478882;9003.96454407745;9033.954830225839;9036.45781253127;8374.28818550424;10719.35683858967;11014.173936954721;11022.669319920415;11029;10603.893961060407;10624.575016999312;10671.78656426871;10694.51874665638;10694.732631684192;10561.260711750143;10638.414887181201;10640.893591064068;10648.094911932494;10650.988156125195;10386.221033422447;10480.213983951235;10490.527926243338;10502.369857808479;10506.001929816655;41059.38410923839;41343.379849301986;41425;41508.37737433941;41579.58420415787;3774.9811250943844;3791.184895247535;3856.6529012388737;3880.0881792778673;4250.234957707611;33028.1742956428;34158;34345.31309373824;34506.96479105631;34517.654823451696;4270.145970805851;4312.978435107836;4324.632406245441;4350.956490435086;4486.641068714495;326576;327677;327885;327936.9999999976;328205;62155.378446214956;62750.37249627445;62975.37024629695;63013.68493157597;63055.6847215761;71094;72660;72862.35688215568;72932.63533682298;72966.63516682382;17681.292748289925;17726.20232089559;17752.20115094824;17788.46634600964;17799.377021804175;13938.37277322523;14374.35315410809;14549.709005819825;14770.926145369205;15165.848341516665;20025.799742002393;20055.197792088446;20174.29389971344;20225.190992360436;20328.186872525228;7257.564546127249;7385.150707668579;7411.703531858773;7559.773206803805;7626.36890272855;1105.6627728542871;1117.8211486162174;1130.496928866663;1153.5278810779614;1203.6819682447706;32865;32979.67020329814;33233.3353332932;33749.49375759366;34135.48796768051;1237.6101528018646;1238.578883179723;1240.9379531023412;1292.1923797626484;1298.8116723075102;17144.314227430765;17622.207000685;17628.823711762976;17774;17786;512862;518329;518491;519022;519463;61498;63013.68493157505;63118;63196.684016579624;63229.68385158045;1344.865513448667;1411.9223442710545;1446.7323545144181;1561.7266978278756;1622.618684609116;31847.522287166175;32175.51736723904;33039.50440743343;33253;33362;50368.74815625898;59493.10760338512;61439.38560614337;61486.69256653688;61586.69206653938;446248;453868;454435;454757;457929;43265.13469730651;46306.30540541827;47919;47968;49072.50927490679;44455.77772111119;44483;45073.54926450693;45364.54635453735;45473;37180.25639487249;38388.61611383851;38634.806825965694;38930.6106938927;39284.017899551596;37898;45931.54068459273;47240.7637961808;47256.52743472659;47712.761436192595;43651.345229820945;44468.55531444774;44577;44790;45238.547614523435;42862.14275714406;43858.71072546466;45655.543444565126;45721;47206.291905620754;34298.31403371968;34793.304133917685;34864.825675871456;35207.295854082266;35635.46546801748 04:20:45 INFO - PROCESS | 22393 | |2;jquery.html;425.321612028814;430.5135197227133;435.9258925982583;437.07558513743425;442.70781284352313;18244.81755182448;18557.16492757826;18684.01535099727;19050.237990480382;19080.33218837341;18213.27146914122;18301.542461438472;18603.81396186038;18891.338803141894;18919;4874.366332376786;5225.973870130653;5377.085895397791;5816.709164541777;5845.766169353221;5798.217240672498;5815.156802263669;5828.795992140276;5842.0652695568715;5847.970760146193;5265.552428043621;5329.946700532983;5333.120035194188;5782.653040817543;5792.102224155263;4805.639577031737;4807.519248075165;4825.879353016167;4851.248056551241;4996.999999999982;4694.57748802606;4710.081534100852;4734.95265047352;4737.28940658904;4744.264638980963;13295.468181272738;13919.23444210568;22467.662985055238;23286.301410957698;23287.88356058209;2438.1710218525786;2499.6125600531946;2526.9620955685677;2542.072143667548;2581;10368.79262414755;10828.079613232805;10974.286671366415;14249.786253206106;14398.640033999129;1971.9507012324664;2002.5994801039706;2014.3369888346456;2030.46192758919;2091.069082616569;76156.61921690356;79138.8129178057;79991.20008799895;82415;82415.17584824134;11031;11180.888191118147;11230.15773816967;11252.099832013419;11296.209265351346;15915.363385464683;16119.838801612068;16126.838731612768;16139.193040347936;16157.353705851634;8788;8992.370534062684;9028.8645670315;9085.50029748357;9150.084991500797;8779.868301975348;8917.509536975398;8944.552772361356;9016.909830901739;9018.86471702925;4681.227597446383;4720.504347043511;4983.152864013126;4987.551120399109;4993.875153121201;1995.600879824012;2024.8076432738867;2053.7638171610156;2063.938081857547;2105.842061845368;1009.0817356205818;1058.5342449322275;1065.0787069185253;1091.9672409827717;1108.2740804772886;18208;18337.816621833877;18429.26282948667;18663.253469861324;19187.232510699694;1065.4672663668166;1070.4915165296422;1081;1100.14738577603;1103.2553026706942;10575.259731818698;11125.833112503318;11149.108071354434;11223.887761122447;11228.382438965935;498100;502473.7949684322;511441;514644;526158;58814.705926470095;96668;97500;98644;99600;1137.5677242647741;1147.8565179352747;1184.4729095552568;1207.927524348542;1227.2636418149038;10935.17986151026;10963.284189069549;17230.310787568356;17587.120643967493;17601.559961001076;38927.80536097301;39422.40866386949;39684.70231518805;40325.596744033355;41787;51006;51046;55163;56788;59333;12471.501139954664;13332.93333533326;13337.133086349357;13367.799483007957;13428.597142085753;9444.716658500256;14524.20116893581;14669.046511976687;14699.632509187355;14927.253637317874;8435.32517398619;8555.144485551395;8721.215090641872;8994.685186018458;9058.547072646474;8462.407631465738;8595.09751476111;8702.825943480968;8779.868301975348;8893.955530222567;8798.648054077765;8832.160944710242;8862.867056994279;8989.46063236208;9204;12993.48026078984;13028.934855325662;13427.395767190304;13485;13560.728785424039;12922.160059596095;13074.28091454979;13092.345382731015;13171.275579842817;13186.868131318564 04:20:45 INFO - PROCESS | 22393 | |3;mootools.html;1416.2140012293173;1563.710713517999;1588.618731504439;1800.8199180081992;1933.2653591635167;8038.919610803898;8237.258646721793;8247.54638494884;8252.463589866662;8256.422050456471;8057.798555036127;8222.259996600305;8227.341812654988;8230.711925082624;8233.91766082339;2345.1323010486144;2356.96464553031;2365.8698771567556;2368.455255291284;2368.6210206366986;2401.819863510235;2423.1761201191593;2446.376174075608;2460.6801115854914;2461.2862269941784;2350.2949115265437;2353.1175809071597;2366.2782851230368;2398.1606437746823;2401.1955994741784;2362.043372434167;2396.101461951768;2398.0647547456506;2404.63930410439;2407.07327678844;2356.081128359941;2409.3013026222548;2423.7333893271725;2425.0784701813373;2426.1751004658327;7180.353768160839;7894.131645518988;8333.374996875198;8385.538795366314;8387.580620968927;5011.974940125312;5113.667611605234;5114.897702045975;5116.872078198075;5144.897102057937;3314.8839790607212;3333.4333163362285;3346.2303670156;3425.9143521411916;3461.9826900865587;1173.9941300293528;1185.9347735874524;1191.8927296543266;1199.7000749812546;1201.516127582435;11462.254953428084;11841.289522628584;11898.28610283377;11902;11917.940410297893;4670.696404733681;4696.906061878812;4707.317438971399;4759.0719809636785;4760.952390476051;10205;10205.489725513695;10208.948955255177;10217.18262538995;10218.591256349811;5318.308619879468;5332.066888294533;5333.1466965286145;5335.973320133452;5338.813141540028;4836.637252206098;4851.757412129379;4858.416989961227;4868.610511159099;4869.610431165498;3748.887533374003;3935.4687117238805;3951.565327813938;3958.960410395917;3979.8607048753156;1213.1568559850818;1223.1621339382552;1224.7856625090574;1228.956986505468;1238.2013601227338;908.5820522559565;981.5239608789731;1034.5396298647029;1050.6270274052754;1054.7099547624464;5894.67579283135;5901.881962360729;5905.055191169392;5944.7324870380935;6071.817845464643;472.75416783272505;473.56432082484196;475.38912497440623;492.72161228905554;493.82222399935995;3546.5921419036627;3969.186316805048;4036.656884164879;4056.3307054335705;4099.528554216244;9711.27165462593;9863.30956833029;10008.44953527563;10013.048760367754;10027.899721002843;9658.517074146264;9839.508024598741;9863.901360986298;9869.062439068277;9894.356866803635;7752.806179845549;7891.565963872042;7894.250046245597;7972.123066462568;7976.641051152712;5662.66024038559;5888.381719919346;5901.557383196192;5962.37395073511;6034.879302414015;9229.815403692022;9260.675876344296;9386.06139386056;9389.765255868659;9581.952090239503;9400.435973841591;9498.09768072032;9507.857382139135;9604.27967902396;9660.729728513934;7245.38414234796;7300.233475484997;7351.228121047213;7358.595277259802;7378.114626244885;8092.87860682102;8123.837523249384;8203.630836612487;8221.671133154607;8238.752837414888;7539.924600753922;7585.620718963919;7612.58130802789;7625.161232264558;7678.6544605494;7523.1348394935285;7536.585487798224;7548.207438219128;7631.580263085583;7639.847203056019;6825.488088393291;6862.073620061427;6870.828229294308;7048.436125109876;7054.25930277334;5040.7479626019285;5094.286799848099;5147.202183661539;5250.553702935141;5279.39286982002;5160.587153027674;5220.3735551734035;5247.370315562004;5285.550728187994;5351.117065684119 04:20:45 INFO - PROCESS | 22393 | |4;prototype.html;353.33043881843906;356.45284488310443;358.3835802419838;366.44117720476254;368.60927416938046;5966.612170208944;6115.816525504237;6116.357782432848;6119.2350956130485;6138.109974053759;6136.662483563402;6170.796694644535;6172.351903050182;6179.196704428429;6181.783637572686;4707.599854012413;4742.786574604151;4745.786439610226;4750.287456881478;4750.524947505239;4542.727436353813;4589.79345929434;4670;4737.786799594027;4739.597134243593;4630.8147674093;4631.120087183441;4632.14305353509;4634.930476042862;4645.9767701161445;4681.204195286809;4685.4377474702915;4690;4690.929636055462;4699.318598803155;4119.8970025749295;4124.9587504124875;4127.7936103195025;4133.834646614132;4141.855035073788;5829.970850145764;5834.562407819388;5840.766369345221;5840.824775256707;5865.178874957509;5432.2123292122815;5436.510714035756;5437.32033495813;5437.401885792559;5449.6730196188355;6150.753969841246;6343.462614954009;6344;6413.326600706905;6419.454346380563;4485.753283569403;4486.8878278042985;4487.483939346984;4492.595666390008;4496.4829044659955;6622.139121914121;6691.1636045494315;6693.832654183636;6697.598144111369;6703.262641109474;4490.595846373842;4502.977485112619;4505.842295519641;4505.909881802346;4510.300903359985;4562.794674239667;4569.977150114295;4571.108633816374;4572.9314060289125;4574.108048930427;5211.557017653466;5320.733963301819;5331.653442526223;5336.839894803162;5346.679199247979;6435.452986496107;6450.8064758057335;6452.9677351612945;6454.290028096905;6455.0317452382515;1552.0765144738862;1580.7233734096717;1583.263782341217;1596.3375199292395;1632.4449687106442;1044.472541366605;1069.3637285814928;1069.9572017119228;1093.824988001916;1098.4452851310036;6230.314665386803;6378;6389.488840892717;6405.19935008124;6410.807675769641;6604.240512341143;6605.207375115017;6605.966970165118;6606.966965165239;6621.602703837785;6276.843078923063;6278.560500764903;6286.717097730613;6295.874082518324;6305;3537.0273174877116;3569.839357228931;3573.7498375114014;3573.8213089345427;3574.7140228781636;6718;6910.067140935909;6919.619420931796;6923.099997000459;6928.792136235921;6686.1642294713165;6705.994100884906;6709.966450167718;6714.254293883528;6719.328067193339;6827.6244806536115;6900.7929762107215;6902.723891044402;6903.0335752993615;6906.412954898789;6592.76925307612;6593.835154121185;6600.372964568358;6617.867642647024;6618.867622647616;6386.265579458422;6531.967340163269;6537.378948999837;6555.180602424697;6564.8358791030605;6997.26528714498;7017.7192912282935;7022.789316320519;7034.753783617549;7035.613041282779;4543.409356783597;4591.403117594691;4597.149527337453;4599.954000459952;4607.562281583244;6433.260175079926;6715.764948226984;6725.226598940989;6725.4619630430425;6729.192496900403;6348.968255158695;6404.679766011587;6455.289918109098;6537.313582073813;6542.018697195268;6478.935210647834;6493.805185844432;6501.902471463027;6523.380278873499;6525;6431.649353635602;6432.807015789534;6435.806925792233;6436.774712885027;6441.355864413708;6344.587601805868;6566.376194261537;6580.670966451754;6582.572132811352;6582.605043697394;6298.212723409574;6329.208848893888;6330.556861019684;6331.620102793847;6341.048842673636 04:20:45 INFO - PROCESS | 22393 | |5;yui.html;778.9104253010905;796.9203079692031;910.5923313841896;932.0586207929992;932.4638332958547;14407.855921440783;15448;15672.451464198755;15694.21528923552;15695;12557.811632825515;16012.759808602881;16179.919100404511;16222.756658650129;16250.268737906794;770.3606007014165;914.4193437167413;915.4919019943928;939.375315415248;940.7836197674538;873.8645509945936;921.8294615496121;927.0729270729271;928.5542939389097;928.6842473558988;922.5802259971697;976.3507267666993;980.5489474841581;980.7744218829673;981.6466072213997;803.955782431966;812.1959260332258;922.9893266872764;956.4118067388575;972.6644307713827;683.1597135523284;694.0456871801273;709.7515869445705;715.1168307140678;715.8568286342752;15001.399944002227;15056.397744090333;15105.697886042328;15147.318370673345;15225;14606;14683.339249733788;14691.412343506247;14868.182249976247;14927.552173434815;10951.945240273748;11048.37219983927;11093.16801239902;11171.441427928652;11287;3968.6912153744515;4089.8568550100604;4135.441715368417;4141.047559061402;4144.171165766858;56967.715161424756;56980.715096424254;57149.71425142848;57355;57460.42539574592;11748.412579370997;11992.64022079339;12030.15788894769;12103;12279.693007674701;21654.566908661738;21656.458588535414;21720;21727.456813579473;21737.34787956364;8856.468611883307;9040.41237319572;9121.087891210826;9251.352405331561;9254.12085851843;4768.165571025057;4846.36997190363;4957.132501812241;5113.693178409308;5138.486151384832;3611.530501034901;3657.2868290683064;3662.212624285791;3662.5788034376387;3667.74325797197;604.9304330002018;619.6096459230746;625.7090452939404;636.8376064103624;641.1152609399093;767.963249613018;802.7391097893208;820.6102101501739;831.264331066998;839.0141583639199;9685.854712179324;10139.64511242103;10141.391516509033;10197.54111064989;10247.38515689061;803.3733687723585;809.1867672988609;816.2286639126088;827.4125370986667;834.8580741273998;4536.432945881765;4770;4847.830325938575;4854.514548545118;4855.927161092586;62443;63555.6822215886;63637.36362636314;63672.681636592446;63685.36314636794;54994.72502637461;56250;56931.43068569261;56986;58319.70840145857;51084.744576276884;51613;52017;52429.73785131126;53477.73261133747;8975.50634715097;9400.623975041195;9401.435913844918;9561.760955976157;9616.471094089613;38146.618533814304;38614;38792.6120738789;39158;39625.20749584935;44409.111817762816;45237.54762452334;48743;49497.50502494929;49749.25376119433;11423.143264255381;12274.324912129918;12287.75424491523;12712.936435318134;13016.28410437435;14018.439262429389;14075.648108797363;14571.198584077978;14973.1016139032;14978.550643480714;12199.02407807391;12440.25358478458;12700.555480558136;13745.38145783422;14593.562193134223;12440.37798110109;12695.619131426072;13321.200727956353;13455;13890.444382224598;12332.568360107352;12763.425645846144;13826.86173138296;14461.638459038188;14639.41442342337;10997.61508347204;11137.498812553617;11177.72055698614;11284.21010529255;11589.478473468545;11000.114823745831;11286.943565282449;11293.289610493259;11327.546898123983;11415.771684566429 04:20:45 INFO - PROCESS | 22393 | __end_tp_report 04:20:45 INFO - PROCESS | 22393 | __start_cc_report 04:20:45 INFO - PROCESS | 22393 | _x_x_mozilla_cycle_collect,852 04:20:45 INFO - PROCESS | 22393 | __end_cc_report 04:20:45 INFO - PROCESS | 22393 | __startTimestamp1469618445878__endTimestamp 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | ------- Summary: start ------- 04:20:45 INFO - PROCESS | 22393 | Number of tests: 6 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#0] dojo.html Cycles:165 Average:5382.87 Median:5592.69 stddev:576.20 (10.3%) stddev-sans-first:552.19 04:20:45 INFO - PROCESS | 22393 | Values: 3210.6 3289.2 3294.8 3308.4 3328.1 5280.2 5315.1 5320.5 5321.4 5339.5 5328.0 5330.4 5333.4 5334.3 5334.8 4861.6 4889.1 4907.7 4923.3 4984.0 4904.0 4922.9 4971.7 4988.1 5041.3 4994.0 5056.2 5061.6 5076.2 5109.3 4977.1 4983.6 5011.3 5044.5 5046.9 4816.1 4866.6 4956.8 4967.8 4974.6 5294.6 5302.8 5313.7 5335.7 5340.2 5660.7 5779.5 5786.8 5818.8 5825.0 5658.9 5728.3 5746.7 5779.7 5789.0 5446.8 5475.8 5475.9 5476.5 5477.1 5743.1 5890.3 5926.5 5935.4 5949.8 5674.5 5676.0 5684.4 5690.8 5717.5 5756.7 5759.0 5770.5 5773.4 5775.5 5585.7 5630.0 5691.9 5722.1 5726.9 5781.1 5782.6 5786.5 5792.4 5797.1 4456.3 4486.7 4492.8 4496.3 4500.1 3895.7 3966.6 4013.0 4024.7 4047.5 5542.9 5583.7 5591.0 5606.4 5640.7 5665.9 5841.6 5844.9 5849.3 5853.4 5482.6 5533.1 5566.4 5587.5 5595.3 5030.1 5040.8 5058.2 5066.4 5089.1 5838.8 6033.4 6034.8 6044.6 6045.3 5728.2 5811.0 5814.6 5817.0 5832.2 6002.1 6017.1 6019.9 6023.5 6031.3 5531.0 5578.8 5664.8 5698.4 5704.8 5707.2 5708.5 5739.7 5745.6 5798.7 5581.0 5592.7 5615.4 5616.2 5620.8 5534.7 5594.5 5619.4 5625.2 5646.6 5587.0 5588.7 5593.6 5593.8 5613.9 5698.0 5717.9 5720.5 5724.1 5728.9 5405.1 5425.7 5562.3 5602.2 5607.6 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#1] ext.html Cycles:180 Average:61640.17 Median:39107.31 stddev:116270.09 (297.3%) stddev-sans-first:116505.92 04:20:45 INFO - PROCESS | 22393 | Values: 596.8 658.9 669.7 673.1 735.8 32911.3 33436.0 33444.3 39999.0 40911.6 43603.8 43944.0 43946.8 44094.3 44112.0 8856.2 8991.6 9004.0 9034.0 9036.5 8374.3 10719.4 11014.2 11022.7 11029.0 10603.9 10624.6 10671.8 10694.5 10694.7 10561.3 10638.4 10640.9 10648.1 10651.0 10386.2 10480.2 10490.5 10502.4 10506.0 41059.4 41343.4 41425.0 41508.4 41579.6 3775.0 3791.2 3856.7 3880.1 4250.2 33028.2 34158.0 34345.3 34507.0 34517.7 4270.1 4313.0 4324.6 4351.0 4486.6 326576.0 327677.0 327885.0 327937.0 328205.0 62155.4 62750.4 62975.4 63013.7 63055.7 71094.0 72660.0 72862.4 72932.6 72966.6 17681.3 17726.2 17752.2 17788.5 17799.4 13938.4 14374.4 14549.7 14770.9 15165.8 20025.8 20055.2 20174.3 20225.2 20328.2 7257.6 7385.2 7411.7 7559.8 7626.4 1105.7 1117.8 1130.5 1153.5 1203.7 32865.0 32979.7 33233.3 33749.5 34135.5 1237.6 1238.6 1240.9 1292.2 1298.8 17144.3 17622.2 17628.8 17774.0 17786.0 512862.0 518329.0 518491.0 519022.0 519463.0 61498.0 63013.7 63118.0 63196.7 63229.7 1344.9 1411.9 1446.7 1561.7 1622.6 31847.5 32175.5 33039.5 33253.0 33362.0 50368.7 59493.1 61439.4 61486.7 61586.7 446248.0 453868.0 454435.0 454757.0 457929.0 43265.1 46306.3 47919.0 47968.0 49072.5 44455.8 44483.0 45073.5 45364.5 45473.0 37180.3 38388.6 38634.8 38930.6 39284.0 37898.0 45931.5 47240.8 47256.5 47712.8 43651.3 44468.6 44577.0 44790.0 45238.5 42862.1 43858.7 45655.5 45721.0 47206.3 34298.3 34793.3 34864.8 35207.3 35635.5 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#2] jquery.html Cycles:180 Average:29309.65 Median:2513.29 stddev:84042.30 (3343.9%) stddev-sans-first:84250.08 04:20:45 INFO - PROCESS | 22393 | Values: 425.3 430.5 435.9 437.1 442.7 18244.8 18557.2 18684.0 19050.2 19080.3 18213.3 18301.5 18603.8 18891.3 18919.0 4874.4 5226.0 5377.1 5816.7 5845.8 5798.2 5815.2 5828.8 5842.1 5848.0 5265.6 5329.9 5333.1 5782.7 5792.1 4805.6 4807.5 4825.9 4851.2 4997.0 4694.6 4710.1 4735.0 4737.3 4744.3 13295.5 13919.2 22467.7 23286.3 23287.9 2438.2 2499.6 2527.0 2542.1 2581.0 10368.8 10828.1 10974.3 14249.8 14398.6 1972.0 2002.6 2014.3 2030.5 2091.1 76156.6 79138.8 79991.2 82415.0 82415.2 11031.0 11180.9 11230.2 11252.1 11296.2 15915.4 16119.8 16126.8 16139.2 16157.4 8788.0 8992.4 9028.9 9085.5 9150.1 8779.9 8917.5 8944.6 9016.9 9018.9 4681.2 4720.5 4983.2 4987.6 4993.9 1995.6 2024.8 2053.8 2063.9 2105.8 1009.1 1058.5 1065.1 1092.0 1108.3 18208.0 18337.8 18429.3 18663.3 19187.2 1065.5 1070.5 1081.0 1100.1 1103.3 10575.3 11125.8 11149.1 11223.9 11228.4 498100.0 502473.8 511441.0 514644.0 526158.0 58814.7 96668.0 97500.0 98644.0 99600.0 1137.6 1147.9 1184.5 1207.9 1227.3 10935.2 10963.3 17230.3 17587.1 17601.6 38927.8 39422.4 39684.7 40325.6 41787.0 51006.0 51046.0 55163.0 56788.0 59333.0 12471.5 13332.9 13337.1 13367.8 13428.6 9444.7 14524.2 14669.0 14699.6 14927.3 8435.3 8555.1 8721.2 8994.7 9058.5 8462.4 8595.1 8702.8 8779.9 8894.0 8798.6 8832.2 8862.9 8989.5 9204.0 12993.5 13028.9 13427.4 13485.0 13560.7 12922.2 13074.3 13092.3 13171.3 13186.9 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#3] mootools.html Cycles:180 Average:5601.47 Median:5115.88 stddev:3063.51 (59.9%) stddev-sans-first:3055.95 04:20:45 INFO - PROCESS | 22393 | Values: 1416.2 1563.7 1588.6 1800.8 1933.3 8038.9 8237.3 8247.5 8252.5 8256.4 8057.8 8222.3 8227.3 8230.7 8233.9 2345.1 2357.0 2365.9 2368.5 2368.6 2401.8 2423.2 2446.4 2460.7 2461.3 2350.3 2353.1 2366.3 2398.2 2401.2 2362.0 2396.1 2398.1 2404.6 2407.1 2356.1 2409.3 2423.7 2425.1 2426.2 7180.4 7894.1 8333.4 8385.5 8387.6 5012.0 5113.7 5114.9 5116.9 5144.9 3314.9 3333.4 3346.2 3425.9 3462.0 1174.0 1185.9 1191.9 1199.7 1201.5 11462.3 11841.3 11898.3 11902.0 11917.9 4670.7 4696.9 4707.3 4759.1 4761.0 10205.0 10205.5 10208.9 10217.2 10218.6 5318.3 5332.1 5333.1 5336.0 5338.8 4836.6 4851.8 4858.4 4868.6 4869.6 3748.9 3935.5 3951.6 3959.0 3979.9 1213.2 1223.2 1224.8 1229.0 1238.2 908.6 981.5 1034.5 1050.6 1054.7 5894.7 5901.9 5905.1 5944.7 6071.8 472.8 473.6 475.4 492.7 493.8 3546.6 3969.2 4036.7 4056.3 4099.5 9711.3 9863.3 10008.4 10013.0 10027.9 9658.5 9839.5 9863.9 9869.1 9894.4 7752.8 7891.6 7894.3 7972.1 7976.6 5662.7 5888.4 5901.6 5962.4 6034.9 9229.8 9260.7 9386.1 9389.8 9582.0 9400.4 9498.1 9507.9 9604.3 9660.7 7245.4 7300.2 7351.2 7358.6 7378.1 8092.9 8123.8 8203.6 8221.7 8238.8 7539.9 7585.6 7612.6 7625.2 7678.7 7523.1 7536.6 7548.2 7631.6 7639.8 6825.5 6862.1 6870.8 7048.4 7054.3 5040.7 5094.3 5147.2 5250.6 5279.4 5160.6 5220.4 5247.4 5285.6 5351.1 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#4] prototype.html Cycles:180 Average:5408.46 Median:6206.05 stddev:1632.32 (26.3%) stddev-sans-first:1592.19 04:20:45 INFO - PROCESS | 22393 | Values: 353.3 356.5 358.4 366.4 368.6 5966.6 6115.8 6116.4 6119.2 6138.1 6136.7 6170.8 6172.4 6179.2 6181.8 4707.6 4742.8 4745.8 4750.3 4750.5 4542.7 4589.8 4670.0 4737.8 4739.6 4630.8 4631.1 4632.1 4634.9 4646.0 4681.2 4685.4 4690.0 4690.9 4699.3 4119.9 4125.0 4127.8 4133.8 4141.9 5830.0 5834.6 5840.8 5840.8 5865.2 5432.2 5436.5 5437.3 5437.4 5449.7 6150.8 6343.5 6344.0 6413.3 6419.5 4485.8 4486.9 4487.5 4492.6 4496.5 6622.1 6691.2 6693.8 6697.6 6703.3 4490.6 4503.0 4505.8 4505.9 4510.3 4562.8 4570.0 4571.1 4572.9 4574.1 5211.6 5320.7 5331.7 5336.8 5346.7 6435.5 6450.8 6453.0 6454.3 6455.0 1552.1 1580.7 1583.3 1596.3 1632.4 1044.5 1069.4 1070.0 1093.8 1098.4 6230.3 6378.0 6389.5 6405.2 6410.8 6604.2 6605.2 6606.0 6607.0 6621.6 6276.8 6278.6 6286.7 6295.9 6305.0 3537.0 3569.8 3573.7 3573.8 3574.7 6718.0 6910.1 6919.6 6923.1 6928.8 6686.2 6706.0 6710.0 6714.3 6719.3 6827.6 6900.8 6902.7 6903.0 6906.4 6592.8 6593.8 6600.4 6617.9 6618.9 6386.3 6532.0 6537.4 6555.2 6564.8 6997.3 7017.7 7022.8 7034.8 7035.6 4543.4 4591.4 4597.1 4600.0 4607.6 6433.3 6715.8 6725.2 6725.5 6729.2 6349.0 6404.7 6455.3 6537.3 6542.0 6478.9 6493.8 6501.9 6523.4 6525.0 6431.6 6432.8 6435.8 6436.8 6441.4 6344.6 6566.4 6580.7 6582.6 6582.6 6298.2 6329.2 6330.6 6331.6 6341.0 04:20:45 INFO - PROCESS | 22393 | 04:20:45 INFO - PROCESS | 22393 | [#5] yui.html Cycles:180 Average:15671.26 Median:24886.99 stddev:17786.40 (71.5%) stddev-sans-first:17801.13 04:20:45 INFO - PROCESS | 22393 | Values: 778.9 796.9 910.6 932.1 932.5 14407.9 15448.0 15672.5 15694.2 15695.0 12557.8 16012.8 16179.9 16222.8 16250.3 770.4 914.4 915.5 939.4 940.8 873.9 921.8 927.1 928.6 928.7 922.6 976.4 980.5 980.8 981.6 804.0 812.2 923.0 956.4 972.7 683.2 694.0 709.8 715.1 715.9 15001.4 15056.4 15105.7 15147.3 15225.0 14606.0 14683.3 14691.4 14868.2 14927.6 10951.9 11048.4 11093.2 11171.4 11287.0 3968.7 4089.9 4135.4 4141.0 4144.2 56967.7 56980.7 57149.7 57355.0 57460.4 11748.4 11992.6 12030.2 12103.0 12279.7 21654.6 21656.5 21720.0 21727.5 21737.3 8856.5 9040.4 9121.1 9251.4 9254.1 4768.2 4846.4 4957.1 5113.7 5138.5 3611.5 3657.3 3662.2 3662.6 3667.7 604.9 619.6 625.7 636.8 641.1 768.0 802.7 820.6 831.3 839.0 9685.9 10139.6 10141.4 10197.5 10247.4 803.4 809.2 816.2 827.4 834.9 4536.4 4770.0 4847.8 4854.5 4855.9 62443.0 63555.7 63637.4 63672.7 63685.4 54994.7 56250.0 56931.4 56986.0 58319.7 51084.7 51613.0 52017.0 52429.7 53477.7 8975.5 9400.6 9401.4 9561.8 9616.5 38146.6 38614.0 38792.6 39158.0 39625.2 44409.1 45237.5 48743.0 49497.5 49749.3 11423.1 12274.3 12287.8 12712.9 13016.3 14018.4 14075.6 14571.2 14973.1 14978.6 12199.0 12440.3 12700.6 13745.4 14593.6 12440.4 12695.6 13321.2 13455.0 13890.4 12332.6 12763.4 13826.9 14461.6 14639.4 10997.6 11137.5 11177.7 11284.2 11589.5 11000.1 11286.9 11293.3 11327.5 11415.8 04:20:45 INFO - PROCESS | 22393 | -------- Summary: end -------- 04:20:45 INFO - PROCESS | 22393 | 04:20:46 INFO - TEST-INFO | 22393: exit 0 04:20:46 INFO - TEST-OK | dromaeo_css | took 1110727ms 04:20:46 INFO - TEST-START | kraken 04:20:46 INFO - operating with platform_type : linux_ 04:20:46 INFO - Initialising browser for kraken test... 04:20:46 INFO - TEST-INFO | started process 22587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppfIHqd/profile http://localhost:44254/getInfo.html) 04:20:50 INFO - PROCESS | 22587 | __metrics Screen width/height:1600/1200 04:20:50 INFO - PROCESS | 22587 | colorDepth:24 04:20:50 INFO - PROCESS | 22587 | Browser inner width/height: 1024/697 04:20:50 INFO - PROCESS | 22587 | __metrics 04:20:51 INFO - PROCESS | 22587 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:20:51 ERROR - PROCESS | 22587 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:52 INFO - TEST-INFO | 22587: exit 0 04:20:52 INFO - Browser initialized. 04:20:52 INFO - Running cycle 1/1 for kraken test... 04:20:52 INFO - TEST-INFO | started process 22675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppfIHqd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:04 INFO - PROCESS | 22675 | RSS: Main: 139292672 04:21:04 INFO - PROCESS | 22675 | 04:21:06 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44254/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:07 INFO - PROCESS | 22675 | RSS: Main: 196907008 04:21:07 INFO - PROCESS | 22675 | 04:21:10 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44254/tests/kraken/driver.html?testName=audio-dft) 04:21:10 INFO - PROCESS | 22675 | RSS: Main: 183840768 04:21:10 INFO - PROCESS | 22675 | 04:21:13 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44254/tests/kraken/driver.html?testName=audio-fft) 04:21:14 INFO - PROCESS | 22675 | RSS: Main: 273215488 04:21:14 INFO - PROCESS | 22675 | 04:21:16 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44254/tests/kraken/driver.html?testName=audio-oscillator) 04:21:16 INFO - PROCESS | 22675 | RSS: Main: 179384320 04:21:16 INFO - PROCESS | 22675 | 04:21:18 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:19 INFO - PROCESS | 22675 | RSS: Main: 177684480 04:21:19 INFO - PROCESS | 22675 | 04:21:22 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44254/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:22 INFO - PROCESS | 22675 | RSS: Main: 212705280 04:21:22 INFO - PROCESS | 22675 | 04:21:26 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44254/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:26 INFO - PROCESS | 22675 | RSS: Main: 212865024 04:21:26 INFO - PROCESS | 22675 | 04:21:29 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44254/tests/kraken/driver.html?testName=json-parse-financial) 04:21:30 INFO - PROCESS | 22675 | RSS: Main: 212623360 04:21:30 INFO - PROCESS | 22675 | 04:21:31 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:32 INFO - PROCESS | 22675 | RSS: Main: 193282048 04:21:32 INFO - PROCESS | 22675 | 04:21:33 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:34 INFO - PROCESS | 22675 | RSS: Main: 197103616 04:21:34 INFO - PROCESS | 22675 | 04:21:36 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:37 INFO - PROCESS | 22675 | RSS: Main: 210051072 04:21:37 INFO - PROCESS | 22675 | 04:21:39 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:40 INFO - PROCESS | 22675 | RSS: Main: 218718208 04:21:40 INFO - PROCESS | 22675 | 04:21:42 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:43 INFO - PROCESS | 22675 | RSS: Main: 215814144 04:21:43 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:44254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44254/tests/kraken/driver.html?testName=ai-astar) 04:21:45 INFO - PROCESS | 22675 | RSS: Main: 276385792 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | __start_tp_report 04:21:45 INFO - PROCESS | 22675 | _x_x_mozilla_page_load 04:21:45 INFO - PROCESS | 22675 | _x_x_mozilla_page_load_details 04:21:45 INFO - PROCESS | 22675 | |i|pagename|runs| 04:21:45 INFO - PROCESS | 22675 | |0;ai-astar;112;112;111;112;112;113;107;112;111;110 04:21:45 INFO - PROCESS | 22675 | |1;audio-beat-detection;156;126;156;180;126;152;159;128;182;131 04:21:45 INFO - PROCESS | 22675 | |2;audio-dft;162;161;160;162;160;160;170;164;162;160 04:21:45 INFO - PROCESS | 22675 | |3;audio-fft;73;73;75;168;76;75;76;76;160;77 04:21:45 INFO - PROCESS | 22675 | |4;audio-oscillator;91;92;156;93;92;92;143;92;93;150 04:21:45 INFO - PROCESS | 22675 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;122;117;116 04:21:45 INFO - PROCESS | 22675 | |6;imaging-darkroom;145;145;145;144;145;145;145;147;145;146 04:21:45 INFO - PROCESS | 22675 | |7;imaging-desaturate;95;94;95;94;94;94;95;94;94;94 04:21:45 INFO - PROCESS | 22675 | |8;json-parse-financial;53;53;54;53;54;59;55;75;53;51 04:21:45 INFO - PROCESS | 22675 | |9;json-stringify-tinderbox;57;58;58;58;58;57;58;57;58;58 04:21:45 INFO - PROCESS | 22675 | |10;stanford-crypto-aes;72;72;72;73;74;75;74;76;73;81 04:21:45 INFO - PROCESS | 22675 | |11;stanford-crypto-ccm;115;114;122;124;117;120;112;113;134;121 04:21:45 INFO - PROCESS | 22675 | |12;stanford-crypto-pbkdf2;160;160;163;162;162;161;163;160;158;161 04:21:45 INFO - PROCESS | 22675 | |13;stanford-crypto-sha256-iterative;66;73;65;67;69;67;67;67;64;65 04:21:45 INFO - PROCESS | 22675 | __end_tp_report 04:21:45 INFO - PROCESS | 22675 | __start_cc_report 04:21:45 INFO - PROCESS | 22675 | _x_x_mozilla_cycle_collect,1589 04:21:45 INFO - PROCESS | 22675 | __end_cc_report 04:21:45 INFO - PROCESS | 22675 | __startTimestamp1469618505486__endTimestamp 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | ------- Summary: start ------- 04:21:45 INFO - PROCESS | 22675 | Number of tests: 14 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.69 (1.5%) stddev-sans-first:1.76 04:21:45 INFO - PROCESS | 22675 | Values: 112.0 112.0 111.0 112.0 112.0 113.0 107.0 112.0 111.0 110.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:21.28 (13.6%) stddev-sans-first:22.45 04:21:45 INFO - PROCESS | 22675 | Values: 156.0 126.0 156.0 180.0 126.0 152.0 159.0 128.0 182.0 131.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:3.07 (1.9%) stddev-sans-first:3.26 04:21:45 INFO - PROCESS | 22675 | Values: 162.0 161.0 160.0 162.0 160.0 160.0 170.0 164.0 162.0 160.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:37.54 (49.7%) stddev-sans-first:39.12 04:21:45 INFO - PROCESS | 22675 | Values: 73.0 73.0 75.0 168.0 76.0 75.0 76.0 76.0 160.0 77.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:27.96 (30.4%) stddev-sans-first:28.85 04:21:45 INFO - PROCESS | 22675 | Values: 91.0 92.0 156.0 93.0 92.0 92.0 143.0 92.0 93.0 150.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:1.79 (1.5%) stddev-sans-first:1.86 04:21:45 INFO - PROCESS | 22675 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 122.0 117.0 116.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:21:45 INFO - PROCESS | 22675 | Values: 145.0 145.0 145.0 144.0 145.0 145.0 145.0 147.0 145.0 146.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:21:45 INFO - PROCESS | 22675 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:6.99 (12.9%) stddev-sans-first:7.33 04:21:45 INFO - PROCESS | 22675 | Values: 53.0 53.0 54.0 53.0 54.0 59.0 55.0 75.0 53.0 51.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:21:45 INFO - PROCESS | 22675 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 58.0 57.0 58.0 58.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.74 (3.7%) stddev-sans-first:2.79 04:21:45 INFO - PROCESS | 22675 | Values: 72.0 72.0 72.0 73.0 74.0 75.0 74.0 76.0 73.0 81.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.50 stddev:6.61 (5.5%) stddev-sans-first:6.84 04:21:45 INFO - PROCESS | 22675 | Values: 115.0 114.0 122.0 124.0 117.0 120.0 112.0 113.0 134.0 121.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:1.56 (1.0%) stddev-sans-first:1.62 04:21:45 INFO - PROCESS | 22675 | Values: 160.0 160.0 163.0 162.0 162.0 161.0 163.0 160.0 158.0 161.0 04:21:45 INFO - PROCESS | 22675 | 04:21:45 INFO - PROCESS | 22675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.54 (3.8%) stddev-sans-first:2.67 04:21:45 INFO - PROCESS | 22675 | Values: 66.0 73.0 65.0 67.0 69.0 67.0 67.0 67.0 64.0 65.0 04:21:45 INFO - PROCESS | 22675 | -------- Summary: end -------- 04:21:45 INFO - PROCESS | 22675 | 04:21:46 INFO - TEST-INFO | 22675: exit 0 04:21:46 INFO - TEST-OK | kraken | took 59819ms 04:21:46 INFO - SUITE-END | took 1170s 04:21:46 INFO - Completed test suite (00:19:30) 04:21:46 INFO - javascript benchmark 04:21:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.6468288488263, 3289.2270316475624, 3294.752893532984, 3308.4044871923043, 3328.134684981904, 5280.1815718563685, 5315.14957606783, 5320.547753440953, 5321.4412486688925, 5339.492748188921, 5328.040952628526, 5330.440303768097, 5333.4399888011785, 5334.279872217249, 5334.786608535664, 4861.562459378664, 4889.119958407486, 4907.656464047518, 4923.310736496894, 4983.975080124595, 4903.9754801225945, 4922.901541969159, 4971.726555039471, 4988.127077761395, 5041.3194218780545, 4994.0, 5056.19100943849, 5061.620378471611, 5076.162433198518, 5109.310243117169, 4977.104121258172, 4983.576396006344, 5011.323471331379, 5044.520770526794, 5046.873828154289, 4816.084943860656, 4866.562009419134, 4956.776945037482, 4967.751612419364, 4974.602031837444, 5294.629375943686, 5302.814401495968, 5313.707746073965, 5335.6798592084215, 5340.198970154469, 5660.688662123582, 5779.508741756914, 5786.826395208151, 5818.8254352369495, 5825.0, 5658.886822263532, 5728.312602487728, 5746.712664366765, 5779.682117483537, 5789.044807606782, 5446.782128714846, 5475.753591088411, 5475.890482190373, 5476.479734425223, 5477.123660214386, 5743.10981797822, 5890.263717035371, 5926.496247818897, 5935.376785437553, 5949.762009519657, 5674.4892959633835, 5676.0, 5684.403137670485, 5690.800821971211, 5717.542596592262, 5756.65460072397, 5759.049756790167, 5770.451807078321, 5773.364929857712, 5775.48020678141, 5585.720713964367, 5630.042892708249, 5691.9146212806845, 5722.084466485342, 5726.885462290731, 5781.075027995501, 5782.5663075268685, 5786.479216870502, 5792.420757924174, 5797.072468405119, 4456.286994080931, 4486.7083639563325, 4492.797824097858, 4496.258117410591, 4500.122476117192, 3895.668868146183, 3966.6231707987695, 4013.0, 4024.71826972115, 4047.4535937648043, 5542.944570554324, 5583.664980101207, 5591.0, 5606.383297837235, 5640.689762063126, 5665.943340566541, 5841.561882858802, 5844.912326315109, 5849.327327357323, 5853.414658534112, 5482.5613950883835, 5533.142362933751, 5566.415526369754, 5587.469190426903, 5595.272614560081, 5030.119729047476, 5040.7731652075745, 5058.215976523645, 5066.417362003417, 5089.083964886282, 5838.766449341979, 6033.3664965178905, 6034.758609655652, 6044.576879618385, 6045.274567051982, 5728.226689396878, 5811.0, 5814.5639077068545, 5817.040188368872, 5832.154337621106, 6002.069679199731, 6017.127516510169, 6019.909701354396, 6023.5181185505935, 6031.336552979256, 5530.97234513841, 5578.776848925998, 5664.773409063756, 5698.430156984268, 5704.80033198836, 5707.172459993195, 5708.457696518824, 5739.655620662774, 5745.626534275259, 5798.739056742541, 5581.0, 5592.692401917933, 5615.410381910004, 5616.1856530803625, 5620.831375058755, 5534.667919924817, 5594.4964953152785, 5619.409961953936, 5625.21247025425, 5646.632968857176, 5586.972065139648, 5588.720563971704, 5593.608447408805, 5593.776248949996, 5613.859653508695, 5697.971510142588, 5717.885642287214, 5720.513756330759, 5724.141378793214, 5728.914066288926, 5405.108157154183, 5425.728713564385, 5562.3047119110115, 5602.243697100839, 5607.607467477401], "value": 5346.717345824551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.8478038100284, 658.8616390557983, 669.6885948034164, 673.1047706550289, 735.8307589254468, 32911.341773164524, 33436.0, 33444.331113377746, 39999.0, 40911.59088409115, 43603.78198109005, 43944.0, 43946.78026609871, 44094.33858492125, 44112.0, 8856.158664926837, 8991.550422478882, 9003.96454407745, 9033.954830225839, 9036.45781253127, 8374.28818550424, 10719.35683858967, 11014.173936954721, 11022.669319920415, 11029.0, 10603.893961060407, 10624.575016999312, 10671.78656426871, 10694.51874665638, 10694.732631684192, 10561.260711750143, 10638.414887181201, 10640.893591064068, 10648.094911932494, 10650.988156125195, 10386.221033422447, 10480.213983951235, 10490.527926243338, 10502.369857808479, 10506.001929816655, 41059.38410923839, 41343.379849301986, 41425.0, 41508.37737433941, 41579.58420415787, 3774.9811250943844, 3791.184895247535, 3856.6529012388737, 3880.0881792778673, 4250.234957707611, 33028.1742956428, 34158.0, 34345.31309373824, 34506.96479105631, 34517.654823451696, 4270.145970805851, 4312.978435107836, 4324.632406245441, 4350.956490435086, 4486.641068714495, 326576.0, 327677.0, 327885.0, 327936.9999999976, 328205.0, 62155.378446214956, 62750.37249627445, 62975.37024629695, 63013.68493157597, 63055.6847215761, 71094.0, 72660.0, 72862.35688215568, 72932.63533682298, 72966.63516682382, 17681.292748289925, 17726.20232089559, 17752.20115094824, 17788.46634600964, 17799.377021804175, 13938.37277322523, 14374.35315410809, 14549.709005819825, 14770.926145369205, 15165.848341516665, 20025.799742002393, 20055.197792088446, 20174.29389971344, 20225.190992360436, 20328.186872525228, 7257.564546127249, 7385.150707668579, 7411.703531858773, 7559.773206803805, 7626.36890272855, 1105.6627728542871, 1117.8211486162174, 1130.496928866663, 1153.5278810779614, 1203.6819682447706, 32865.0, 32979.67020329814, 33233.3353332932, 33749.49375759366, 34135.48796768051, 1237.6101528018646, 1238.578883179723, 1240.9379531023412, 1292.1923797626484, 1298.8116723075102, 17144.314227430765, 17622.207000685, 17628.823711762976, 17774.0, 17786.0, 512862.0, 518329.0, 518491.0, 519022.0, 519463.0, 61498.0, 63013.68493157505, 63118.0, 63196.684016579624, 63229.68385158045, 1344.865513448667, 1411.9223442710545, 1446.7323545144181, 1561.7266978278756, 1622.618684609116, 31847.522287166175, 32175.51736723904, 33039.50440743343, 33253.0, 33362.0, 50368.74815625898, 59493.10760338512, 61439.38560614337, 61486.69256653688, 61586.69206653938, 446248.0, 453868.0, 454435.0, 454757.0, 457929.0, 43265.13469730651, 46306.30540541827, 47919.0, 47968.0, 49072.50927490679, 44455.77772111119, 44483.0, 45073.54926450693, 45364.54635453735, 45473.0, 37180.25639487249, 38388.61611383851, 38634.806825965694, 38930.6106938927, 39284.017899551596, 37898.0, 45931.54068459273, 47240.7637961808, 47256.52743472659, 47712.761436192595, 43651.345229820945, 44468.55531444774, 44577.0, 44790.0, 45238.547614523435, 42862.14275714406, 43858.71072546466, 45655.543444565126, 45721.0, 47206.291905620754, 34298.31403371968, 34793.304133917685, 34864.825675871456, 35207.295854082266, 35635.46546801748], "value": 21789.807355543242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.321612028814, 430.5135197227133, 435.9258925982583, 437.07558513743425, 442.70781284352313, 18244.81755182448, 18557.16492757826, 18684.01535099727, 19050.237990480382, 19080.33218837341, 18213.27146914122, 18301.542461438472, 18603.81396186038, 18891.338803141894, 18919.0, 4874.366332376786, 5225.973870130653, 5377.085895397791, 5816.709164541777, 5845.766169353221, 5798.217240672498, 5815.156802263669, 5828.795992140276, 5842.0652695568715, 5847.970760146193, 5265.552428043621, 5329.946700532983, 5333.120035194188, 5782.653040817543, 5792.102224155263, 4805.639577031737, 4807.519248075165, 4825.879353016167, 4851.248056551241, 4996.999999999982, 4694.57748802606, 4710.081534100852, 4734.95265047352, 4737.28940658904, 4744.264638980963, 13295.468181272738, 13919.23444210568, 22467.662985055238, 23286.301410957698, 23287.88356058209, 2438.1710218525786, 2499.6125600531946, 2526.9620955685677, 2542.072143667548, 2581.0, 10368.79262414755, 10828.079613232805, 10974.286671366415, 14249.786253206106, 14398.640033999129, 1971.9507012324664, 2002.5994801039706, 2014.3369888346456, 2030.46192758919, 2091.069082616569, 76156.61921690356, 79138.8129178057, 79991.20008799895, 82415.0, 82415.17584824134, 11031.0, 11180.888191118147, 11230.15773816967, 11252.099832013419, 11296.209265351346, 15915.363385464683, 16119.838801612068, 16126.838731612768, 16139.193040347936, 16157.353705851634, 8788.0, 8992.370534062684, 9028.8645670315, 9085.50029748357, 9150.084991500797, 8779.868301975348, 8917.509536975398, 8944.552772361356, 9016.909830901739, 9018.86471702925, 4681.227597446383, 4720.504347043511, 4983.152864013126, 4987.551120399109, 4993.875153121201, 1995.600879824012, 2024.8076432738867, 2053.7638171610156, 2063.938081857547, 2105.842061845368, 1009.0817356205818, 1058.5342449322275, 1065.0787069185253, 1091.9672409827717, 1108.2740804772886, 18208.0, 18337.816621833877, 18429.26282948667, 18663.253469861324, 19187.232510699694, 1065.4672663668166, 1070.4915165296422, 1081.0, 1100.14738577603, 1103.2553026706942, 10575.259731818698, 11125.833112503318, 11149.108071354434, 11223.887761122447, 11228.382438965935, 498100.0, 502473.7949684322, 511441.0, 514644.0, 526158.0, 58814.705926470095, 96668.0, 97500.0, 98644.0, 99600.0, 1137.5677242647741, 1147.8565179352747, 1184.4729095552568, 1207.927524348542, 1227.2636418149038, 10935.17986151026, 10963.284189069549, 17230.310787568356, 17587.120643967493, 17601.559961001076, 38927.80536097301, 39422.40866386949, 39684.70231518805, 40325.596744033355, 41787.0, 51006.0, 51046.0, 55163.0, 56788.0, 59333.0, 12471.501139954664, 13332.93333533326, 13337.133086349357, 13367.799483007957, 13428.597142085753, 9444.716658500256, 14524.20116893581, 14669.046511976687, 14699.632509187355, 14927.253637317874, 8435.32517398619, 8555.144485551395, 8721.215090641872, 8994.685186018458, 9058.547072646474, 8462.407631465738, 8595.09751476111, 8702.825943480968, 8779.868301975348, 8893.955530222567, 8798.648054077765, 8832.160944710242, 8862.867056994279, 8989.46063236208, 9204.0, 12993.48026078984, 13028.934855325662, 13427.395767190304, 13485.0, 13560.728785424039, 12922.160059596095, 13074.28091454979, 13092.345382731015, 13171.275579842817, 13186.868131318564], "value": 9305.758396054413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.2140012293173, 1563.710713517999, 1588.618731504439, 1800.8199180081992, 1933.2653591635167, 8038.919610803898, 8237.258646721793, 8247.54638494884, 8252.463589866662, 8256.422050456471, 8057.798555036127, 8222.259996600305, 8227.341812654988, 8230.711925082624, 8233.91766082339, 2345.1323010486144, 2356.96464553031, 2365.8698771567556, 2368.455255291284, 2368.6210206366986, 2401.819863510235, 2423.1761201191593, 2446.376174075608, 2460.6801115854914, 2461.2862269941784, 2350.2949115265437, 2353.1175809071597, 2366.2782851230368, 2398.1606437746823, 2401.1955994741784, 2362.043372434167, 2396.101461951768, 2398.0647547456506, 2404.63930410439, 2407.07327678844, 2356.081128359941, 2409.3013026222548, 2423.7333893271725, 2425.0784701813373, 2426.1751004658327, 7180.353768160839, 7894.131645518988, 8333.374996875198, 8385.538795366314, 8387.580620968927, 5011.974940125312, 5113.667611605234, 5114.897702045975, 5116.872078198075, 5144.897102057937, 3314.8839790607212, 3333.4333163362285, 3346.2303670156, 3425.9143521411916, 3461.9826900865587, 1173.9941300293528, 1185.9347735874524, 1191.8927296543266, 1199.7000749812546, 1201.516127582435, 11462.254953428084, 11841.289522628584, 11898.28610283377, 11902.0, 11917.940410297893, 4670.696404733681, 4696.906061878812, 4707.317438971399, 4759.0719809636785, 4760.952390476051, 10205.0, 10205.489725513695, 10208.948955255177, 10217.18262538995, 10218.591256349811, 5318.308619879468, 5332.066888294533, 5333.1466965286145, 5335.973320133452, 5338.813141540028, 4836.637252206098, 4851.757412129379, 4858.416989961227, 4868.610511159099, 4869.610431165498, 3748.887533374003, 3935.4687117238805, 3951.565327813938, 3958.960410395917, 3979.8607048753156, 1213.1568559850818, 1223.1621339382552, 1224.7856625090574, 1228.956986505468, 1238.2013601227338, 908.5820522559565, 981.5239608789731, 1034.5396298647029, 1050.6270274052754, 1054.7099547624464, 5894.67579283135, 5901.881962360729, 5905.055191169392, 5944.7324870380935, 6071.817845464643, 472.75416783272505, 473.56432082484196, 475.38912497440623, 492.72161228905554, 493.82222399935995, 3546.5921419036627, 3969.186316805048, 4036.656884164879, 4056.3307054335705, 4099.528554216244, 9711.27165462593, 9863.30956833029, 10008.44953527563, 10013.048760367754, 10027.899721002843, 9658.517074146264, 9839.508024598741, 9863.901360986298, 9869.062439068277, 9894.356866803635, 7752.806179845549, 7891.565963872042, 7894.250046245597, 7972.123066462568, 7976.641051152712, 5662.66024038559, 5888.381719919346, 5901.557383196192, 5962.37395073511, 6034.879302414015, 9229.815403692022, 9260.675876344296, 9386.06139386056, 9389.765255868659, 9581.952090239503, 9400.435973841591, 9498.09768072032, 9507.857382139135, 9604.27967902396, 9660.729728513934, 7245.38414234796, 7300.233475484997, 7351.228121047213, 7358.595277259802, 7378.114626244885, 8092.87860682102, 8123.837523249384, 8203.630836612487, 8221.671133154607, 8238.752837414888, 7539.924600753922, 7585.620718963919, 7612.58130802789, 7625.161232264558, 7678.6544605494, 7523.1348394935285, 7536.585487798224, 7548.207438219128, 7631.580263085583, 7639.847203056019, 6825.488088393291, 6862.073620061427, 6870.828229294308, 7048.436125109876, 7054.25930277334, 5040.7479626019285, 5094.286799848099, 5147.202183661539, 5250.553702935141, 5279.39286982002, 5160.587153027674, 5220.3735551734035, 5247.370315562004, 5285.550728187994, 5351.117065684119], "value": 4491.783555577262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.33043881843906, 356.45284488310443, 358.3835802419838, 366.44117720476254, 368.60927416938046, 5966.612170208944, 6115.816525504237, 6116.357782432848, 6119.2350956130485, 6138.109974053759, 6136.662483563402, 6170.796694644535, 6172.351903050182, 6179.196704428429, 6181.783637572686, 4707.599854012413, 4742.786574604151, 4745.786439610226, 4750.287456881478, 4750.524947505239, 4542.727436353813, 4589.79345929434, 4670.0, 4737.786799594027, 4739.597134243593, 4630.8147674093, 4631.120087183441, 4632.14305353509, 4634.930476042862, 4645.9767701161445, 4681.204195286809, 4685.4377474702915, 4690.0, 4690.929636055462, 4699.318598803155, 4119.8970025749295, 4124.9587504124875, 4127.7936103195025, 4133.834646614132, 4141.855035073788, 5829.970850145764, 5834.562407819388, 5840.766369345221, 5840.824775256707, 5865.178874957509, 5432.2123292122815, 5436.510714035756, 5437.32033495813, 5437.401885792559, 5449.6730196188355, 6150.753969841246, 6343.462614954009, 6344.0, 6413.326600706905, 6419.454346380563, 4485.753283569403, 4486.8878278042985, 4487.483939346984, 4492.595666390008, 4496.4829044659955, 6622.139121914121, 6691.1636045494315, 6693.832654183636, 6697.598144111369, 6703.262641109474, 4490.595846373842, 4502.977485112619, 4505.842295519641, 4505.909881802346, 4510.300903359985, 4562.794674239667, 4569.977150114295, 4571.108633816374, 4572.9314060289125, 4574.108048930427, 5211.557017653466, 5320.733963301819, 5331.653442526223, 5336.839894803162, 5346.679199247979, 6435.452986496107, 6450.8064758057335, 6452.9677351612945, 6454.290028096905, 6455.0317452382515, 1552.0765144738862, 1580.7233734096717, 1583.263782341217, 1596.3375199292395, 1632.4449687106442, 1044.472541366605, 1069.3637285814928, 1069.9572017119228, 1093.824988001916, 1098.4452851310036, 6230.314665386803, 6378.0, 6389.488840892717, 6405.19935008124, 6410.807675769641, 6604.240512341143, 6605.207375115017, 6605.966970165118, 6606.966965165239, 6621.602703837785, 6276.843078923063, 6278.560500764903, 6286.717097730613, 6295.874082518324, 6305.0, 3537.0273174877116, 3569.839357228931, 3573.7498375114014, 3573.8213089345427, 3574.7140228781636, 6718.0, 6910.067140935909, 6919.619420931796, 6923.099997000459, 6928.792136235921, 6686.1642294713165, 6705.994100884906, 6709.966450167718, 6714.254293883528, 6719.328067193339, 6827.6244806536115, 6900.7929762107215, 6902.723891044402, 6903.0335752993615, 6906.412954898789, 6592.76925307612, 6593.835154121185, 6600.372964568358, 6617.867642647024, 6618.867622647616, 6386.265579458422, 6531.967340163269, 6537.378948999837, 6555.180602424697, 6564.8358791030605, 6997.26528714498, 7017.7192912282935, 7022.789316320519, 7034.753783617549, 7035.613041282779, 4543.409356783597, 4591.403117594691, 4597.149527337453, 4599.954000459952, 4607.562281583244, 6433.260175079926, 6715.764948226984, 6725.226598940989, 6725.4619630430425, 6729.192496900403, 6348.968255158695, 6404.679766011587, 6455.289918109098, 6537.313582073813, 6542.018697195268, 6478.935210647834, 6493.805185844432, 6501.902471463027, 6523.380278873499, 6525.0, 6431.649353635602, 6432.807015789534, 6435.806925792233, 6436.774712885027, 6441.355864413708, 6344.587601805868, 6566.376194261537, 6580.670966451754, 6582.572132811352, 6582.605043697394, 6298.212723409574, 6329.208848893888, 6330.556861019684, 6331.620102793847, 6341.048842673636], "value": 4879.626921635269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.9104253010905, 796.9203079692031, 910.5923313841896, 932.0586207929992, 932.4638332958547, 14407.855921440783, 15448.0, 15672.451464198755, 15694.21528923552, 15695.0, 12557.811632825515, 16012.759808602881, 16179.919100404511, 16222.756658650129, 16250.268737906794, 770.3606007014165, 914.4193437167413, 915.4919019943928, 939.375315415248, 940.7836197674538, 873.8645509945936, 921.8294615496121, 927.0729270729271, 928.5542939389097, 928.6842473558988, 922.5802259971697, 976.3507267666993, 980.5489474841581, 980.7744218829673, 981.6466072213997, 803.955782431966, 812.1959260332258, 922.9893266872764, 956.4118067388575, 972.6644307713827, 683.1597135523284, 694.0456871801273, 709.7515869445705, 715.1168307140678, 715.8568286342752, 15001.399944002227, 15056.397744090333, 15105.697886042328, 15147.318370673345, 15225.0, 14606.0, 14683.339249733788, 14691.412343506247, 14868.182249976247, 14927.552173434815, 10951.945240273748, 11048.37219983927, 11093.16801239902, 11171.441427928652, 11287.0, 3968.6912153744515, 4089.8568550100604, 4135.441715368417, 4141.047559061402, 4144.171165766858, 56967.715161424756, 56980.715096424254, 57149.71425142848, 57355.0, 57460.42539574592, 11748.412579370997, 11992.64022079339, 12030.15788894769, 12103.0, 12279.693007674701, 21654.566908661738, 21656.458588535414, 21720.0, 21727.456813579473, 21737.34787956364, 8856.468611883307, 9040.41237319572, 9121.087891210826, 9251.352405331561, 9254.12085851843, 4768.165571025057, 4846.36997190363, 4957.132501812241, 5113.693178409308, 5138.486151384832, 3611.530501034901, 3657.2868290683064, 3662.212624285791, 3662.5788034376387, 3667.74325797197, 604.9304330002018, 619.6096459230746, 625.7090452939404, 636.8376064103624, 641.1152609399093, 767.963249613018, 802.7391097893208, 820.6102101501739, 831.264331066998, 839.0141583639199, 9685.854712179324, 10139.64511242103, 10141.391516509033, 10197.54111064989, 10247.38515689061, 803.3733687723585, 809.1867672988609, 816.2286639126088, 827.4125370986667, 834.8580741273998, 4536.432945881765, 4770.0, 4847.830325938575, 4854.514548545118, 4855.927161092586, 62443.0, 63555.6822215886, 63637.36362636314, 63672.681636592446, 63685.36314636794, 54994.72502637461, 56250.0, 56931.43068569261, 56986.0, 58319.70840145857, 51084.744576276884, 51613.0, 52017.0, 52429.73785131126, 53477.73261133747, 8975.50634715097, 9400.623975041195, 9401.435913844918, 9561.760955976157, 9616.471094089613, 38146.618533814304, 38614.0, 38792.6120738789, 39158.0, 39625.20749584935, 44409.111817762816, 45237.54762452334, 48743.0, 49497.50502494929, 49749.25376119433, 11423.143264255381, 12274.324912129918, 12287.75424491523, 12712.936435318134, 13016.28410437435, 14018.439262429389, 14075.648108797363, 14571.198584077978, 14973.1016139032, 14978.550643480714, 12199.02407807391, 12440.25358478458, 12700.555480558136, 13745.38145783422, 14593.562193134223, 12440.37798110109, 12695.619131426072, 13321.200727956353, 13455.0, 13890.444382224598, 12332.568360107352, 12763.425645846144, 13826.86173138296, 14461.638459038188, 14639.41442342337, 10997.61508347204, 11137.498812553617, 11177.72055698614, 11284.21010529255, 11589.478473468545, 11000.114823745831, 11286.943565282449, 11293.289610493259, 11327.546898123983, 11415.771684566429], "value": 7242.635937158924, "unit": "score"}], "name": "dromaeo_css", "value": 7458.298521488787, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 107.0, 112.0, 111.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 156.0, 180.0, 126.0, 152.0, 159.0, 128.0, 182.0, 131.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 160.0, 160.0, 170.0, 164.0, 162.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 168.0, 76.0, 75.0, 76.0, 76.0, 160.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 156.0, 93.0, 92.0, 92.0, 143.0, 92.0, 93.0, 150.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 122.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 54.0, 59.0, 55.0, 75.0, 53.0, 51.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 74.0, 75.0, 74.0, 76.0, 73.0, 81.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 122.0, 124.0, 117.0, 120.0, 112.0, 113.0, 134.0, 121.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 163.0, 162.0, 162.0, 161.0, 163.0, 160.0, 158.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 65.0, 67.0, 69.0, 67.0, 67.0, 67.0, 64.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1516.9, "alertThreshold": 2.0}]} 04:21:46 INFO - Return code: 0 04:21:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:46 ERROR - # TBPL SUCCESS # 04:21:46 INFO - Running post-action listener: _resource_record_post_action 04:21:46 INFO - Running post-run listener: _resource_record_post_run 04:21:47 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 474886144; Read time: 24; Write time: 431064 04:21:47 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242413568; Read time: 0; Write time: 271220 04:21:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220729344; Read time: 8; Write time: 156636 04:21:47 INFO - Running post-run listener: _upload_blobber_files 04:21:47 INFO - Blob upload gear active. 04:21:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:49 INFO - (blobuploader) - INFO - Done attempting. 04:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:49 INFO - (blobuploader) - INFO - Done attempting. 04:21:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:49 INFO - Return code: 0 04:21:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/104916f28bb8b3b259e00cac0afd6ae02dcbee136f297227570105dec2a3732c4bc469fc826c66c2bd9b591d22158296e9bb4d6d951b890049b9bcb9a534a0be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79981dae2f3934e7deca8e5e19c89373ec6a9e06e08c0d1678cc892be4dc74d59e26e652e77ff71b2b84e8effd91261567217ed603bb38363dcf9c7ce8f88478"} 04:21:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:49 INFO - Contents: 04:21:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/104916f28bb8b3b259e00cac0afd6ae02dcbee136f297227570105dec2a3732c4bc469fc826c66c2bd9b591d22158296e9bb4d6d951b890049b9bcb9a534a0be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79981dae2f3934e7deca8e5e19c89373ec6a9e06e08c0d1678cc892be4dc74d59e26e652e77ff71b2b84e8effd91261567217ed603bb38363dcf9c7ce8f88478"} 04:21:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:49 INFO - Copying logs to upload dir... 04:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.116849 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-27 04:21:49.653219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:49.656614) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 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/104916f28bb8b3b259e00cac0afd6ae02dcbee136f297227570105dec2a3732c4bc469fc826c66c2bd9b591d22158296e9bb4d6d951b890049b9bcb9a534a0be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79981dae2f3934e7deca8e5e19c89373ec6a9e06e08c0d1678cc892be4dc74d59e26e652e77ff71b2b84e8effd91261567217ed603bb38363dcf9c7ce8f88478"} 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.011405 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/104916f28bb8b3b259e00cac0afd6ae02dcbee136f297227570105dec2a3732c4bc469fc826c66c2bd9b591d22158296e9bb4d6d951b890049b9bcb9a534a0be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79981dae2f3934e7deca8e5e19c89373ec6a9e06e08c0d1678cc892be4dc74d59e26e652e77ff71b2b84e8effd91261567217ed603bb38363dcf9c7ce8f88478"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:49.681576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:49.681869) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469617283.923925-230658790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:49.766623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:49.766926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:49.767220) ========= ========= Total master_lag: 0.18 =========