builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1469617286.79 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.791629) ========= 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:26.792068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.792380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.814239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.814627) ========= 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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-27 04:01:27 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.948449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.948801) ========= 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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016259 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.999260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:26.999627) ========= 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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:27,363 truncating revision to first 12 chars 2016-07-27 04:01:27,363 Setting DEBUG logging. 2016-07-27 04:01:27,363 attempt 1/10 2016-07-27 04:01:27,363 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:27,657 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:27.649557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:27.649875) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:27.653298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:27.653582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:27.663562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-27 04:01:27.663851) ========= /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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:28 INFO - MultiFileLogger online at 20160727 04:01:28 in /builds/slave/test 04:01:28 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:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:28 INFO - {'append_to_log': False, 04:01:28 INFO - 'base_work_dir': '/builds/slave/test', 04:01:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:01:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:28 INFO - 'branch': 'Mozilla-Beta', 04:01:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:28 INFO - 'config_files': ('talos/linux_config.py',), 04:01:28 INFO - 'default_actions': ('clobber', 04:01:28 INFO - 'read-buildbot-config', 04:01:28 INFO - 'download-and-extract', 04:01:28 INFO - 'populate-webroot', 04:01:28 INFO - 'create-virtualenv', 04:01:28 INFO - 'install', 04:01:28 INFO - 'run-tests'), 04:01:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:28 INFO - 'download_minidump_stackwalk': True, 04:01:28 INFO - 'download_symbols': 'ondemand', 04:01:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:28 INFO - 'installer_path': 'installer.exe', 04:01:28 INFO - 'log_level': 'info', 04:01:28 INFO - 'log_name': 'talos', 04:01:28 INFO - 'log_to_console': True, 04:01:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:28 INFO - 'opt_config_files': (), 04:01:28 INFO - 'pip_index': False, 04:01:28 INFO - 'sps_profile': False, 04:01:28 INFO - 'sps_profile_interval': 0, 04:01:28 INFO - 'suite': 'dromaeojs', 04:01:28 INFO - 'system_bits': '32', 04:01:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:28 INFO - 'title': 'talos-linux64-ix-043', 04:01:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:28 INFO - 'use_talos_json': True, 04:01:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:28 INFO - 'work_dir': 'build'} 04:01:28 INFO - ##### 04:01:28 INFO - ##### Running clobber step. 04:01:28 INFO - ##### 04:01:28 INFO - Running pre-action listener: _resource_record_pre_action 04:01:28 INFO - Running main action method: clobber 04:01:28 INFO - rmtree: /builds/slave/test/build 04:01:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:28 INFO - Running post-action listener: _resource_record_post_action 04:01:28 INFO - ##### 04:01:28 INFO - ##### Running read-buildbot-config step. 04:01:28 INFO - ##### 04:01:28 INFO - Running pre-action listener: _resource_record_pre_action 04:01:28 INFO - Running main action method: read_buildbot_config 04:01:28 INFO - Using buildbot properties: 04:01:28 INFO - { 04:01:28 INFO - "project": "", 04:01:28 INFO - "product": "firefox", 04:01:28 INFO - "script_repo_revision": "production", 04:01:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:01:28 INFO - "repository": "", 04:01:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:01:28 INFO - "buildid": "20160726073802", 04:01:28 INFO - "pgo_build": "True", 04:01:28 INFO - "basedir": "/builds/slave/test", 04:01:28 INFO - "buildnumber": 114, 04:01:28 INFO - "slavename": "talos-linux64-ix-043", 04:01:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:01:28 INFO - "platform": "ubuntu64_hw", 04:01:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:28 INFO - "branch": "mozilla-beta", 04:01:28 INFO - "repo_path": "releases/mozilla-beta", 04:01:28 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:28 INFO - "stage_platform": "linux64-pgo", 04:01:28 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:28 INFO - "slavebuilddir": "test" 04:01:28 INFO - } 04:01:28 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:28 INFO - Running post-action listener: _resource_record_post_action 04:01:28 INFO - ##### 04:01:28 INFO - ##### Running download-and-extract step. 04:01:28 INFO - ##### 04:01:28 INFO - Running pre-action listener: _resource_record_pre_action 04:01:28 INFO - Running main action method: download_and_extract 04:01:28 INFO - mkdir: /builds/slave/test/build/tests 04:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:28 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:28 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:29 INFO - Downloaded 1327 bytes. 04:01:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:29 INFO - Using the following test package requirements: 04:01:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'jsshell-linux-x86_64.zip'], 04:01:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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:30 INFO - Downloaded 24199952 bytes. 04:01:30 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:30 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:32 INFO - Return code: 0 04:01:32 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:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:32 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:32 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:32 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:32 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:32 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:33 INFO - Downloaded 24199952 bytes. 04:01:33 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:33 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:01:35 INFO - Downloaded 10840145 bytes. 04:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:01:35 INFO - Return code: 0 04:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:35 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:01:37 INFO - Downloaded 56024276 bytes. 04:01:37 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:37 INFO - mkdir: /builds/slave/test/properties 04:01:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:37 INFO - Contents: 04:01:37 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:39 INFO - Running post-action listener: _resource_record_post_action 04:01:39 INFO - Running post-action listener: set_extra_try_arguments 04:01:39 INFO - ##### 04:01:39 INFO - ##### Running populate-webroot step. 04:01:39 INFO - ##### 04:01:39 INFO - Running pre-action listener: _resource_record_pre_action 04:01:39 INFO - Running main action method: populate_webroot 04:01:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:39 INFO - '--tppagecycles', 04:01:39 INFO - '7'], 04:01:39 INFO - 'tests': ['tsvgm']}}, 04:01:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['damp', 'tps']}, 04:01:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['damp', 'tps']}, 04:01:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['dromaeo_dom']}, 04:01:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['tsvgx', 04:01:39 INFO - 'tsvgr_opacity', 04:01:39 INFO - 'tart', 04:01:39 INFO - 'tscrollx', 04:01:39 INFO - 'cart']}, 04:01:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:39 INFO - 'tsvgr_opacity', 04:01:39 INFO - 'tart', 04:01:39 INFO - 'tscrollx', 04:01:39 INFO - 'cart']}, 04:01:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--disable-e10s'], 04:01:39 INFO - 'tests': ['tp5o']}, 04:01:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['tp5o']}, 04:01:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--disable-e10s', 04:01:39 INFO - '--xperf_path', 04:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:39 INFO - 'tests': ['tp5n']}, 04:01:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--xperf_path', 04:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:39 INFO - 'tests': ['tp5n']}}, 04:01:39 INFO - 'talos.zip': {'path': '', 04:01:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:39 INFO - Running post-action listener: _resource_record_post_action 04:01:39 INFO - ##### 04:01:39 INFO - ##### Running create-virtualenv step. 04:01:39 INFO - ##### 04:01:39 INFO - Running pre-action listener: _resource_record_pre_action 04:01:39 INFO - Running main action method: create_virtualenv 04:01:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:39 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:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:39 INFO - Using real prefix '/usr' 04:01:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:42 INFO - Installing pip.................done. 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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', 'pip>=1.5'] 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 pip>=1.5 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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 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 - 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:42 INFO - Cleaning up... 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing psutil>=0.7.1 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', '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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 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 psutil>=0.7.1 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:44 INFO - Installing collected packages: psutil 04:01:44 INFO - Running setup.py install for psutil 04:01:44 INFO - building 'psutil._psutil_linux' extension 04:01:44 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:44 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:45 INFO - building 'psutil._psutil_posix' extension 04:01:45 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:45 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:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:45 INFO - Successfully installed psutil 04:01:45 INFO - Cleaning up... 04:01:45 INFO - Return code: 0 04:01:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:01:45 INFO - Using env: {'DISPLAY': ':0', 04:01:45 INFO - 'HOME': '/home/cltbld', 04:01:45 INFO - 'LANG': 'en_US.UTF-8', 04:01:45 INFO - 'LANGUAGE': 'en_US:en', 04:01:45 INFO - 'LOGNAME': 'cltbld', 04:01:45 INFO - 'MAIL': '/var/mail/cltbld', 04:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:45 INFO - 'MOZ_NO_REMOTE': '1', 04:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:45 INFO - 'NO_EM_RESTART': '1', 04:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:45 INFO - 'PWD': '/builds/slave/test', 04:01:45 INFO - 'SHELL': '/bin/bash', 04:01:45 INFO - 'SHLVL': '1', 04:01:45 INFO - 'TERM': 'linux', 04:01:45 INFO - 'TMOUT': '86400', 04:01:45 INFO - 'USER': 'cltbld', 04:01:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 04:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:45 INFO - '_': '/tools/buildbot/bin/python'} 04:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:47 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:47 INFO - Installing collected packages: mozsystemmonitor 04:01:47 INFO - Running setup.py install for mozsystemmonitor 04:01:47 INFO - Successfully installed mozsystemmonitor 04:01:47 INFO - Cleaning up... 04:01:47 INFO - Return code: 0 04:01:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 04:01:47 INFO - 'HOME': '/home/cltbld', 04:01:47 INFO - 'LANG': 'en_US.UTF-8', 04:01:47 INFO - 'LANGUAGE': 'en_US:en', 04:01:47 INFO - 'LOGNAME': 'cltbld', 04:01:47 INFO - 'MAIL': '/var/mail/cltbld', 04:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:47 INFO - 'MOZ_NO_REMOTE': '1', 04:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:47 INFO - 'NO_EM_RESTART': '1', 04:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:47 INFO - 'PWD': '/builds/slave/test', 04:01:47 INFO - 'SHELL': '/bin/bash', 04:01:47 INFO - 'SHLVL': '1', 04:01:47 INFO - 'TERM': 'linux', 04:01:47 INFO - 'TMOUT': '86400', 04:01:47 INFO - 'USER': 'cltbld', 04:01:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 04:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:47 INFO - '_': '/tools/buildbot/bin/python'} 04:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Downloading docopt-0.6.1.tar.gz 04:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:50 INFO - Running setup.py install for blobuploader 04:01:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:50 INFO - Running setup.py install for requests 04:01:51 INFO - Running setup.py install for docopt 04:01:51 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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', '--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:51 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: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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 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-9AFae0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 INFO - Running setup.py (path:/tmp/pip-1_Wckq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 INFO - Running setup.py (path:/tmp/pip-BcMeBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 INFO - Running setup.py (path:/tmp/pip-NmCZUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:51 INFO - Running setup.py (path:/tmp/pip-ARk_lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:51 INFO - Running setup.py (path:/tmp/pip-ijjPOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:51 INFO - Running setup.py (path:/tmp/pip-dmh6Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:52 INFO - Running setup.py (path:/tmp/pip-Qxzo2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:52 INFO - Running setup.py (path:/tmp/pip-yuZ1Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:52 INFO - Running setup.py (path:/tmp/pip-e2s0Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:52 INFO - Running setup.py (path:/tmp/pip-PPsTL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:52 INFO - Running setup.py (path:/tmp/pip-9HRa47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:52 INFO - Running setup.py (path:/tmp/pip-Y0dxFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:52 INFO - Running setup.py (path:/tmp/pip-XCdjgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 INFO - Running setup.py (path:/tmp/pip-ey_Sr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:52 INFO - Running setup.py (path:/tmp/pip-wL1GXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:52 INFO - Running setup.py (path:/tmp/pip-GNLAdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:52 INFO - Running setup.py install for manifestparser 04:01:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozcrash 04:01:52 INFO - Running setup.py install for mozdebug 04:01:53 INFO - Running setup.py install for mozdevice 04:01:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozfile 04:01:53 INFO - Running setup.py install for mozhttpd 04:01:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozinfo 04:01:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozInstall 04:01:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozleak 04:01:53 INFO - Running setup.py install for mozlog 04:01:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for moznetwork 04:01:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozprocess 04:01:54 INFO - Running setup.py install for mozprofile 04:01:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Running setup.py install for mozrunner 04:01:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Running setup.py install for mozscreenshot 04:01:54 INFO - Running setup.py install for moztest 04:01:54 INFO - Running setup.py install for mozversion 04:01:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:54 INFO - Cleaning up... 04:01:54 INFO - Return code: 0 04:01:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 04:01:54 INFO - 'HOME': '/home/cltbld', 04:01:54 INFO - 'LANG': 'en_US.UTF-8', 04:01:54 INFO - 'LANGUAGE': 'en_US:en', 04:01:54 INFO - 'LOGNAME': 'cltbld', 04:01:54 INFO - 'MAIL': '/var/mail/cltbld', 04:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:54 INFO - 'MOZ_NO_REMOTE': '1', 04:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:54 INFO - 'NO_EM_RESTART': '1', 04:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:54 INFO - 'PWD': '/builds/slave/test', 04:01:54 INFO - 'SHELL': '/bin/bash', 04:01:54 INFO - 'SHLVL': '1', 04:01:54 INFO - 'TERM': 'linux', 04:01:54 INFO - 'TMOUT': '86400', 04:01:54 INFO - 'USER': 'cltbld', 04:01:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 04:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:54 INFO - '_': '/tools/buildbot/bin/python'} 04:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 INFO - Running setup.py (path:/tmp/pip-m09Tdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 INFO - Running setup.py (path:/tmp/pip-GmwYgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 INFO - Running setup.py (path:/tmp/pip-grVIsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:55 INFO - Running setup.py (path:/tmp/pip-oZyI_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:55 INFO - Running setup.py (path:/tmp/pip-7rcwdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:55 INFO - Running setup.py (path:/tmp/pip-TE22iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:55 INFO - Running setup.py (path:/tmp/pip-jf3lFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:55 INFO - Running setup.py (path:/tmp/pip-ykDBns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:55 INFO - Running setup.py (path:/tmp/pip-9cAZPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:55 INFO - Running setup.py (path:/tmp/pip-EmSZa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 INFO - Running setup.py (path:/tmp/pip-_8DsQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 INFO - Running setup.py (path:/tmp/pip-6fN_PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 INFO - Running setup.py (path:/tmp/pip-MM8WDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 INFO - Running setup.py (path:/tmp/pip-Pq6Eb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 INFO - Running setup.py (path:/tmp/pip-mFsQSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:55 INFO - Running setup.py (path:/tmp/pip-Ejxyb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:55 INFO - Running setup.py (path:/tmp/pip-poIroX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:56 INFO - 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:56 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:56 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:56 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 blessings-1.6.tar.gz 04:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:57 INFO - Installing collected packages: blessings 04:01:57 INFO - Running setup.py install for blessings 04:01:58 INFO - Successfully installed blessings 04:01:58 INFO - Cleaning up... 04:01:58 INFO - Return code: 0 04:01:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:58 INFO - Reading from file tmpfile_stdout 04:01:58 INFO - Current package versions: 04:01:58 INFO - argparse == 1.2.1 04:01:58 INFO - blessings == 1.6 04:01:58 INFO - blobuploader == 1.2.4 04:01:58 INFO - docopt == 0.6.1 04:01:58 INFO - manifestparser == 1.1 04:01:58 INFO - mozInstall == 1.12 04:01:58 INFO - mozcrash == 0.17 04:01:58 INFO - mozdebug == 0.1 04:01:58 INFO - mozdevice == 0.48 04:01:58 INFO - mozfile == 1.2 04:01:58 INFO - mozhttpd == 0.7 04:01:58 INFO - mozinfo == 0.9 04:01:58 INFO - mozleak == 0.1 04:01:58 INFO - mozlog == 3.1 04:01:58 INFO - moznetwork == 0.27 04:01:58 INFO - mozprocess == 0.22 04:01:58 INFO - mozprofile == 0.28 04:01:58 INFO - mozrunner == 6.11 04:01:58 INFO - mozscreenshot == 0.1 04:01:58 INFO - mozsystemmonitor == 0.0 04:01:58 INFO - moztest == 0.7 04:01:58 INFO - mozversion == 1.4 04:01:58 INFO - psutil == 3.1.1 04:01:58 INFO - requests == 1.2.3 04:01:58 INFO - wsgiref == 0.1.2 04:01:58 INFO - Installing None 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', '-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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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', '-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:58 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: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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 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 - 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Cleaning up... 04:01:58 INFO - Return code: 0 04:01:58 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', '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', 'jsonschema'] 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 jsonschema 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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 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 jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 04:02:00 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 04:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:01 INFO - Installing collected packages: jsonschema, functools32 04:02:01 INFO - Running setup.py install for functools32 04:02:01 INFO - warning: no files found matching '*.txt' 04:02:01 INFO - no previously-included directories found matching 'build' 04:02:01 INFO - no previously-included directories found matching 'dist' 04:02:01 INFO - no previously-included directories found matching '.git*' 04:02:01 INFO - Successfully installed jsonschema functools32 04:02:01 INFO - Cleaning up... 04:02:01 INFO - Return code: 0 04:02:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 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 0x7f6f21fb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, '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': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:02:01 INFO - Using env: {'DISPLAY': ':0', 04:02:01 INFO - 'HOME': '/home/cltbld', 04:02:01 INFO - 'LANG': 'en_US.UTF-8', 04:02:01 INFO - 'LANGUAGE': 'en_US:en', 04:02:01 INFO - 'LOGNAME': 'cltbld', 04:02:01 INFO - 'MAIL': '/var/mail/cltbld', 04:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:01 INFO - 'MOZ_NO_REMOTE': '1', 04:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:01 INFO - 'NO_EM_RESTART': '1', 04:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:01 INFO - 'PWD': '/builds/slave/test', 04:02:01 INFO - 'SHELL': '/bin/bash', 04:02:01 INFO - 'SHLVL': '1', 04:02:01 INFO - 'TERM': 'linux', 04:02:01 INFO - 'TMOUT': '86400', 04:02:01 INFO - 'USER': 'cltbld', 04:02:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 04:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:01 INFO - '_': '/tools/buildbot/bin/python'} 04:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:01 INFO - Downloading/unpacking flake8 04:02:01 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:01 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:01 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:01 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:01 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:01 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:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:04 INFO - no previously-included directories found matching 'docs/_build' 04:02:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:04 INFO - Running setup.py install for pep8 04:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:04 INFO - no previously-included directories found matching 'docs/_build' 04:02:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:04 INFO - Cleaning up... 04:02:04 INFO - Return code: 0 04:02:04 INFO - Running post-action listener: _resource_record_post_action 04:02:04 INFO - Running post-action listener: _start_resource_monitoring 04:02:04 INFO - Starting resource monitoring. 04:02:04 INFO - ##### 04:02:04 INFO - ##### Running install step. 04:02:04 INFO - ##### 04:02:04 INFO - Running pre-action listener: _resource_record_pre_action 04:02:04 INFO - Running main action method: install 04:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:04 INFO - Reading from file tmpfile_stdout 04:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:04 INFO - Reading from file tmpfile_stdout 04:02:04 INFO - Output received: 04:02:04 INFO - Usage: mozinstall [options] installer 04:02:04 INFO - Options: 04:02:04 INFO - -h, --help show this help message and exit 04:02:04 INFO - -d DEST, --destination=DEST 04:02:04 INFO - Directory to install application into. [default: 04:02:04 INFO - "/builds/slave/test"] 04:02:04 INFO - --app=APP Application being installed. [default: firefox] 04:02:04 INFO - mkdir: /builds/slave/test/build/application 04:02:04 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:04 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:17 INFO - Reading from file tmpfile_stdout 04:02:17 INFO - Output received: 04:02:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:17 INFO - Running post-action listener: _resource_record_post_action 04:02:17 INFO - ##### 04:02:17 INFO - ##### Running run-tests step. 04:02:17 INFO - ##### 04:02:17 INFO - Running pre-action listener: _resource_record_pre_action 04:02:17 INFO - Running main action method: run_tests 04:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:17 INFO - Python 2.7.3 04:02:17 INFO - Return code: 0 04:02:17 INFO - grabbing minidump binary from tooltool 04:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:17 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 0x26e2410>, '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 0x26e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:17 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:17 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:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:17 INFO - Return code: 0 04:02:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:18 INFO - Return code: 0 04:02:18 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-043', '--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:18 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-043 --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:18 INFO - Using env: {'DISPLAY': ':0', 04:02:18 INFO - 'HOME': '/home/cltbld', 04:02:18 INFO - 'LANG': 'en_US.UTF-8', 04:02:18 INFO - 'LANGUAGE': 'en_US:en', 04:02:18 INFO - 'LOGNAME': 'cltbld', 04:02:19 INFO - 'MAIL': '/var/mail/cltbld', 04:02:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:19 INFO - 'MOZ_NO_REMOTE': '1', 04:02:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:19 INFO - 'NO_EM_RESTART': '1', 04:02:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:19 INFO - 'PWD': '/builds/slave/test', 04:02:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:19 INFO - 'SHELL': '/bin/bash', 04:02:19 INFO - 'SHLVL': '1', 04:02:19 INFO - 'TERM': 'linux', 04:02:19 INFO - 'TMOUT': '86400', 04:02:19 INFO - 'USER': 'cltbld', 04:02:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469617286.137355-919252908', 04:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:19 INFO - '_': '/tools/buildbot/bin/python'} 04:02:19 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-043', '--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:19 INFO - mozversion application_buildid: 20160726073802 04:02:19 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:19 INFO - mozversion application_display_name: Firefox 04:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:19 INFO - mozversion application_name: Firefox 04:02:19 INFO - mozversion application_remotingname: firefox 04:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:19 INFO - mozversion application_vendor: Mozilla 04:02:19 INFO - mozversion application_version: 48.0 04:02:19 INFO - mozversion platform_buildid: 20160726073802 04:02:19 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:19 INFO - mozversion platform_version: 48.0 04:02:19 INFO - using testdate: 1469617339 04:02:19 INFO - actual date: 1469617339 04:02:19 INFO - starting webserver on 'localhost:52787' 04:02:19 INFO - SUITE-START | Running 2 tests 04:02:19 INFO - TEST-START | dromaeo_css 04:02:19 INFO - operating with platform_type : linux_ 04:02:19 INFO - Initialising browser for dromaeo_css test... 04:02:19 INFO - TEST-INFO | started process 13820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1rFpK/profile http://localhost:52787/getInfo.html) 04:02:23 INFO - PROCESS | 13820 | __metrics Screen width/height:1600/1200 04:02:23 INFO - PROCESS | 13820 | colorDepth:24 04:02:23 INFO - PROCESS | 13820 | Browser inner width/height: 1024/697 04:02:23 INFO - PROCESS | 13820 | __metrics 04:02:24 INFO - PROCESS | 13820 | 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:24 ERROR - PROCESS | 13820 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:25 INFO - TEST-INFO | 13820: exit 0 04:02:25 INFO - Browser initialized. 04:02:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:25 INFO - TEST-INFO | started process 13914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1rFpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:36 INFO - PROCESS | 13914 | RSS: Main: 138944512 04:02:36 INFO - PROCESS | 13914 | 04:03:27 INFO - PROCESS | 13914 | 1469617407730 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:35 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52787/tests/dromaeo/cssquery-ext.html) 04:05:36 INFO - PROCESS | 13914 | RSS: Main: 247910400 04:05:36 INFO - PROCESS | 13914 | 04:08:38 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-ext.html (next: http://localhost:52787/tests/dromaeo/cssquery-jquery.html) 04:08:38 INFO - PROCESS | 13914 | RSS: Main: 221765632 04:08:38 INFO - PROCESS | 13914 | 04:11:40 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52787/tests/dromaeo/cssquery-mootools.html) 04:11:41 INFO - PROCESS | 13914 | RSS: Main: 221409280 04:11:41 INFO - PROCESS | 13914 | 04:14:42 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52787/tests/dromaeo/cssquery-prototype.html) 04:14:43 INFO - PROCESS | 13914 | RSS: Main: 220749824 04:14:43 INFO - PROCESS | 13914 | 04:17:46 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52787/tests/dromaeo/cssquery-yui.html) 04:17:46 INFO - PROCESS | 13914 | RSS: Main: 210513920 04:17:46 INFO - PROCESS | 13914 | 04:20:48 INFO - PROCESS | 13914 | Cycle 1(1): loaded http://localhost:52787/tests/dromaeo/cssquery-yui.html (next: http://localhost:52787/tests/dromaeo/cssquery-dojo.html) 04:20:49 INFO - PROCESS | 13914 | RSS: Main: 246853632 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | __start_tp_report 04:20:49 INFO - PROCESS | 13914 | _x_x_mozilla_page_load 04:20:49 INFO - PROCESS | 13914 | _x_x_mozilla_page_load_details 04:20:49 INFO - PROCESS | 13914 | |i|pagename|runs| 04:20:49 INFO - PROCESS | 13914 | |0;dojo.html;3248.3828072666192;3254.511823226516;3277.3772983133217;3309.6524864889184;3334.816585087819;5331.333583302087;5346.064438723222;5355.732213389334;5361.812336568221;5363.731813409334;5324.7071411072375;5385.35375754909;5387.622866399353;5391.78432862685;5404.189371594262;4760.143174228638;4839.75801209939;4925.162722337193;4999.550040496355;5014.548690617844;4774.28385742138;4890.682105663121;4898.167311557026;4915.164422048242;4921.064997650435;4850.563449289563;4874.65877388583;4897.51024897511;4912.778924948368;4926.11329960607;4929.088118698052;4948.307236986825;4950.183219768734;4951.183054795991;4965;4639.582437580634;4782.091402633523;4879.780409881564;4884.633652476078;4909.926351104737;5229.790808367661;5273.367195936512;5288.947110528922;5294.735263236823;5295.629305948585;5658.603897727161;5721;5723.198752174699;5725.6278341908055;5726.627769194989;5558.221848941152;5646.096624540095;5657.066584013633;5691.288588926384;5751.137329400582;5383.865403364908;5393.460653934614;5424.376196737347;5435.864103397407;5438.646487978348;5740.1102829061565;5870.618409803349;5885.941140588625;5901;5901.557383196277;5591.049521581341;5627.268455100892;5632.324121105494;5645.5201307888465;5676.574256930747;5699.658020518782;5703.62926409782;5704.001799685038;5707.771689132388;5718.142278658234;5611.6352437091455;5671.234383358194;5674.858128546737;5688.77244910199;5690.630109042899;5664.773409063674;5732.914006289909;5736.053551164011;5736.827895163152;5773.018586840163;4432.13573353193;4439.511653718088;4443.488998765119;4450.421445212101;4473.7986790594505;3946.8815935521407;3957.2085582883537;4008.2584721826556;4013.979930100331;4053.3919912013434;5495.065838807413;5502.669839809544;5516.834494965157;5527.143292789624;5528.115501519737;5768.163616275617;5785.103308987113;5785.1611516329895;5786.971065144648;5794.015017447045;5402.837914862561;5447.863803404946;5509.862253443615;5517.393086760453;5545.445455454503;4984.127777638899;4997.9500204997485;5008.098542262355;5008.424031236382;5042.924356134661;5938.703064846741;5974.880502389928;5987.281526216795;5988;5999.100134979788;5656.377798442168;5780.190773291659;5849.94150058494;5864.149698293809;5874.735636896265;5972.984592619178;5975.521958243243;5983.910241346296;5986.551008674454;5986.610870293591;5517.062099443185;5693.9430605693415;5700.914486282626;5703.030484817508;5710.457506536873;5703.315602127771;5755.8561035974435;5802.535797136304;5812.3025236971835;5848.035074212878;5601.943980560305;5613.719314034363;5617.354004289396;5619.129034999582;5626.156076588544;5482.17767334903;5568.053430916835;5605.159226116115;5613.073842815889;5615.691136987341;5509.201165830852;5521.917171242354;5550.972245138749;5553.416891226525;5587.636803607753;5648.774049037993;5663.377028526941;5667.518260947865;5667.8866422672145;5672.432756724294;5478.260434841245;5524.806631767869;5551.555875530029;5591.04952158126;5609.887802244014 04:20:49 INFO - PROCESS | 13914 | |1;ext.html;664.4684252597923;667.8731041102191;669.8593295407961;671.6440286648078;675.5710124071213;32575.51136732948;33181.50227746583;39509.80245098771;40105.7994710026;40188.59811401885;42800;43126.353104703456;43213.56786432143;43309.7834510827;43360.783196084056;8115.553644549547;8831.470111793296;8958.507282099481;9001.549922503882;9005.639774409015;10790.838137427905;11081.335119892792;11088.722781930435;11091.667249982513;11094.278871873343;10432.478376081204;10505.159587233004;10565.154787616972;10577.153827693766;10584.78830423391;10640.361578305288;10703.83944240837;10716.78566428667;10719.624813131502;10723.088537474325;10459.372437653765;10549.10332621728;10554.050135487767;10564.26050176488;10569.894301056967;42675;43146;43149.56850431487;43169.56830431718;43186.78406607978;3656.378415669316;3670.229251857113;3706.5181526401666;3921.725479216456;4095.4075336865203;32733.345333093443;33115;33291.33417331664;33729.32541349184;34707;4345.348197770328;4471.709338892962;4474.709143905636;4504.324351347292;4548.067646132535;323160;323953;324195;324764;325056;39954.20091598152;61072.38927610756;61283;61550.69224653938;61672.69163654153;37269.25461490755;37460.25079498395;37463.812680936964;37465.62534374676;37491.25017499635;17607.911960440117;17757.7336339955;17771.378001769877;17779.555511112325;17780.91109544444;13576.321183940763;13866.445342186402;14274.785878211835;14469.565913022627;14998.850011499964;9200.81598368029;9236.399634023766;9250.86123708145;9293;9303.906960930304;3514.139035936161;3584.444411116281;3595.9640403596154;3597.686844301811;3676.871309504208;994.945278009702;1108;1163.7032556697989;1173.7887180307628;1184.7630473905253;31871.68128318687;32838.67161328404;32899.835500822344;33089.3382132356;33889.322213556086;1110.348327015495;1180.3744015671707;1189.4944648524342;1265.2282107914166;1290.3870661435742;14912.850871491146;17454.91272543629;17595;17726.556836078944;17855;363690;369746;369755;369850;372095;55124;55567.722161388934;55605.44394556003;55704;55833.162502562496;1394.8884089273038;1492.7387707151206;1499.242882344409;1561.5783738390571;1640.0323808952776;28868.27829304284;29558.113256602337;29790.851045744632;30151.698483015767;30387.696123038488;44421.55578444174;44714.77642611766;44720;44765.65703028914;44837.32744008908;300547;304291;306834;307268;307558;27099.1870243893;29974.850125750105;30826.69173308238;30927.84536077305;31046.53430198594;47130.764346178046;47460.288095677904;47630;48058.27912581244;48086.759566201945;38425.6157438422;39383.21233575255;39734;40339.596604033584;40510.59489405068;37944;38092.619073808906;38363.23273534569;42724.5727542733;43333.167107166264;41582.376264356666;41985.79007104945;42042.57957420387;42258.57741422547;42823;35493;35745.642543574235;36624.08439789026;37004.25991480101;37098.8145059273;28126.85936570304;28332.71667283383;28342.43315133727;28701.85649071741;28742.425151496434 04:20:49 INFO - PROCESS | 13914 | |2;jquery.html;418.90574620710345;426.47969477237757;427.7454914325975;438.89466528033273;440.2471773267712;18297.17662705178;19023.714644280346;19045.047747612614;19246.80753192468;20048.29830955917;12724.936375318133;12813.615591532269;12898.355082245896;12980.28608426536;13052.869471305308;5229.660072095311;5438.564914806806;5457.290552228204;5476.315460567429;5483.533899618517;4020.5376381716037;4114.547399786021;5369.19462080689;5789.681567513785;6033.27600687918;5995.130706047642;6002;6032.336442991267;6038;6039.456448919596;5838.970805145968;6492.285848556655;6497.675116244216;6499.837504062389;6501.707423165945;3978.781167035812;5615.634983726086;5833.504152147073;5849.85375365615;5859.648421094748;14005.159690418608;14017.789733154012;14123.505677301348;17580.560485987953;22459.438514037116;2303.8502497337618;2405.9639105413435;2408.89159987801;2422.588160012802;2429.4898071405028;10376.325538839952;10449.634262800766;10674.519646615843;10860.891391086067;13881.097728647606;1972.5265936175358;2047.4471892589067;2096.874187548752;2105.5788842231464;2110.873347599149;74772;75584;77876;79737.60131199307;81005.59497202536;11046.834297485544;11315.434228288552;11490.885091149148;11532.827007594893;11708.88291117095;16240.431584894472;16286.26711797972;16341.101239431946;16370.263338149574;16393.59016024609;8818.162274583905;9020.458772473672;9080.818383632422;9148.817023659623;9161.221296189899;8608.870866936875;8691.869621955675;9050.230730387859;9063.81872362549;9087.81824363509;4952.430470495867;4986.626003049786;5017.347744793154;5035.546800787946;5076.873078173001;1827.6853124984425;2011.8088781565727;2012.2252932621047;2118.142152428238;2154.1706443019552;1019.4698756646502;1030.7371620236793;1055.2244100586063;1088.7223757941674;1124.454639499842;17943.282268709365;18839.71740423895;18868.33960811365;19059.42821715351;19661.90169049174;1000.314784372707;1063.106990128296;1070.464767616192;1084.1814430105378;1088.482970588964;10698.358098514114;10949.41233521135;11003.61487347939;11019.449027548591;11040.723981900355;513399;514479;521560;524402;526449;86548.5672571633;89843.55078224567;89955.65066524007;90829;92107;1091.748897753521;1125.6060378867494;1142.057802313095;1150.0569532982875;1155.0990227622467;17326.047067411415;17430.91284543569;17470.912645436692;17486.650266994842;17702.468925932244;25064.37339066465;25810.741892581584;32749;38864.417033745085;39078.6092139075;58130.418695814195;58207;58210.70894645499;58401;58456.70771646115;8619.784505387415;8796.60415281301;8932.419392739452;9100.044495327895;9121.680741174026;12674.746505069663;12881.291528965998;12889.613311600668;12976.15654982423;12988.48046078184;11141;11348.943255284;11413.828792567952;11442.084633229488;11489.770204595694;11178.217524773188;11234.269772464764;11238;11310.773784524428;11420.600278990196;11433.714157146138;11546.826797597874;11662.650120496399;12144.392780361124;12203.877961220274;8803.427777194718;8883.511406872425;8891;9015.81968360616;9146.95426522863;10980.615678451215;11684.70788230301;11732.41337933117;11831;11980 04:20:49 INFO - PROCESS | 13914 | |3;mootools.html;1401.9859801401983;1549.1170033081141;1570.6858628274344;1748.2569907789186;1896.516388320978;7216.530925489839;7769.961150194248;7901.130875603679;7907.525548467096;7914.406419518545;7740.303372696456;7919.168487308836;7919.445638805286;7928.5242885426915;7935.484193527417;2284.64587988862;2316.918907838226;2321.3732292281156;2325.8953347099423;2326.81332520415;2276.4536511237347;2318.5594737;2390.127603424755;2392.2942731894045;2406;2309.9191528296515;2328.75548067453;2344.2732752846673;2348.1311914591624;2360.7285162206394;2295.3114065780364;2321.3964369264027;2322.6399908014287;2325.848819826706;2367.7277113132036;2320.2691152286975;2330.207729372005;2333.428310064028;2338;2343.589871772433;7697.461177717562;7856.25365590268;8010.959945200295;8030.39772017101;8044.839103217902;4956.157453232959;5101.362329708786;5102.285680004802;5115.181570948667;5119.641625086246;3336.7163791077787;3351.329734053199;3352.2960178362573;3374.207061340583;3397.9320413591836;1095.5727266366123;1125.5779082843933;1125.7692173104494;1136.8351589019628;1139.8176291793357;11016.11871050314;11172.553097876074;11176.329420234812;11184.161187910859;11220.49507772144;4337.414449049401;4337.566243375637;4414.933775993362;4451.821927122944;4494.438195225597;9619.951900240594;9702.27232957531;9713.125818676353;9729.41623502578;9735.70792876215;5097.515736005148;5126.359205099363;5132.9743351283005;5133.640645154804;5133.8716532087;4027.073773032219;4093.2222877653153;4483.439570053743;4586.6789324747615;4693.6949098308505;3929;4033.5882441145363;4052.696047796427;4069.593040695907;4156.56356082613;1240.7580521798343;1251.249250449723;1252.8872401483911;1254.3477391756235;1264.4878824076263;1027.912627426677;1035.3477309295097;1046.7487802927394;1079.7354648111263;1080.3679847289266;5775.88448231033;5841.094630332305;5855.795047173328;5994.6403215807195;6047.788327408608;471.1284124369888;471.19660978032374;486.07645473599734;490.6124161912121;490.85274417674555;3990.920181596352;3998.6001399859783;4060.6548443382053;4078.3270760324212;4079.1229885574744;9336.626534938527;9486.667966621135;9488.715338539854;9505;9590.472524011107;9417.293702972305;9425.67010154655;9468.431894086378;9472.242220622335;9492.240620750323;7635.809104772425;7740.729074482366;7745.031871016123;7745.806354841174;7755.108162561265;5429.728513574227;5590.916136257878;5620.241267428844;5725.51333136688;5763.971180144073;8527.317814574695;8569.742907712778;8726.301895848444;8909.465432074096;8975.865362019706;8646.265067469336;8800.33997450181;8810.955945220232;8843.734687959372;8866.822663546822;6579.144711187515;6942.757003505055;7081.114860642419;7181.317774811385;7313.48805583604;7691.538507689556;7729.227077292226;7795.415343849348;7797.064352277763;7807.414443916842;6924.515283930076;7116.50184487081;7123.358897699025;7180.281971802778;7227.49407541467;7030.824229394306;7036.718531258693;7068.858622827412;7133.037039999534;7134.143902731706;6417.422431981144;6611.404973552403;6629.569078009914;6636.933630663824;6733.93266067333;4962.280469331855;5020.171671674133;5026.547610715053;5053.418856831511;5144.125498665311;5167.020583540088;5193.324867767166;5224.8900913088855;5310.7875684973715;5353.946460535345 04:20:49 INFO - PROCESS | 13914 | |4;prototype.html;354.9414346632806;358.81700332830263;362.53052297275025;366.49972787145555;369.4015694574789;6133.20268365113;6143.385661433855;6154.323024467305;6163.229596300468;6169.105479705446;6154.446099851012;6158.507319414447;6169.7532098716;6187.288461826891;6189.938100618992;4551.795169217385;4641.141388843075;4716.4340279166545;4720.197566413718;4738.265568836836;4719.764011799413;4730.810767569293;4746.264329029006;4762.404699412574;4765.166095933215;4536.841210557631;4729.408823897013;4731.337612734203;4738.857834264978;4742.193827049393;4611.446626404836;4694.037722266927;4694.29585562165;4706.987997580537;4731.432228132646;4177.665786737054;4187.685923555746;4191.371294305848;4195.937060944088;4196.706230563862;5903.881922361528;5910.320313163998;5916.615419997729;5918.763249470016;5920.703964801785;5484.122540393558;5490.286262785812;5492.670439773587;5496.038193316193;5510.118381059051;6393.520485963525;6456.967715161441;6465.3534646535445;6465.4827613790785;6512.348765123497;4624.190766615829;4626.745528995903;4660;4660.067986402733;4660.557247061523;6706.9329306706795;6717.932820671828;6739.135867256446;6741.292164322725;6742.865142697167;4754.690945088627;4758.78585463655;4761.809527618856;4762.9523704762505;4768.76156192196;4812.879678008007;4814.638902082358;4815.374001379868;4822.758862056883;4830.154722923475;5466.808661696821;5470.8085217017215;5477.643953143112;5482.424345443751;5490.862728431821;6299.6535190564955;6486.351364863476;6524.67376631176;6525.3800888915475;6536.182977127859;1619.5465269724496;1637.2059551117698;1640.6226567889453;1644.4080131152775;1649.9605248693485;1014.9492525373702;1047.1361127070045;1055.4353420919772;1075.2312096850633;1105.4693747001484;6252.874942501125;6260;6330.841728956813;6334.873302534015;6340.587861789061;6638.966805165944;6643.335666433415;6645.06969024337;6652.800415987528;6662.766803161866;6308.7476500940365;6311.715972781236;6317.5893566918;6319.684015799284;6323.36766323364;3536.5402497675136;3594.2092739597247;3609.0616439725336;3612.7832330060282;3613.584437789635;6770.086038384755;6894.931050689529;6902.8619427612175;6919.515633905578;6924.896126558106;6717.294684058202;6745.156855393076;6746.595204287759;6748.527603067836;6750.594964302158;6895.275996020446;6896.586204827727;6898.206706228848;6902.723891044402;6908.412784913338;6621.139251897415;6629.337066293332;6698.933010669831;6700.6984685688285;6703.262641109572;6395.232572091379;6533.803985880431;6550.312217217123;6564.048213008991;6564.5076619254705;6858.279880612663;6893.138357705287;6904.689288981907;6907.861842763217;6909.723611055501;4627.167109920247;4628.051249493913;4628.9537104628525;4632.629389648752;4643.466001409881;6606.8678626426245;6616.338366163538;6630.83422914431;6703.564268322543;6705.262421133574;6262.624242545279;6423.743050277936;6444.709988050456;6447.903281450688;6450.193725784277;6406.359364063556;6425.8714825704155;6428.774992875414;6432.292447830641;6436.935630643821;6321;6323.177986861679;6329.670769138348;6332.588381755171;6338.429541341301;6457.903131453126;6467.223933128054;6477.319881412573;6480.837979050561;6483.416492515507;6147.96926015385;6266.937330626818;6274.686265686789;6335.461485773761;6340.619562826245 04:20:49 INFO - PROCESS | 13914 | |5;yui.html;766.6358479722131;783.9925695481307;788.7830846517211;802.0896282719116;810.3436216664502;13427.462901483941;13621.523246686367;13630.114042587238;13694.931525342385;13708.314584270796;13142.802857957115;13152.868471315283;13183;13186;13277.20336779794;772.5364781131304;869.9217070463673;905.6060613633058;907.2651152566409;928.0348437624862;916.3631276263;921.6451666108529;922.3543519536317;922.5064590444114;922.6816748221886;935.794125292438;942.7218970403713;951.6907005223295;952.3571589177278;953.3517208298355;795.8965334506535;813.1258896686056;948.33616468472;951.3007939164709;954.7183580843667;703.9964800175966;709.3155105323336;710.1017213225274;710.2187593646998;710.5985118408083;12948.935255323662;12963.546275880299;13014.674633134247;13028.218306901521;13047.739045219138;13315.800262996063;13578.932105339509;13739.656508587266;13814;13949.217502395426;11952.70118247042;12013.219140755911;12055.517779288817;12131.514739410413;12174.086943479186;3959.1487830116375;3987.8803635890968;4011.859584914514;4046.2312160689376;4107.753534787922;52713.7364313176;53189.2021619676;53229;53549.46450535523;53555.732221339036;10278.280520363653;10302.33034852732;11822.290662560274;11909.22590031645;12292.139550231397;19946.401607951786;20146.093425795876;20163.495912602302;20174;20181.899090504452;8887.200151986352;9033.548322583845;9134.858142732159;9174;9241.983381827993;5000.14997450427;5032.823851165192;5069.264956581275;5131.512506311894;5138.3833939927445;3434.227298857737;3505.8772942946875;3507.0881570791776;3507.2459421224557;3511.8244087795506;571.6958082003541;675.8377989282635;681.2744427185032;682.4301708073715;682.8668409660069;739;767.7005967672612;777.2033665492802;778.9493682910706;784.2001158818088;9433.669821556212;9590.376625519319;9632.325737198329;9797.80404391908;9940.552675129637;771.753039027517;795.550513959611;802.6548584108773;823.6993497373535;829.668132746894;4269.658427325807;4416.712913660602;4781.976090119527;4796.136695394863;4796.5203479651755;60840.69579652162;60959.69520152371;63236.68381658154;63952;64372;53777;54940;55266.72366638141;55295.17057244144;55365.44634553603;50203.74898125486;50630.24054639183;50780.23829642558;51483.48516514787;51956.74021629943;9442.669506567237;9576.090271424204;9599;9608.375455595364;9658.75853103678;37220.81389593035;39064.80467597644;39286.2142757149;39393.80303098466;40155.59844401519;43832.78083609562;48580;50528.49471505238;51253.97492050213;51276;11440.427978601203;11501.53993840237;11556.133290003452;12663.810042849549;12703.80944285855;14007.369668365152;14072.718545629235;14333.856661433669;14342.784858227344;14626.268686565842;12323.568675096687;12790.74418511606;13422.530211442552;13878.653033674238;13959.041325261845;12926.547570835352;13487.25820079905;13637.863621364057;13794.586162415144;13813.309334533435;13437.731245375233;13557.728845422838;13627.523036694065;13635.86364136346;13800;11358.488868000795;11427.828582571101;11491.922395065978;11547.769044619228;11660.475278612314;10284.640037598649;10551.515962587771;10717.9464102679;10764.677059688222;10787.730306742395 04:20:49 INFO - PROCESS | 13914 | __end_tp_report 04:20:49 INFO - PROCESS | 13914 | __start_cc_report 04:20:49 INFO - PROCESS | 13914 | _x_x_mozilla_cycle_collect,827 04:20:49 INFO - PROCESS | 13914 | __end_cc_report 04:20:49 INFO - PROCESS | 13914 | __startTimestamp1469618449230__endTimestamp 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | ------- Summary: start ------- 04:20:49 INFO - PROCESS | 13914 | Number of tests: 6 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#0] dojo.html Cycles:165 Average:5349.22 Median:5551.56 stddev:577.25 (10.4%) stddev-sans-first:555.00 04:20:49 INFO - PROCESS | 13914 | Values: 3248.4 3254.5 3277.4 3309.7 3334.8 5331.3 5346.1 5355.7 5361.8 5363.7 5324.7 5385.4 5387.6 5391.8 5404.2 4760.1 4839.8 4925.2 4999.6 5014.5 4774.3 4890.7 4898.2 4915.2 4921.1 4850.6 4874.7 4897.5 4912.8 4926.1 4929.1 4948.3 4950.2 4951.2 4965.0 4639.6 4782.1 4879.8 4884.6 4909.9 5229.8 5273.4 5288.9 5294.7 5295.6 5658.6 5721.0 5723.2 5725.6 5726.6 5558.2 5646.1 5657.1 5691.3 5751.1 5383.9 5393.5 5424.4 5435.9 5438.6 5740.1 5870.6 5885.9 5901.0 5901.6 5591.0 5627.3 5632.3 5645.5 5676.6 5699.7 5703.6 5704.0 5707.8 5718.1 5611.6 5671.2 5674.9 5688.8 5690.6 5664.8 5732.9 5736.1 5736.8 5773.0 4432.1 4439.5 4443.5 4450.4 4473.8 3946.9 3957.2 4008.3 4014.0 4053.4 5495.1 5502.7 5516.8 5527.1 5528.1 5768.2 5785.1 5785.2 5787.0 5794.0 5402.8 5447.9 5509.9 5517.4 5545.4 4984.1 4998.0 5008.1 5008.4 5042.9 5938.7 5974.9 5987.3 5988.0 5999.1 5656.4 5780.2 5849.9 5864.1 5874.7 5973.0 5975.5 5983.9 5986.6 5986.6 5517.1 5693.9 5700.9 5703.0 5710.5 5703.3 5755.9 5802.5 5812.3 5848.0 5601.9 5613.7 5617.4 5619.1 5626.2 5482.2 5568.1 5605.2 5613.1 5615.7 5509.2 5521.9 5551.0 5553.4 5587.6 5648.8 5663.4 5667.5 5667.9 5672.4 5478.3 5524.8 5551.6 5591.0 5609.9 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#1] ext.html Cycles:180 Average:50099.75 Median:3596.83 stddev:87476.34 (2432.0%) stddev-sans-first:87642.99 04:20:49 INFO - PROCESS | 13914 | Values: 664.5 667.9 669.9 671.6 675.6 32575.5 33181.5 39509.8 40105.8 40188.6 42800.0 43126.4 43213.6 43309.8 43360.8 8115.6 8831.5 8958.5 9001.5 9005.6 10790.8 11081.3 11088.7 11091.7 11094.3 10432.5 10505.2 10565.2 10577.2 10584.8 10640.4 10703.8 10716.8 10719.6 10723.1 10459.4 10549.1 10554.1 10564.3 10569.9 42675.0 43146.0 43149.6 43169.6 43186.8 3656.4 3670.2 3706.5 3921.7 4095.4 32733.3 33115.0 33291.3 33729.3 34707.0 4345.3 4471.7 4474.7 4504.3 4548.1 323160.0 323953.0 324195.0 324764.0 325056.0 39954.2 61072.4 61283.0 61550.7 61672.7 37269.3 37460.3 37463.8 37465.6 37491.3 17607.9 17757.7 17771.4 17779.6 17780.9 13576.3 13866.4 14274.8 14469.6 14998.9 9200.8 9236.4 9250.9 9293.0 9303.9 3514.1 3584.4 3596.0 3597.7 3676.9 994.9 1108.0 1163.7 1173.8 1184.8 31871.7 32838.7 32899.8 33089.3 33889.3 1110.3 1180.4 1189.5 1265.2 1290.4 14912.9 17454.9 17595.0 17726.6 17855.0 363690.0 369746.0 369755.0 369850.0 372095.0 55124.0 55567.7 55605.4 55704.0 55833.2 1394.9 1492.7 1499.2 1561.6 1640.0 28868.3 29558.1 29790.9 30151.7 30387.7 44421.6 44714.8 44720.0 44765.7 44837.3 300547.0 304291.0 306834.0 307268.0 307558.0 27099.2 29974.9 30826.7 30927.8 31046.5 47130.8 47460.3 47630.0 48058.3 48086.8 38425.6 39383.2 39734.0 40339.6 40510.6 37944.0 38092.6 38363.2 42724.6 43333.2 41582.4 41985.8 42042.6 42258.6 42823.0 35493.0 35745.6 36624.1 37004.3 37098.8 28126.9 28332.7 28342.4 28701.9 28742.4 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#2] jquery.html Cycles:180 Average:29203.37 Median:2108.23 stddev:85505.88 (4055.8%) stddev-sans-first:85718.43 04:20:49 INFO - PROCESS | 13914 | Values: 418.9 426.5 427.7 438.9 440.2 18297.2 19023.7 19045.0 19246.8 20048.3 12724.9 12813.6 12898.4 12980.3 13052.9 5229.7 5438.6 5457.3 5476.3 5483.5 4020.5 4114.5 5369.2 5789.7 6033.3 5995.1 6002.0 6032.3 6038.0 6039.5 5839.0 6492.3 6497.7 6499.8 6501.7 3978.8 5615.6 5833.5 5849.9 5859.6 14005.2 14017.8 14123.5 17580.6 22459.4 2303.9 2406.0 2408.9 2422.6 2429.5 10376.3 10449.6 10674.5 10860.9 13881.1 1972.5 2047.4 2096.9 2105.6 2110.9 74772.0 75584.0 77876.0 79737.6 81005.6 11046.8 11315.4 11490.9 11532.8 11708.9 16240.4 16286.3 16341.1 16370.3 16393.6 8818.2 9020.5 9080.8 9148.8 9161.2 8608.9 8691.9 9050.2 9063.8 9087.8 4952.4 4986.6 5017.3 5035.5 5076.9 1827.7 2011.8 2012.2 2118.1 2154.2 1019.5 1030.7 1055.2 1088.7 1124.5 17943.3 18839.7 18868.3 19059.4 19661.9 1000.3 1063.1 1070.5 1084.2 1088.5 10698.4 10949.4 11003.6 11019.4 11040.7 513399.0 514479.0 521560.0 524402.0 526449.0 86548.6 89843.6 89955.7 90829.0 92107.0 1091.7 1125.6 1142.1 1150.1 1155.1 17326.0 17430.9 17470.9 17486.7 17702.5 25064.4 25810.7 32749.0 38864.4 39078.6 58130.4 58207.0 58210.7 58401.0 58456.7 8619.8 8796.6 8932.4 9100.0 9121.7 12674.7 12881.3 12889.6 12976.2 12988.5 11141.0 11348.9 11413.8 11442.1 11489.8 11178.2 11234.3 11238.0 11310.8 11420.6 11433.7 11546.8 11662.7 12144.4 12203.9 8803.4 8883.5 8891.0 9015.8 9147.0 10980.6 11684.7 11732.4 11831.0 11980.0 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#3] mootools.html Cycles:180 Average:5379.75 Median:5129.67 stddev:2879.80 (56.1%) stddev-sans-first:2872.36 04:20:49 INFO - PROCESS | 13914 | Values: 1402.0 1549.1 1570.7 1748.3 1896.5 7216.5 7770.0 7901.1 7907.5 7914.4 7740.3 7919.2 7919.4 7928.5 7935.5 2284.6 2316.9 2321.4 2325.9 2326.8 2276.5 2318.6 2390.1 2392.3 2406.0 2309.9 2328.8 2344.3 2348.1 2360.7 2295.3 2321.4 2322.6 2325.8 2367.7 2320.3 2330.2 2333.4 2338.0 2343.6 7697.5 7856.3 8011.0 8030.4 8044.8 4956.2 5101.4 5102.3 5115.2 5119.6 3336.7 3351.3 3352.3 3374.2 3397.9 1095.6 1125.6 1125.8 1136.8 1139.8 11016.1 11172.6 11176.3 11184.2 11220.5 4337.4 4337.6 4414.9 4451.8 4494.4 9620.0 9702.3 9713.1 9729.4 9735.7 5097.5 5126.4 5133.0 5133.6 5133.9 4027.1 4093.2 4483.4 4586.7 4693.7 3929.0 4033.6 4052.7 4069.6 4156.6 1240.8 1251.2 1252.9 1254.3 1264.5 1027.9 1035.3 1046.7 1079.7 1080.4 5775.9 5841.1 5855.8 5994.6 6047.8 471.1 471.2 486.1 490.6 490.9 3990.9 3998.6 4060.7 4078.3 4079.1 9336.6 9486.7 9488.7 9505.0 9590.5 9417.3 9425.7 9468.4 9472.2 9492.2 7635.8 7740.7 7745.0 7745.8 7755.1 5429.7 5590.9 5620.2 5725.5 5764.0 8527.3 8569.7 8726.3 8909.5 8975.9 8646.3 8800.3 8811.0 8843.7 8866.8 6579.1 6942.8 7081.1 7181.3 7313.5 7691.5 7729.2 7795.4 7797.1 7807.4 6924.5 7116.5 7123.4 7180.3 7227.5 7030.8 7036.7 7068.9 7133.0 7134.1 6417.4 6611.4 6629.6 6636.9 6733.9 4962.3 5020.2 5026.5 5053.4 5144.1 5167.0 5193.3 5224.9 5310.8 5353.9 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#4] prototype.html Cycles:180 Average:5439.39 Median:6221.41 stddev:1615.37 (26.0%) stddev-sans-first:1574.18 04:20:49 INFO - PROCESS | 13914 | Values: 354.9 358.8 362.5 366.5 369.4 6133.2 6143.4 6154.3 6163.2 6169.1 6154.4 6158.5 6169.8 6187.3 6189.9 4551.8 4641.1 4716.4 4720.2 4738.3 4719.8 4730.8 4746.3 4762.4 4765.2 4536.8 4729.4 4731.3 4738.9 4742.2 4611.4 4694.0 4694.3 4707.0 4731.4 4177.7 4187.7 4191.4 4195.9 4196.7 5903.9 5910.3 5916.6 5918.8 5920.7 5484.1 5490.3 5492.7 5496.0 5510.1 6393.5 6457.0 6465.4 6465.5 6512.3 4624.2 4626.7 4660.0 4660.1 4660.6 6706.9 6717.9 6739.1 6741.3 6742.9 4754.7 4758.8 4761.8 4763.0 4768.8 4812.9 4814.6 4815.4 4822.8 4830.2 5466.8 5470.8 5477.6 5482.4 5490.9 6299.7 6486.4 6524.7 6525.4 6536.2 1619.5 1637.2 1640.6 1644.4 1650.0 1014.9 1047.1 1055.4 1075.2 1105.5 6252.9 6260.0 6330.8 6334.9 6340.6 6639.0 6643.3 6645.1 6652.8 6662.8 6308.7 6311.7 6317.6 6319.7 6323.4 3536.5 3594.2 3609.1 3612.8 3613.6 6770.1 6894.9 6902.9 6919.5 6924.9 6717.3 6745.2 6746.6 6748.5 6750.6 6895.3 6896.6 6898.2 6902.7 6908.4 6621.1 6629.3 6698.9 6700.7 6703.3 6395.2 6533.8 6550.3 6564.0 6564.5 6858.3 6893.1 6904.7 6907.9 6909.7 4627.2 4628.1 4629.0 4632.6 4643.5 6606.9 6616.3 6630.8 6703.6 6705.3 6262.6 6423.7 6444.7 6447.9 6450.2 6406.4 6425.9 6428.8 6432.3 6436.9 6321.0 6323.2 6329.7 6332.6 6338.4 6457.9 6467.2 6477.3 6480.8 6483.4 6148.0 6266.9 6274.7 6335.5 6340.6 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - PROCESS | 13914 | [#5] yui.html Cycles:180 Average:15241.14 Median:26688.26 stddev:17406.84 (65.2%) stddev-sans-first:17421.73 04:20:49 INFO - PROCESS | 13914 | Values: 766.6 784.0 788.8 802.1 810.3 13427.5 13621.5 13630.1 13694.9 13708.3 13142.8 13152.9 13183.0 13186.0 13277.2 772.5 869.9 905.6 907.3 928.0 916.4 921.6 922.4 922.5 922.7 935.8 942.7 951.7 952.4 953.4 795.9 813.1 948.3 951.3 954.7 704.0 709.3 710.1 710.2 710.6 12948.9 12963.5 13014.7 13028.2 13047.7 13315.8 13578.9 13739.7 13814.0 13949.2 11952.7 12013.2 12055.5 12131.5 12174.1 3959.1 3987.9 4011.9 4046.2 4107.8 52713.7 53189.2 53229.0 53549.5 53555.7 10278.3 10302.3 11822.3 11909.2 12292.1 19946.4 20146.1 20163.5 20174.0 20181.9 8887.2 9033.5 9134.9 9174.0 9242.0 5000.1 5032.8 5069.3 5131.5 5138.4 3434.2 3505.9 3507.1 3507.2 3511.8 571.7 675.8 681.3 682.4 682.9 739.0 767.7 777.2 778.9 784.2 9433.7 9590.4 9632.3 9797.8 9940.6 771.8 795.6 802.7 823.7 829.7 4269.7 4416.7 4782.0 4796.1 4796.5 60840.7 60959.7 63236.7 63952.0 64372.0 53777.0 54940.0 55266.7 55295.2 55365.4 50203.7 50630.2 50780.2 51483.5 51956.7 9442.7 9576.1 9599.0 9608.4 9658.8 37220.8 39064.8 39286.2 39393.8 40155.6 43832.8 48580.0 50528.5 51254.0 51276.0 11440.4 11501.5 11556.1 12663.8 12703.8 14007.4 14072.7 14333.9 14342.8 14626.3 12323.6 12790.7 13422.5 13878.7 13959.0 12926.5 13487.3 13637.9 13794.6 13813.3 13437.7 13557.7 13627.5 13635.9 13800.0 11358.5 11427.8 11491.9 11547.8 11660.5 10284.6 10551.5 10717.9 10764.7 10787.7 04:20:49 INFO - PROCESS | 13914 | -------- Summary: end -------- 04:20:49 INFO - PROCESS | 13914 | 04:20:49 INFO - TEST-INFO | 13914: exit 0 04:20:49 INFO - TEST-OK | dromaeo_css | took 1110725ms 04:20:49 INFO - TEST-START | kraken 04:20:49 INFO - operating with platform_type : linux_ 04:20:49 INFO - Initialising browser for kraken test... 04:20:49 INFO - TEST-INFO | started process 14108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxxCOf/profile http://localhost:52787/getInfo.html) 04:20:53 INFO - PROCESS | 14108 | __metrics Screen width/height:1600/1200 04:20:53 INFO - PROCESS | 14108 | colorDepth:24 04:20:53 INFO - PROCESS | 14108 | Browser inner width/height: 1024/697 04:20:53 INFO - PROCESS | 14108 | __metrics 04:20:54 INFO - PROCESS | 14108 | 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:54 ERROR - PROCESS | 14108 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:55 INFO - TEST-INFO | 14108: exit 0 04:20:55 INFO - Browser initialized. 04:20:55 INFO - Running cycle 1/1 for kraken test... 04:20:55 INFO - TEST-INFO | started process 14201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxxCOf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:07 INFO - PROCESS | 14201 | RSS: Main: 139685888 04:21:07 INFO - PROCESS | 14201 | 04:21:09 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52787/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:10 INFO - PROCESS | 14201 | RSS: Main: 198139904 04:21:10 INFO - PROCESS | 14201 | 04:21:13 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52787/tests/kraken/driver.html?testName=audio-dft) 04:21:14 INFO - PROCESS | 14201 | RSS: Main: 184606720 04:21:14 INFO - PROCESS | 14201 | 04:21:16 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52787/tests/kraken/driver.html?testName=audio-fft) 04:21:17 INFO - PROCESS | 14201 | RSS: Main: 272982016 04:21:17 INFO - PROCESS | 14201 | 04:21:19 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52787/tests/kraken/driver.html?testName=audio-oscillator) 04:21:20 INFO - PROCESS | 14201 | RSS: Main: 179109888 04:21:20 INFO - PROCESS | 14201 | 04:21:22 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52787/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:22 INFO - PROCESS | 14201 | RSS: Main: 177594368 04:21:22 INFO - PROCESS | 14201 | 04:21:25 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52787/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:26 INFO - PROCESS | 14201 | RSS: Main: 211976192 04:21:26 INFO - PROCESS | 14201 | 04:21:29 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52787/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:30 INFO - PROCESS | 14201 | RSS: Main: 212836352 04:21:30 INFO - PROCESS | 14201 | 04:21:33 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52787/tests/kraken/driver.html?testName=json-parse-financial) 04:21:33 INFO - PROCESS | 14201 | RSS: Main: 211922944 04:21:33 INFO - PROCESS | 14201 | 04:21:35 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52787/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:35 INFO - PROCESS | 14201 | RSS: Main: 193155072 04:21:35 INFO - PROCESS | 14201 | 04:21:37 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:38 INFO - PROCESS | 14201 | RSS: Main: 199135232 04:21:38 INFO - PROCESS | 14201 | 04:21:40 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:40 INFO - PROCESS | 14201 | RSS: Main: 209317888 04:21:40 INFO - PROCESS | 14201 | 04:21:43 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:43 INFO - PROCESS | 14201 | RSS: Main: 217378816 04:21:43 INFO - PROCESS | 14201 | 04:21:46 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:47 INFO - PROCESS | 14201 | RSS: Main: 214294528 04:21:47 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | Cycle 1(1): loaded http://localhost:52787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52787/tests/kraken/driver.html?testName=ai-astar) 04:21:48 INFO - PROCESS | 14201 | RSS: Main: 274907136 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | __start_tp_report 04:21:48 INFO - PROCESS | 14201 | _x_x_mozilla_page_load 04:21:48 INFO - PROCESS | 14201 | _x_x_mozilla_page_load_details 04:21:48 INFO - PROCESS | 14201 | |i|pagename|runs| 04:21:48 INFO - PROCESS | 14201 | |0;ai-astar;112;111;111;111;112;112;105;112;112;112 04:21:48 INFO - PROCESS | 14201 | |1;audio-beat-detection;164;125;156;182;123;153;158;135;180;126 04:21:48 INFO - PROCESS | 14201 | |2;audio-dft;160;160;161;161;162;161;162;162;160;160 04:21:48 INFO - PROCESS | 14201 | |3;audio-fft;76;75;77;182;76;76;76;76;180;75 04:21:48 INFO - PROCESS | 14201 | |4;audio-oscillator;92;91;158;93;93;92;150;92;93;150 04:21:48 INFO - PROCESS | 14201 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;117;117;116 04:21:48 INFO - PROCESS | 14201 | |6;imaging-darkroom;145;145;145;145;145;144;144;145;146;145 04:21:48 INFO - PROCESS | 14201 | |7;imaging-desaturate;95;94;94;95;94;94;94;93;94;95 04:21:48 INFO - PROCESS | 14201 | |8;json-parse-financial;55;54;56;55;56;64;56;74;52;52 04:21:48 INFO - PROCESS | 14201 | |9;json-stringify-tinderbox;57;60;57;57;58;58;57;58;58;58 04:21:48 INFO - PROCESS | 14201 | |10;stanford-crypto-aes;72;73;74;72;77;73;73;73;74;75 04:21:48 INFO - PROCESS | 14201 | |11;stanford-crypto-ccm;117;115;113;116;113;119;115;116;131;127 04:21:48 INFO - PROCESS | 14201 | |12;stanford-crypto-pbkdf2;159;165;166;161;168;163;159;162;170;161 04:21:48 INFO - PROCESS | 14201 | |13;stanford-crypto-sha256-iterative;66;68;67;65;66;68;65;67;66;65 04:21:48 INFO - PROCESS | 14201 | __end_tp_report 04:21:48 INFO - PROCESS | 14201 | __start_cc_report 04:21:48 INFO - PROCESS | 14201 | _x_x_mozilla_cycle_collect,1584 04:21:48 INFO - PROCESS | 14201 | __end_cc_report 04:21:48 INFO - PROCESS | 14201 | __startTimestamp1469618508932__endTimestamp 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | ------- Summary: start ------- 04:21:48 INFO - PROCESS | 14201 | Number of tests: 14 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.16 (1.9%) stddev-sans-first:2.26 04:21:48 INFO - PROCESS | 14201 | Values: 112.0 111.0 111.0 111.0 112.0 112.0 105.0 112.0 112.0 112.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:22.07 (14.1%) stddev-sans-first:22.84 04:21:48 INFO - PROCESS | 14201 | Values: 164.0 125.0 156.0 182.0 123.0 153.0 158.0 135.0 180.0 126.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 04:21:48 INFO - PROCESS | 14201 | Values: 160.0 160.0 161.0 161.0 162.0 161.0 162.0 162.0 160.0 160.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:44.33 (58.3%) stddev-sans-first:46.37 04:21:48 INFO - PROCESS | 14201 | Values: 76.0 75.0 77.0 182.0 76.0 76.0 76.0 76.0 180.0 75.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:29.25 (31.8%) stddev-sans-first:30.26 04:21:48 INFO - PROCESS | 14201 | Values: 92.0 91.0 158.0 93.0 93.0 92.0 150.0 92.0 93.0 150.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:21:48 INFO - PROCESS | 14201 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:21:48 INFO - PROCESS | 14201 | Values: 145.0 145.0 145.0 145.0 145.0 144.0 144.0 145.0 146.0 145.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:21:48 INFO - PROCESS | 14201 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 93.0 94.0 95.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:6.72 (12.0%) stddev-sans-first:7.07 04:21:48 INFO - PROCESS | 14201 | Values: 55.0 54.0 56.0 55.0 56.0 64.0 56.0 74.0 52.0 52.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 04:21:48 INFO - PROCESS | 14201 | Values: 57.0 60.0 57.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:1.51 (2.0%) stddev-sans-first:1.48 04:21:48 INFO - PROCESS | 14201 | Values: 72.0 73.0 74.0 72.0 77.0 73.0 73.0 73.0 74.0 75.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:116.50 stddev:6.03 (5.2%) stddev-sans-first:6.38 04:21:48 INFO - PROCESS | 14201 | Values: 117.0 115.0 113.0 116.0 113.0 119.0 115.0 116.0 131.0 127.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:3.75 (2.3%) stddev-sans-first:3.62 04:21:48 INFO - PROCESS | 14201 | Values: 159.0 165.0 166.0 161.0 168.0 163.0 159.0 162.0 170.0 161.0 04:21:48 INFO - PROCESS | 14201 | 04:21:48 INFO - PROCESS | 14201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 04:21:48 INFO - PROCESS | 14201 | Values: 66.0 68.0 67.0 65.0 66.0 68.0 65.0 67.0 66.0 65.0 04:21:48 INFO - PROCESS | 14201 | -------- Summary: end -------- 04:21:48 INFO - PROCESS | 14201 | 04:21:49 INFO - TEST-INFO | 14201: exit 0 04:21:49 INFO - TEST-OK | kraken | took 59958ms 04:21:49 INFO - SUITE-END | took 1170s 04:21:50 INFO - Completed test suite (00:19:30) 04:21:50 INFO - javascript benchmark 04:21:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.3828072666192, 3254.511823226516, 3277.3772983133217, 3309.6524864889184, 3334.816585087819, 5331.333583302087, 5346.064438723222, 5355.732213389334, 5361.812336568221, 5363.731813409334, 5324.7071411072375, 5385.35375754909, 5387.622866399353, 5391.78432862685, 5404.189371594262, 4760.143174228638, 4839.75801209939, 4925.162722337193, 4999.550040496355, 5014.548690617844, 4774.28385742138, 4890.682105663121, 4898.167311557026, 4915.164422048242, 4921.064997650435, 4850.563449289563, 4874.65877388583, 4897.51024897511, 4912.778924948368, 4926.11329960607, 4929.088118698052, 4948.307236986825, 4950.183219768734, 4951.183054795991, 4965.0, 4639.582437580634, 4782.091402633523, 4879.780409881564, 4884.633652476078, 4909.926351104737, 5229.790808367661, 5273.367195936512, 5288.947110528922, 5294.735263236823, 5295.629305948585, 5658.603897727161, 5721.0, 5723.198752174699, 5725.6278341908055, 5726.627769194989, 5558.221848941152, 5646.096624540095, 5657.066584013633, 5691.288588926384, 5751.137329400582, 5383.865403364908, 5393.460653934614, 5424.376196737347, 5435.864103397407, 5438.646487978348, 5740.1102829061565, 5870.618409803349, 5885.941140588625, 5901.0, 5901.557383196277, 5591.049521581341, 5627.268455100892, 5632.324121105494, 5645.5201307888465, 5676.574256930747, 5699.658020518782, 5703.62926409782, 5704.001799685038, 5707.771689132388, 5718.142278658234, 5611.6352437091455, 5671.234383358194, 5674.858128546737, 5688.77244910199, 5690.630109042899, 5664.773409063674, 5732.914006289909, 5736.053551164011, 5736.827895163152, 5773.018586840163, 4432.13573353193, 4439.511653718088, 4443.488998765119, 4450.421445212101, 4473.7986790594505, 3946.8815935521407, 3957.2085582883537, 4008.2584721826556, 4013.979930100331, 4053.3919912013434, 5495.065838807413, 5502.669839809544, 5516.834494965157, 5527.143292789624, 5528.115501519737, 5768.163616275617, 5785.103308987113, 5785.1611516329895, 5786.971065144648, 5794.015017447045, 5402.837914862561, 5447.863803404946, 5509.862253443615, 5517.393086760453, 5545.445455454503, 4984.127777638899, 4997.9500204997485, 5008.098542262355, 5008.424031236382, 5042.924356134661, 5938.703064846741, 5974.880502389928, 5987.281526216795, 5988.0, 5999.100134979788, 5656.377798442168, 5780.190773291659, 5849.94150058494, 5864.149698293809, 5874.735636896265, 5972.984592619178, 5975.521958243243, 5983.910241346296, 5986.551008674454, 5986.610870293591, 5517.062099443185, 5693.9430605693415, 5700.914486282626, 5703.030484817508, 5710.457506536873, 5703.315602127771, 5755.8561035974435, 5802.535797136304, 5812.3025236971835, 5848.035074212878, 5601.943980560305, 5613.719314034363, 5617.354004289396, 5619.129034999582, 5626.156076588544, 5482.17767334903, 5568.053430916835, 5605.159226116115, 5613.073842815889, 5615.691136987341, 5509.201165830852, 5521.917171242354, 5550.972245138749, 5553.416891226525, 5587.636803607753, 5648.774049037993, 5663.377028526941, 5667.518260947865, 5667.8866422672145, 5672.432756724294, 5478.260434841245, 5524.806631767869, 5551.555875530029, 5591.04952158126, 5609.887802244014], "value": 5312.984751789526, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.4684252597923, 667.8731041102191, 669.8593295407961, 671.6440286648078, 675.5710124071213, 32575.51136732948, 33181.50227746583, 39509.80245098771, 40105.7994710026, 40188.59811401885, 42800.0, 43126.353104703456, 43213.56786432143, 43309.7834510827, 43360.783196084056, 8115.553644549547, 8831.470111793296, 8958.507282099481, 9001.549922503882, 9005.639774409015, 10790.838137427905, 11081.335119892792, 11088.722781930435, 11091.667249982513, 11094.278871873343, 10432.478376081204, 10505.159587233004, 10565.154787616972, 10577.153827693766, 10584.78830423391, 10640.361578305288, 10703.83944240837, 10716.78566428667, 10719.624813131502, 10723.088537474325, 10459.372437653765, 10549.10332621728, 10554.050135487767, 10564.26050176488, 10569.894301056967, 42675.0, 43146.0, 43149.56850431487, 43169.56830431718, 43186.78406607978, 3656.378415669316, 3670.229251857113, 3706.5181526401666, 3921.725479216456, 4095.4075336865203, 32733.345333093443, 33115.0, 33291.33417331664, 33729.32541349184, 34707.0, 4345.348197770328, 4471.709338892962, 4474.709143905636, 4504.324351347292, 4548.067646132535, 323160.0, 323953.0, 324195.0, 324764.0, 325056.0, 39954.20091598152, 61072.38927610756, 61283.0, 61550.69224653938, 61672.69163654153, 37269.25461490755, 37460.25079498395, 37463.812680936964, 37465.62534374676, 37491.25017499635, 17607.911960440117, 17757.7336339955, 17771.378001769877, 17779.555511112325, 17780.91109544444, 13576.321183940763, 13866.445342186402, 14274.785878211835, 14469.565913022627, 14998.850011499964, 9200.81598368029, 9236.399634023766, 9250.86123708145, 9293.0, 9303.906960930304, 3514.139035936161, 3584.444411116281, 3595.9640403596154, 3597.686844301811, 3676.871309504208, 994.945278009702, 1108.0, 1163.7032556697989, 1173.7887180307628, 1184.7630473905253, 31871.68128318687, 32838.67161328404, 32899.835500822344, 33089.3382132356, 33889.322213556086, 1110.348327015495, 1180.3744015671707, 1189.4944648524342, 1265.2282107914166, 1290.3870661435742, 14912.850871491146, 17454.91272543629, 17595.0, 17726.556836078944, 17855.0, 363690.0, 369746.0, 369755.0, 369850.0, 372095.0, 55124.0, 55567.722161388934, 55605.44394556003, 55704.0, 55833.162502562496, 1394.8884089273038, 1492.7387707151206, 1499.242882344409, 1561.5783738390571, 1640.0323808952776, 28868.27829304284, 29558.113256602337, 29790.851045744632, 30151.698483015767, 30387.696123038488, 44421.55578444174, 44714.77642611766, 44720.0, 44765.65703028914, 44837.32744008908, 300547.0, 304291.0, 306834.0, 307268.0, 307558.0, 27099.1870243893, 29974.850125750105, 30826.69173308238, 30927.84536077305, 31046.53430198594, 47130.764346178046, 47460.288095677904, 47630.0, 48058.27912581244, 48086.759566201945, 38425.6157438422, 39383.21233575255, 39734.0, 40339.596604033584, 40510.59489405068, 37944.0, 38092.619073808906, 38363.23273534569, 42724.5727542733, 43333.167107166264, 41582.376264356666, 41985.79007104945, 42042.57957420387, 42258.57741422547, 42823.0, 35493.0, 35745.642543574235, 36624.08439789026, 37004.25991480101, 37098.8145059273, 28126.85936570304, 28332.71667283383, 28342.43315133727, 28701.85649071741, 28742.425151496434], "value": 19238.866221970875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.90574620710345, 426.47969477237757, 427.7454914325975, 438.89466528033273, 440.2471773267712, 18297.17662705178, 19023.714644280346, 19045.047747612614, 19246.80753192468, 20048.29830955917, 12724.936375318133, 12813.615591532269, 12898.355082245896, 12980.28608426536, 13052.869471305308, 5229.660072095311, 5438.564914806806, 5457.290552228204, 5476.315460567429, 5483.533899618517, 4020.5376381716037, 4114.547399786021, 5369.19462080689, 5789.681567513785, 6033.27600687918, 5995.130706047642, 6002.0, 6032.336442991267, 6038.0, 6039.456448919596, 5838.970805145968, 6492.285848556655, 6497.675116244216, 6499.837504062389, 6501.707423165945, 3978.781167035812, 5615.634983726086, 5833.504152147073, 5849.85375365615, 5859.648421094748, 14005.159690418608, 14017.789733154012, 14123.505677301348, 17580.560485987953, 22459.438514037116, 2303.8502497337618, 2405.9639105413435, 2408.89159987801, 2422.588160012802, 2429.4898071405028, 10376.325538839952, 10449.634262800766, 10674.519646615843, 10860.891391086067, 13881.097728647606, 1972.5265936175358, 2047.4471892589067, 2096.874187548752, 2105.5788842231464, 2110.873347599149, 74772.0, 75584.0, 77876.0, 79737.60131199307, 81005.59497202536, 11046.834297485544, 11315.434228288552, 11490.885091149148, 11532.827007594893, 11708.88291117095, 16240.431584894472, 16286.26711797972, 16341.101239431946, 16370.263338149574, 16393.59016024609, 8818.162274583905, 9020.458772473672, 9080.818383632422, 9148.817023659623, 9161.221296189899, 8608.870866936875, 8691.869621955675, 9050.230730387859, 9063.81872362549, 9087.81824363509, 4952.430470495867, 4986.626003049786, 5017.347744793154, 5035.546800787946, 5076.873078173001, 1827.6853124984425, 2011.8088781565727, 2012.2252932621047, 2118.142152428238, 2154.1706443019552, 1019.4698756646502, 1030.7371620236793, 1055.2244100586063, 1088.7223757941674, 1124.454639499842, 17943.282268709365, 18839.71740423895, 18868.33960811365, 19059.42821715351, 19661.90169049174, 1000.314784372707, 1063.106990128296, 1070.464767616192, 1084.1814430105378, 1088.482970588964, 10698.358098514114, 10949.41233521135, 11003.61487347939, 11019.449027548591, 11040.723981900355, 513399.0, 514479.0, 521560.0, 524402.0, 526449.0, 86548.5672571633, 89843.55078224567, 89955.65066524007, 90829.0, 92107.0, 1091.748897753521, 1125.6060378867494, 1142.057802313095, 1150.0569532982875, 1155.0990227622467, 17326.047067411415, 17430.91284543569, 17470.912645436692, 17486.650266994842, 17702.468925932244, 25064.37339066465, 25810.741892581584, 32749.0, 38864.417033745085, 39078.6092139075, 58130.418695814195, 58207.0, 58210.70894645499, 58401.0, 58456.70771646115, 8619.784505387415, 8796.60415281301, 8932.419392739452, 9100.044495327895, 9121.680741174026, 12674.746505069663, 12881.291528965998, 12889.613311600668, 12976.15654982423, 12988.48046078184, 11141.0, 11348.943255284, 11413.828792567952, 11442.084633229488, 11489.770204595694, 11178.217524773188, 11234.269772464764, 11238.0, 11310.773784524428, 11420.600278990196, 11433.714157146138, 11546.826797597874, 11662.650120496399, 12144.392780361124, 12203.877961220274, 8803.427777194718, 8883.511406872425, 8891.0, 9015.81968360616, 9146.95426522863, 10980.615678451215, 11684.70788230301, 11732.41337933117, 11831.0, 11980.0], "value": 9194.243107776832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.9859801401983, 1549.1170033081141, 1570.6858628274344, 1748.2569907789186, 1896.516388320978, 7216.530925489839, 7769.961150194248, 7901.130875603679, 7907.525548467096, 7914.406419518545, 7740.303372696456, 7919.168487308836, 7919.445638805286, 7928.5242885426915, 7935.484193527417, 2284.64587988862, 2316.918907838226, 2321.3732292281156, 2325.8953347099423, 2326.81332520415, 2276.4536511237347, 2318.5594737, 2390.127603424755, 2392.2942731894045, 2406.0, 2309.9191528296515, 2328.75548067453, 2344.2732752846673, 2348.1311914591624, 2360.7285162206394, 2295.3114065780364, 2321.3964369264027, 2322.6399908014287, 2325.848819826706, 2367.7277113132036, 2320.2691152286975, 2330.207729372005, 2333.428310064028, 2338.0, 2343.589871772433, 7697.461177717562, 7856.25365590268, 8010.959945200295, 8030.39772017101, 8044.839103217902, 4956.157453232959, 5101.362329708786, 5102.285680004802, 5115.181570948667, 5119.641625086246, 3336.7163791077787, 3351.329734053199, 3352.2960178362573, 3374.207061340583, 3397.9320413591836, 1095.5727266366123, 1125.5779082843933, 1125.7692173104494, 1136.8351589019628, 1139.8176291793357, 11016.11871050314, 11172.553097876074, 11176.329420234812, 11184.161187910859, 11220.49507772144, 4337.414449049401, 4337.566243375637, 4414.933775993362, 4451.821927122944, 4494.438195225597, 9619.951900240594, 9702.27232957531, 9713.125818676353, 9729.41623502578, 9735.70792876215, 5097.515736005148, 5126.359205099363, 5132.9743351283005, 5133.640645154804, 5133.8716532087, 4027.073773032219, 4093.2222877653153, 4483.439570053743, 4586.6789324747615, 4693.6949098308505, 3929.0, 4033.5882441145363, 4052.696047796427, 4069.593040695907, 4156.56356082613, 1240.7580521798343, 1251.249250449723, 1252.8872401483911, 1254.3477391756235, 1264.4878824076263, 1027.912627426677, 1035.3477309295097, 1046.7487802927394, 1079.7354648111263, 1080.3679847289266, 5775.88448231033, 5841.094630332305, 5855.795047173328, 5994.6403215807195, 6047.788327408608, 471.1284124369888, 471.19660978032374, 486.07645473599734, 490.6124161912121, 490.85274417674555, 3990.920181596352, 3998.6001399859783, 4060.6548443382053, 4078.3270760324212, 4079.1229885574744, 9336.626534938527, 9486.667966621135, 9488.715338539854, 9505.0, 9590.472524011107, 9417.293702972305, 9425.67010154655, 9468.431894086378, 9472.242220622335, 9492.240620750323, 7635.809104772425, 7740.729074482366, 7745.031871016123, 7745.806354841174, 7755.108162561265, 5429.728513574227, 5590.916136257878, 5620.241267428844, 5725.51333136688, 5763.971180144073, 8527.317814574695, 8569.742907712778, 8726.301895848444, 8909.465432074096, 8975.865362019706, 8646.265067469336, 8800.33997450181, 8810.955945220232, 8843.734687959372, 8866.822663546822, 6579.144711187515, 6942.757003505055, 7081.114860642419, 7181.317774811385, 7313.48805583604, 7691.538507689556, 7729.227077292226, 7795.415343849348, 7797.064352277763, 7807.414443916842, 6924.515283930076, 7116.50184487081, 7123.358897699025, 7180.281971802778, 7227.49407541467, 7030.824229394306, 7036.718531258693, 7068.858622827412, 7133.037039999534, 7134.143902731706, 6417.422431981144, 6611.404973552403, 6629.569078009914, 6636.933630663824, 6733.93266067333, 4962.280469331855, 5020.171671674133, 5026.547610715053, 5053.418856831511, 5144.125498665311, 5167.020583540088, 5193.324867767166, 5224.8900913088855, 5310.7875684973715, 5353.946460535345], "value": 4353.71492988561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9414346632806, 358.81700332830263, 362.53052297275025, 366.49972787145555, 369.4015694574789, 6133.20268365113, 6143.385661433855, 6154.323024467305, 6163.229596300468, 6169.105479705446, 6154.446099851012, 6158.507319414447, 6169.7532098716, 6187.288461826891, 6189.938100618992, 4551.795169217385, 4641.141388843075, 4716.4340279166545, 4720.197566413718, 4738.265568836836, 4719.764011799413, 4730.810767569293, 4746.264329029006, 4762.404699412574, 4765.166095933215, 4536.841210557631, 4729.408823897013, 4731.337612734203, 4738.857834264978, 4742.193827049393, 4611.446626404836, 4694.037722266927, 4694.29585562165, 4706.987997580537, 4731.432228132646, 4177.665786737054, 4187.685923555746, 4191.371294305848, 4195.937060944088, 4196.706230563862, 5903.881922361528, 5910.320313163998, 5916.615419997729, 5918.763249470016, 5920.703964801785, 5484.122540393558, 5490.286262785812, 5492.670439773587, 5496.038193316193, 5510.118381059051, 6393.520485963525, 6456.967715161441, 6465.3534646535445, 6465.4827613790785, 6512.348765123497, 4624.190766615829, 4626.745528995903, 4660.0, 4660.067986402733, 4660.557247061523, 6706.9329306706795, 6717.932820671828, 6739.135867256446, 6741.292164322725, 6742.865142697167, 4754.690945088627, 4758.78585463655, 4761.809527618856, 4762.9523704762505, 4768.76156192196, 4812.879678008007, 4814.638902082358, 4815.374001379868, 4822.758862056883, 4830.154722923475, 5466.808661696821, 5470.8085217017215, 5477.643953143112, 5482.424345443751, 5490.862728431821, 6299.6535190564955, 6486.351364863476, 6524.67376631176, 6525.3800888915475, 6536.182977127859, 1619.5465269724496, 1637.2059551117698, 1640.6226567889453, 1644.4080131152775, 1649.9605248693485, 1014.9492525373702, 1047.1361127070045, 1055.4353420919772, 1075.2312096850633, 1105.4693747001484, 6252.874942501125, 6260.0, 6330.841728956813, 6334.873302534015, 6340.587861789061, 6638.966805165944, 6643.335666433415, 6645.06969024337, 6652.800415987528, 6662.766803161866, 6308.7476500940365, 6311.715972781236, 6317.5893566918, 6319.684015799284, 6323.36766323364, 3536.5402497675136, 3594.2092739597247, 3609.0616439725336, 3612.7832330060282, 3613.584437789635, 6770.086038384755, 6894.931050689529, 6902.8619427612175, 6919.515633905578, 6924.896126558106, 6717.294684058202, 6745.156855393076, 6746.595204287759, 6748.527603067836, 6750.594964302158, 6895.275996020446, 6896.586204827727, 6898.206706228848, 6902.723891044402, 6908.412784913338, 6621.139251897415, 6629.337066293332, 6698.933010669831, 6700.6984685688285, 6703.262641109572, 6395.232572091379, 6533.803985880431, 6550.312217217123, 6564.048213008991, 6564.5076619254705, 6858.279880612663, 6893.138357705287, 6904.689288981907, 6907.861842763217, 6909.723611055501, 4627.167109920247, 4628.051249493913, 4628.9537104628525, 4632.629389648752, 4643.466001409881, 6606.8678626426245, 6616.338366163538, 6630.83422914431, 6703.564268322543, 6705.262421133574, 6262.624242545279, 6423.743050277936, 6444.709988050456, 6447.903281450688, 6450.193725784277, 6406.359364063556, 6425.8714825704155, 6428.774992875414, 6432.292447830641, 6436.935630643821, 6321.0, 6323.177986861679, 6329.670769138348, 6332.588381755171, 6338.429541341301, 6457.903131453126, 6467.223933128054, 6477.319881412573, 6480.837979050561, 6483.416492515507, 6147.96926015385, 6266.937330626818, 6274.686265686789, 6335.461485773761, 6340.619562826245], "value": 4914.022562973581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.6358479722131, 783.9925695481307, 788.7830846517211, 802.0896282719116, 810.3436216664502, 13427.462901483941, 13621.523246686367, 13630.114042587238, 13694.931525342385, 13708.314584270796, 13142.802857957115, 13152.868471315283, 13183.0, 13186.0, 13277.20336779794, 772.5364781131304, 869.9217070463673, 905.6060613633058, 907.2651152566409, 928.0348437624862, 916.3631276263, 921.6451666108529, 922.3543519536317, 922.5064590444114, 922.6816748221886, 935.794125292438, 942.7218970403713, 951.6907005223295, 952.3571589177278, 953.3517208298355, 795.8965334506535, 813.1258896686056, 948.33616468472, 951.3007939164709, 954.7183580843667, 703.9964800175966, 709.3155105323336, 710.1017213225274, 710.2187593646998, 710.5985118408083, 12948.935255323662, 12963.546275880299, 13014.674633134247, 13028.218306901521, 13047.739045219138, 13315.800262996063, 13578.932105339509, 13739.656508587266, 13814.0, 13949.217502395426, 11952.70118247042, 12013.219140755911, 12055.517779288817, 12131.514739410413, 12174.086943479186, 3959.1487830116375, 3987.8803635890968, 4011.859584914514, 4046.2312160689376, 4107.753534787922, 52713.7364313176, 53189.2021619676, 53229.0, 53549.46450535523, 53555.732221339036, 10278.280520363653, 10302.33034852732, 11822.290662560274, 11909.22590031645, 12292.139550231397, 19946.401607951786, 20146.093425795876, 20163.495912602302, 20174.0, 20181.899090504452, 8887.200151986352, 9033.548322583845, 9134.858142732159, 9174.0, 9241.983381827993, 5000.14997450427, 5032.823851165192, 5069.264956581275, 5131.512506311894, 5138.3833939927445, 3434.227298857737, 3505.8772942946875, 3507.0881570791776, 3507.2459421224557, 3511.8244087795506, 571.6958082003541, 675.8377989282635, 681.2744427185032, 682.4301708073715, 682.8668409660069, 739.0, 767.7005967672612, 777.2033665492802, 778.9493682910706, 784.2001158818088, 9433.669821556212, 9590.376625519319, 9632.325737198329, 9797.80404391908, 9940.552675129637, 771.753039027517, 795.550513959611, 802.6548584108773, 823.6993497373535, 829.668132746894, 4269.658427325807, 4416.712913660602, 4781.976090119527, 4796.136695394863, 4796.5203479651755, 60840.69579652162, 60959.69520152371, 63236.68381658154, 63952.0, 64372.0, 53777.0, 54940.0, 55266.72366638141, 55295.17057244144, 55365.44634553603, 50203.74898125486, 50630.24054639183, 50780.23829642558, 51483.48516514787, 51956.74021629943, 9442.669506567237, 9576.090271424204, 9599.0, 9608.375455595364, 9658.75853103678, 37220.81389593035, 39064.80467597644, 39286.2142757149, 39393.80303098466, 40155.59844401519, 43832.78083609562, 48580.0, 50528.49471505238, 51253.97492050213, 51276.0, 11440.427978601203, 11501.53993840237, 11556.133290003452, 12663.810042849549, 12703.80944285855, 14007.369668365152, 14072.718545629235, 14333.856661433669, 14342.784858227344, 14626.268686565842, 12323.568675096687, 12790.74418511606, 13422.530211442552, 13878.653033674238, 13959.041325261845, 12926.547570835352, 13487.25820079905, 13637.863621364057, 13794.586162415144, 13813.309334533435, 13437.731245375233, 13557.728845422838, 13627.523036694065, 13635.86364136346, 13800.0, 11358.488868000795, 11427.828582571101, 11491.922395065978, 11547.769044619228, 11660.475278612314, 10284.640037598649, 10551.515962587771, 10717.9464102679, 10764.677059688222, 10787.730306742395], "value": 7054.258183411358, "unit": "score"}], "name": "dromaeo_css", "value": 7221.661931923129, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 111.0, 112.0, 112.0, 105.0, 112.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 125.0, 156.0, 182.0, 123.0, 153.0, 158.0, 135.0, 180.0, 126.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 182.0, 76.0, 76.0, 76.0, 76.0, 180.0, 75.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 158.0, 93.0, 93.0, 92.0, 150.0, 92.0, 93.0, 150.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 144.0, 145.0, 146.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 55.0, 56.0, 64.0, 56.0, 74.0, 52.0, 52.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 72.0, 77.0, 73.0, 73.0, 73.0, 74.0, 75.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 116.0, 113.0, 119.0, 115.0, 116.0, 131.0, 127.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 166.0, 161.0, 168.0, 163.0, 159.0, 162.0, 170.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 65.0, 66.0, 68.0, 65.0, 67.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1521.7, "alertThreshold": 2.0}]} 04:21:50 INFO - Return code: 0 04:21:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:50 ERROR - # TBPL SUCCESS # 04:21:50 INFO - Running post-action listener: _resource_record_post_action 04:21:50 INFO - Running post-run listener: _resource_record_post_run 04:21:51 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 463425536; Read time: 36; Write time: 370908 04:21:51 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242204672; Read time: 0; Write time: 260136 04:21:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 214237184; Read time: 16; Write time: 108676 04:21:51 INFO - Running post-run listener: _upload_blobber_files 04:21:51 INFO - Blob upload gear active. 04:21:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:51 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:51 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:51 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:52 INFO - (blobuploader) - INFO - Done attempting. 04:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:53 INFO - (blobuploader) - INFO - Done attempting. 04:21:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:53 INFO - Return code: 0 04:21:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45703113b3d90bdedec6396dee16fbe93ee3652496a12149ec2a0df269e7e9bf7760cdcbb8596fe4626bb9ce937dc30c3b10ed5a2a9a4b461a0c9aada8f350a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b7c1b3e8489b5cdbee7768fcf8584337ad595e3efd2c4c1fd4ff642010a9e626a628a767c276c2471455806a62911db6f829468338ee543b311a17d236e26ee"} 04:21:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:53 INFO - Contents: 04:21:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45703113b3d90bdedec6396dee16fbe93ee3652496a12149ec2a0df269e7e9bf7760cdcbb8596fe4626bb9ce937dc30c3b10ed5a2a9a4b461a0c9aada8f350a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b7c1b3e8489b5cdbee7768fcf8584337ad595e3efd2c4c1fd4ff642010a9e626a628a767c276c2471455806a62911db6f829468338ee543b311a17d236e26ee"} 04:21:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:53 INFO - Copying logs to upload dir... 04:21:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.266599 ========= master_lag: 3.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-27 04:21:56.607396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.610629) ========= 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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 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/45703113b3d90bdedec6396dee16fbe93ee3652496a12149ec2a0df269e7e9bf7760cdcbb8596fe4626bb9ce937dc30c3b10ed5a2a9a4b461a0c9aada8f350a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b7c1b3e8489b5cdbee7768fcf8584337ad595e3efd2c4c1fd4ff642010a9e626a628a767c276c2471455806a62911db6f829468338ee543b311a17d236e26ee"} 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.011306 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/45703113b3d90bdedec6396dee16fbe93ee3652496a12149ec2a0df269e7e9bf7760cdcbb8596fe4626bb9ce937dc30c3b10ed5a2a9a4b461a0c9aada8f350a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b7c1b3e8489b5cdbee7768fcf8584337ad595e3efd2c4c1fd4ff642010a9e626a628a767c276c2471455806a62911db6f829468338ee543b311a17d236e26ee"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.760546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.760913) ========= 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=d2a8c569965ab8367867b893000001a1-1469617286.137355-919252908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.777689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:56.778042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:56.778371) ========= ========= Total master_lag: 3.90 =========