builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1468962115.08 results: success (0) buildid: 20160719110521 builduid: b50f924069754df69847add88ada5d36 revision: 55cd3b01ca013495afc1f583e4eb9a9392199025 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.080601) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.081087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.081397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.116044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.116341) ========= 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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 14:01:55-- 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% 145M=0s 2016-07-19 14:01:55 (145 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.257281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.257659) ========= 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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.309422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.309772) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 55cd3b01ca013495afc1f583e4eb9a9392199025 --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 55cd3b01ca013495afc1f583e4eb9a9392199025 --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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 14:01:55,612 truncating revision to first 12 chars 2016-07-19 14:01:55,612 Setting DEBUG logging. 2016-07-19 14:01:55,612 attempt 1/10 2016-07-19 14:01:55,612 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/55cd3b01ca01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 14:01:55,921 unpacking tar archive at: mozilla-beta-55cd3b01ca01/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.015763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.016079) ========= script_repo_revision: 55cd3b01ca013495afc1f583e4eb9a9392199025 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.016468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.016772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.728465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-19 14:01:56.728772) ========= /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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:57 INFO - MultiFileLogger online at 20160719 14:01:57 in /builds/slave/test 14:01:57 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 14:01:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:57 INFO - {'append_to_log': False, 14:01:57 INFO - 'base_work_dir': '/builds/slave/test', 14:01:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:01:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:57 INFO - 'branch': 'Mozilla-Beta', 14:01:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:57 INFO - 'config_files': ('talos/linux_config.py',), 14:01:57 INFO - 'default_actions': ('clobber', 14:01:57 INFO - 'read-buildbot-config', 14:01:57 INFO - 'download-and-extract', 14:01:57 INFO - 'populate-webroot', 14:01:57 INFO - 'create-virtualenv', 14:01:57 INFO - 'install', 14:01:57 INFO - 'run-tests'), 14:01:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:57 INFO - 'download_minidump_stackwalk': True, 14:01:57 INFO - 'download_symbols': 'ondemand', 14:01:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:57 INFO - 'installer_path': 'installer.exe', 14:01:57 INFO - 'log_level': 'info', 14:01:57 INFO - 'log_name': 'talos', 14:01:57 INFO - 'log_to_console': True, 14:01:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:57 INFO - 'opt_config_files': (), 14:01:57 INFO - 'pip_index': False, 14:01:57 INFO - 'sps_profile': False, 14:01:57 INFO - 'sps_profile_interval': 0, 14:01:57 INFO - 'suite': 'dromaeojs', 14:01:57 INFO - 'system_bits': '32', 14:01:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:57 INFO - 'title': 'talos-linux64-ix-038', 14:01:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:57 INFO - 'use_talos_json': True, 14:01:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:57 INFO - 'work_dir': 'build'} 14:01:57 INFO - ##### 14:01:57 INFO - ##### Running clobber step. 14:01:57 INFO - ##### 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: clobber 14:01:57 INFO - rmtree: /builds/slave/test/build 14:01:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - ##### 14:01:57 INFO - ##### Running read-buildbot-config step. 14:01:57 INFO - ##### 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: read_buildbot_config 14:01:57 INFO - Using buildbot properties: 14:01:57 INFO - { 14:01:57 INFO - "project": "", 14:01:57 INFO - "product": "firefox", 14:01:57 INFO - "script_repo_revision": "production", 14:01:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:01:57 INFO - "repository": "", 14:01:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:01:57 INFO - "buildid": "20160719110521", 14:01:57 INFO - "pgo_build": "True", 14:01:57 INFO - "basedir": "/builds/slave/test", 14:01:57 INFO - "buildnumber": 179, 14:01:57 INFO - "slavename": "talos-linux64-ix-038", 14:01:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:01:57 INFO - "platform": "ubuntu64_hw", 14:01:57 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:01:57 INFO - "branch": "mozilla-beta", 14:01:57 INFO - "repo_path": "releases/mozilla-beta", 14:01:57 INFO - "revision": "55cd3b01ca013495afc1f583e4eb9a9392199025", 14:01:57 INFO - "stage_platform": "linux64-pgo", 14:01:57 INFO - "builduid": "b50f924069754df69847add88ada5d36", 14:01:57 INFO - "slavebuilddir": "test" 14:01:57 INFO - } 14:01:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - ##### 14:01:57 INFO - ##### Running download-and-extract step. 14:01:57 INFO - ##### 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: download_and_extract 14:01:57 INFO - mkdir: /builds/slave/test/build/tests 14:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:57 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:01 INFO - Downloaded 1327 bytes. 14:02:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:02:01 INFO - Using the following test package requirements: 14:02:01 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:02:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:01 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:02:01 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'jsshell-linux-x86_64.zip'], 14:02:01 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:01 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:02:01 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:02:01 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:02:01 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:01 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14: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')]} 14:02:01 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:06 INFO - Downloaded 24200392 bytes. 14:02:06 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'] 14:02:06 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 14:02:08 INFO - Return code: 0 14:02:08 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 14:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:08 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:09 INFO - Downloaded 24200392 bytes. 14:02:09 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'] 14:02:09 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 14:02:10 INFO - Return code: 0 14:02:10 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')]} 14:02:10 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:12 INFO - Downloaded 10840145 bytes. 14:02:12 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'] 14:02:12 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 14:02:12 INFO - Return code: 0 14:02:12 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')]} 14:02:12 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/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 14:02:27 INFO - Downloaded 56031661 bytes. 14:02:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:27 INFO - mkdir: /builds/slave/test/properties 14:02:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:27 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:27 INFO - Contents: 14:02:27 INFO - build_url:https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - Running post-action listener: set_extra_try_arguments 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running populate-webroot step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: populate_webroot 14:02:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:27 INFO - '--tppagecycles', 14:02:27 INFO - '7'], 14:02:27 INFO - 'tests': ['tsvgm']}}, 14:02:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['damp', 'tps']}, 14:02:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'tests': ['damp', 'tps']}, 14:02:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['dromaeo_dom']}, 14:02:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['a11yr', 14:02:27 INFO - 'ts_paint', 14:02:27 INFO - 'tpaint', 14:02:27 INFO - 'sessionrestore', 14:02:27 INFO - 'sessionrestore_no_auto_restore', 14:02:27 INFO - 'tabpaint']}, 14:02:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['tsvgx', 14:02:27 INFO - 'tsvgr_opacity', 14:02:27 INFO - 'tart', 14:02:27 INFO - 'tscrollx', 14:02:27 INFO - 'cart']}, 14:02:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:27 INFO - 'tsvgr_opacity', 14:02:27 INFO - 'tart', 14:02:27 INFO - 'tscrollx', 14:02:27 INFO - 'cart']}, 14:02:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'talos_options': ['--disable-e10s'], 14:02:27 INFO - 'tests': ['tp5o']}, 14:02:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'tests': ['tp5o']}, 14:02:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'talos_options': ['--disable-e10s', 14:02:27 INFO - '--xperf_path', 14:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:27 INFO - 'tests': ['tp5n']}, 14:02:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:27 INFO - 'talos_options': ['--xperf_path', 14:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:27 INFO - 'tests': ['tp5n']}}, 14:02:27 INFO - 'talos.zip': {'path': '', 14:02:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running create-virtualenv step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: create_virtualenv 14:02:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:27 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 14:02:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:27 INFO - Using real prefix '/usr' 14:02:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:30 INFO - Installing pip.................done. 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:30 INFO - Using env: {'DISPLAY': ':0', 14:02:30 INFO - 'HOME': '/home/cltbld', 14:02:30 INFO - 'LANG': 'en_US.UTF-8', 14:02:30 INFO - 'LANGUAGE': 'en_US:en', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MAIL': '/var/mail/cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SHLVL': '1', 14:02:30 INFO - 'TERM': 'linux', 14:02:30 INFO - 'TMOUT': '86400', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - '_': '/tools/buildbot/bin/python'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 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 14:02:30 INFO - Cleaning up... 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:02:30 INFO - Using env: {'DISPLAY': ':0', 14:02:30 INFO - 'HOME': '/home/cltbld', 14:02:30 INFO - 'LANG': 'en_US.UTF-8', 14:02:30 INFO - 'LANGUAGE': 'en_US:en', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MAIL': '/var/mail/cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SHLVL': '1', 14:02:30 INFO - 'TERM': 'linux', 14:02:30 INFO - 'TMOUT': '86400', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - '_': '/tools/buildbot/bin/python'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 INFO - Downloading/unpacking psutil>=0.7.1 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:30 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 14:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:33 INFO - Installing collected packages: psutil 14:02:33 INFO - Running setup.py install for psutil 14:02:33 INFO - building 'psutil._psutil_linux' extension 14:02:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:02:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:02:33 INFO - building 'psutil._psutil_posix' extension 14:02:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:02:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:33 INFO - Successfully installed psutil 14:02:33 INFO - Cleaning up... 14:02:33 INFO - Return code: 0 14:02:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:02:33 INFO - Using env: {'DISPLAY': ':0', 14:02:33 INFO - 'HOME': '/home/cltbld', 14:02:33 INFO - 'LANG': 'en_US.UTF-8', 14:02:33 INFO - 'LANGUAGE': 'en_US:en', 14:02:33 INFO - 'LOGNAME': 'cltbld', 14:02:33 INFO - 'MAIL': '/var/mail/cltbld', 14:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:33 INFO - 'MOZ_NO_REMOTE': '1', 14:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:33 INFO - 'NO_EM_RESTART': '1', 14:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:33 INFO - 'PWD': '/builds/slave/test', 14:02:33 INFO - 'SHELL': '/bin/bash', 14:02:33 INFO - 'SHLVL': '1', 14:02:33 INFO - 'TERM': 'linux', 14:02:33 INFO - 'TMOUT': '86400', 14:02:33 INFO - 'USER': 'cltbld', 14:02:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:33 INFO - '_': '/tools/buildbot/bin/python'} 14:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:02:35 INFO - Installing collected packages: mozsystemmonitor 14:02:35 INFO - Running setup.py install for mozsystemmonitor 14:02:35 INFO - Successfully installed mozsystemmonitor 14:02:35 INFO - Cleaning up... 14:02:35 INFO - Return code: 0 14:02:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:35 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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:35 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 14:02:35 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 14:02:35 INFO - Using env: {'DISPLAY': ':0', 14:02:35 INFO - 'HOME': '/home/cltbld', 14:02:35 INFO - 'LANG': 'en_US.UTF-8', 14:02:35 INFO - 'LANGUAGE': 'en_US:en', 14:02:35 INFO - 'LOGNAME': 'cltbld', 14:02:35 INFO - 'MAIL': '/var/mail/cltbld', 14:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:35 INFO - 'MOZ_NO_REMOTE': '1', 14:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:35 INFO - 'NO_EM_RESTART': '1', 14:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:35 INFO - 'PWD': '/builds/slave/test', 14:02:35 INFO - 'SHELL': '/bin/bash', 14:02:35 INFO - 'SHLVL': '1', 14:02:35 INFO - 'TERM': 'linux', 14:02:35 INFO - 'TMOUT': '86400', 14:02:35 INFO - 'USER': 'cltbld', 14:02:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:35 INFO - '_': '/tools/buildbot/bin/python'} 14:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:38 INFO - Downloading docopt-0.6.1.tar.gz 14:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:39 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:39 INFO - Running setup.py install for blobuploader 14:02:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:39 INFO - Running setup.py install for requests 14:02:39 INFO - Running setup.py install for docopt 14:02:39 INFO - Successfully installed blobuploader requests docopt 14:02:39 INFO - Cleaning up... 14:02:39 INFO - Return code: 0 14:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:39 INFO - Using env: {'DISPLAY': ':0', 14:02:39 INFO - 'HOME': '/home/cltbld', 14:02:39 INFO - 'LANG': 'en_US.UTF-8', 14:02:39 INFO - 'LANGUAGE': 'en_US:en', 14:02:39 INFO - 'LOGNAME': 'cltbld', 14:02:39 INFO - 'MAIL': '/var/mail/cltbld', 14:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:39 INFO - 'MOZ_NO_REMOTE': '1', 14:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:39 INFO - 'NO_EM_RESTART': '1', 14:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:39 INFO - 'PWD': '/builds/slave/test', 14:02:39 INFO - 'SHELL': '/bin/bash', 14:02:39 INFO - 'SHLVL': '1', 14:02:39 INFO - 'TERM': 'linux', 14:02:39 INFO - 'TMOUT': '86400', 14:02:39 INFO - 'USER': 'cltbld', 14:02:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:39 INFO - '_': '/tools/buildbot/bin/python'} 14:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:39 INFO - Running setup.py (path:/tmp/pip-CWv0EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:39 INFO - Running setup.py (path:/tmp/pip-i7j98T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:40 INFO - Running setup.py (path:/tmp/pip-lRNxjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:40 INFO - Running setup.py (path:/tmp/pip-Mp9Shc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:40 INFO - Running setup.py (path:/tmp/pip-rHn0dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:40 INFO - Running setup.py (path:/tmp/pip-dCohp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:40 INFO - Running setup.py (path:/tmp/pip-UUj54e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:40 INFO - Running setup.py (path:/tmp/pip-Hs8dD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:40 INFO - Running setup.py (path:/tmp/pip-grPkmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:40 INFO - Running setup.py (path:/tmp/pip-m1Sy9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:40 INFO - Running setup.py (path:/tmp/pip-muCH8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:40 INFO - Running setup.py (path:/tmp/pip-1lCRMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:42 INFO - Running setup.py (path:/tmp/pip-BGZA6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:42 INFO - Running setup.py (path:/tmp/pip-hZ2LrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:42 INFO - Running setup.py (path:/tmp/pip-TmeAKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:42 INFO - Running setup.py (path:/tmp/pip-7yaPqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:42 INFO - Running setup.py (path:/tmp/pip-NTGlKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:42 INFO - Running setup.py install for manifestparser 14:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:42 INFO - Running setup.py install for mozcrash 14:02:42 INFO - Running setup.py install for mozdebug 14:02:42 INFO - Running setup.py install for mozdevice 14:02:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozfile 14:02:43 INFO - Running setup.py install for mozhttpd 14:02:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozinfo 14:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozInstall 14:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozleak 14:02:43 INFO - Running setup.py install for mozlog 14:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for moznetwork 14:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozprocess 14:02:43 INFO - Running setup.py install for mozprofile 14:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:43 INFO - Running setup.py install for mozrunner 14:02:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:44 INFO - Running setup.py install for mozscreenshot 14:02:44 INFO - Running setup.py install for moztest 14:02:44 INFO - Running setup.py install for mozversion 14:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:44 INFO - Cleaning up... 14:02:44 INFO - Return code: 0 14:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:44 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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:44 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 14:02:44 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 14:02:44 INFO - Using env: {'DISPLAY': ':0', 14:02:44 INFO - 'HOME': '/home/cltbld', 14:02:44 INFO - 'LANG': 'en_US.UTF-8', 14:02:44 INFO - 'LANGUAGE': 'en_US:en', 14:02:44 INFO - 'LOGNAME': 'cltbld', 14:02:44 INFO - 'MAIL': '/var/mail/cltbld', 14:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:44 INFO - 'MOZ_NO_REMOTE': '1', 14:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:44 INFO - 'NO_EM_RESTART': '1', 14:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:44 INFO - 'PWD': '/builds/slave/test', 14:02:44 INFO - 'SHELL': '/bin/bash', 14:02:44 INFO - 'SHLVL': '1', 14:02:44 INFO - 'TERM': 'linux', 14:02:44 INFO - 'TMOUT': '86400', 14:02:44 INFO - 'USER': 'cltbld', 14:02:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:44 INFO - '_': '/tools/buildbot/bin/python'} 14:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:44 INFO - Running setup.py (path:/tmp/pip-Gy7UYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:44 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)) 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:44 INFO - Running setup.py (path:/tmp/pip-kxDSlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:44 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)) 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:44 INFO - Running setup.py (path:/tmp/pip-f2hs5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:44 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)) 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:44 INFO - Running setup.py (path:/tmp/pip-cO3c8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:44 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)) 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:44 INFO - Running setup.py (path:/tmp/pip-uAnf1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:44 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)) 14:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:44 INFO - Running setup.py (path:/tmp/pip-rKdJTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:45 INFO - Running setup.py (path:/tmp/pip-gpLJfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:45 INFO - Running setup.py (path:/tmp/pip-_IFrXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:45 INFO - Running setup.py (path:/tmp/pip-WvjJKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:45 INFO - Running setup.py (path:/tmp/pip-V9x_EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:45 INFO - Running setup.py (path:/tmp/pip-40wX8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:45 INFO - Running setup.py (path:/tmp/pip-dPxQqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:45 INFO - Running setup.py (path:/tmp/pip-myBkME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:45 INFO - Running setup.py (path:/tmp/pip-2tkUza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:45 INFO - Running setup.py (path:/tmp/pip-MqKHEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:45 INFO - Running setup.py (path:/tmp/pip-R7kBx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:45 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)) 14:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:45 INFO - Running setup.py (path:/tmp/pip-5ywxtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:45 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)) 14:02:45 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)) 14:02:45 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)) 14:02:45 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)) 14:02:45 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)) 14:02:45 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)) 14:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:47 INFO - Downloading blessings-1.6.tar.gz 14:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:47 INFO - Installing collected packages: blessings 14:02:47 INFO - Running setup.py install for blessings 14:02:47 INFO - Successfully installed blessings 14:02:47 INFO - Cleaning up... 14:02:48 INFO - Return code: 0 14:02:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:48 INFO - Reading from file tmpfile_stdout 14:02:48 INFO - Current package versions: 14:02:48 INFO - argparse == 1.2.1 14:02:48 INFO - blessings == 1.6 14:02:48 INFO - blobuploader == 1.2.4 14:02:48 INFO - docopt == 0.6.1 14:02:48 INFO - manifestparser == 1.1 14:02:48 INFO - mozInstall == 1.12 14:02:48 INFO - mozcrash == 0.17 14:02:48 INFO - mozdebug == 0.1 14:02:48 INFO - mozdevice == 0.48 14:02:48 INFO - mozfile == 1.2 14:02:48 INFO - mozhttpd == 0.7 14:02:48 INFO - mozinfo == 0.9 14:02:48 INFO - mozleak == 0.1 14:02:48 INFO - mozlog == 3.1 14:02:48 INFO - moznetwork == 0.27 14:02:48 INFO - mozprocess == 0.22 14:02:48 INFO - mozprofile == 0.28 14:02:48 INFO - mozrunner == 6.11 14:02:48 INFO - mozscreenshot == 0.1 14:02:48 INFO - mozsystemmonitor == 0.0 14:02:48 INFO - moztest == 0.7 14:02:48 INFO - mozversion == 1.4 14:02:48 INFO - psutil == 3.1.1 14:02:48 INFO - requests == 1.2.3 14:02:48 INFO - wsgiref == 0.1.2 14:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:48 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 14:02:48 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 14:02:48 INFO - Using env: {'DISPLAY': ':0', 14:02:48 INFO - 'HOME': '/home/cltbld', 14:02:48 INFO - 'LANG': 'en_US.UTF-8', 14:02:48 INFO - 'LANGUAGE': 'en_US:en', 14:02:48 INFO - 'LOGNAME': 'cltbld', 14:02:48 INFO - 'MAIL': '/var/mail/cltbld', 14:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:48 INFO - 'MOZ_NO_REMOTE': '1', 14:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:48 INFO - 'NO_EM_RESTART': '1', 14:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:48 INFO - 'PWD': '/builds/slave/test', 14:02:48 INFO - 'SHELL': '/bin/bash', 14:02:48 INFO - 'SHLVL': '1', 14:02:48 INFO - 'TERM': 'linux', 14:02:48 INFO - 'TMOUT': '86400', 14:02:48 INFO - 'USER': 'cltbld', 14:02:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:48 INFO - '_': '/tools/buildbot/bin/python'} 14:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 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)) 14:02:48 INFO - Cleaning up... 14:02:48 INFO - Return code: 0 14:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:48 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 14:02:48 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 14:02:48 INFO - Using env: {'DISPLAY': ':0', 14:02:48 INFO - 'HOME': '/home/cltbld', 14:02:48 INFO - 'LANG': 'en_US.UTF-8', 14:02:48 INFO - 'LANGUAGE': 'en_US:en', 14:02:48 INFO - 'LOGNAME': 'cltbld', 14:02:48 INFO - 'MAIL': '/var/mail/cltbld', 14:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:48 INFO - 'MOZ_NO_REMOTE': '1', 14:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:48 INFO - 'NO_EM_RESTART': '1', 14:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:48 INFO - 'PWD': '/builds/slave/test', 14:02:48 INFO - 'SHELL': '/bin/bash', 14:02:48 INFO - 'SHLVL': '1', 14:02:48 INFO - 'TERM': 'linux', 14:02:48 INFO - 'TMOUT': '86400', 14:02:48 INFO - 'USER': 'cltbld', 14:02:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:48 INFO - '_': '/tools/buildbot/bin/python'} 14:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:48 INFO - Downloading/unpacking jsonschema 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:50 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:50 INFO - warning: no files found matching '*.txt' 14:02:50 INFO - no previously-included directories found matching 'build' 14:02:50 INFO - no previously-included directories found matching 'dist' 14:02:50 INFO - no previously-included directories found matching '.git*' 14:02:50 INFO - Installing collected packages: jsonschema, functools32 14:02:50 INFO - Running setup.py install for functools32 14:02:51 INFO - warning: no files found matching '*.txt' 14:02:51 INFO - no previously-included directories found matching 'build' 14:02:51 INFO - no previously-included directories found matching 'dist' 14:02:51 INFO - no previously-included directories found matching '.git*' 14:02:51 INFO - Successfully installed jsonschema functools32 14:02:51 INFO - Cleaning up... 14:02:51 INFO - Return code: 0 14:02:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:51 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 0x7fdbb1d8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, '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': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', '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 14:02:51 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 14:02:51 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 14:02:51 INFO - Using env: {'DISPLAY': ':0', 14:02:51 INFO - 'HOME': '/home/cltbld', 14:02:51 INFO - 'LANG': 'en_US.UTF-8', 14:02:51 INFO - 'LANGUAGE': 'en_US:en', 14:02:51 INFO - 'LOGNAME': 'cltbld', 14:02:51 INFO - 'MAIL': '/var/mail/cltbld', 14:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:51 INFO - 'MOZ_NO_REMOTE': '1', 14:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:51 INFO - 'NO_EM_RESTART': '1', 14:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:51 INFO - 'PWD': '/builds/slave/test', 14:02:51 INFO - 'SHELL': '/bin/bash', 14:02:51 INFO - 'SHLVL': '1', 14:02:51 INFO - 'TERM': 'linux', 14:02:51 INFO - 'TMOUT': '86400', 14:02:51 INFO - 'USER': 'cltbld', 14:02:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:51 INFO - '_': '/tools/buildbot/bin/python'} 14:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:51 INFO - Downloading/unpacking flake8 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:53 INFO - no previously-included directories found matching 'docs/_build' 14:02:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:54 INFO - Running setup.py install for pep8 14:02:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:54 INFO - no previously-included directories found matching 'docs/_build' 14:02:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:54 INFO - Cleaning up... 14:02:54 INFO - Return code: 0 14:02:54 INFO - Running post-action listener: _resource_record_post_action 14:02:54 INFO - Running post-action listener: _start_resource_monitoring 14:02:54 INFO - Starting resource monitoring. 14:02:54 INFO - ##### 14:02:54 INFO - ##### Running install step. 14:02:54 INFO - ##### 14:02:54 INFO - Running pre-action listener: _resource_record_pre_action 14:02:54 INFO - Running main action method: install 14:02:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:54 INFO - Reading from file tmpfile_stdout 14:02:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:54 INFO - Reading from file tmpfile_stdout 14:02:54 INFO - Output received: 14:02:54 INFO - Usage: mozinstall [options] installer 14:02:54 INFO - Options: 14:02:54 INFO - -h, --help show this help message and exit 14:02:54 INFO - -d DEST, --destination=DEST 14:02:54 INFO - Directory to install application into. [default: 14:02:54 INFO - "/builds/slave/test"] 14:02:54 INFO - --app=APP Application being installed. [default: firefox] 14:02:54 INFO - mkdir: /builds/slave/test/build/application 14:02:54 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'] 14:02:54 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 14:03:07 INFO - Reading from file tmpfile_stdout 14:03:07 INFO - Output received: 14:03:07 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:07 INFO - Running post-action listener: _resource_record_post_action 14:03:07 INFO - ##### 14:03:07 INFO - ##### Running run-tests step. 14:03:07 INFO - ##### 14:03:07 INFO - Running pre-action listener: _resource_record_pre_action 14:03:07 INFO - Running main action method: run_tests 14:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:07 INFO - Python 2.7.3 14:03:07 INFO - Return code: 0 14:03:07 INFO - grabbing minidump binary from tooltool 14:03:07 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')]} 14:03:07 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 0x209d640>, '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 0x209e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:07 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 14:03:07 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 14:03:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:07 INFO - Return code: 0 14:03:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:08 INFO - Return code: 0 14:03:08 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/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 14:03:08 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/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 14:03:08 INFO - Using env: {'DISPLAY': ':0', 14:03:08 INFO - 'HOME': '/home/cltbld', 14:03:08 INFO - 'LANG': 'en_US.UTF-8', 14:03:08 INFO - 'LANGUAGE': 'en_US:en', 14:03:08 INFO - 'LOGNAME': 'cltbld', 14:03:08 INFO - 'MAIL': '/var/mail/cltbld', 14:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:08 INFO - 'MOZ_NO_REMOTE': '1', 14:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:08 INFO - 'NO_EM_RESTART': '1', 14:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:08 INFO - 'PWD': '/builds/slave/test', 14:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:08 INFO - 'SHELL': '/bin/bash', 14:03:08 INFO - 'SHLVL': '1', 14:03:08 INFO - 'TERM': 'linux', 14:03:08 INFO - 'TMOUT': '86400', 14:03:08 INFO - 'USER': 'cltbld', 14:03:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634', 14:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:08 INFO - '_': '/tools/buildbot/bin/python'} 14:03:08 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/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 14:03:09 INFO - mozversion application_buildid: 20160719110521 14:03:09 INFO - mozversion application_changeset: 55cd3b01ca013495afc1f583e4eb9a9392199025 14:03:09 INFO - mozversion application_display_name: Firefox 14:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:09 INFO - mozversion application_name: Firefox 14:03:09 INFO - mozversion application_remotingname: firefox 14:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:03:09 INFO - mozversion application_vendor: Mozilla 14:03:09 INFO - mozversion application_version: 48.0 14:03:09 INFO - mozversion platform_buildid: 20160719110521 14:03:09 INFO - mozversion platform_changeset: 55cd3b01ca013495afc1f583e4eb9a9392199025 14:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:03:09 INFO - mozversion platform_version: 48.0 14:03:09 INFO - using testdate: 1468962189 14:03:09 INFO - actual date: 1468962189 14:03:09 INFO - starting webserver on 'localhost:43016' 14:03:09 INFO - SUITE-START | Running 2 tests 14:03:09 INFO - TEST-START | dromaeo_css 14:03:09 INFO - operating with platform_type : linux_ 14:03:09 INFO - Initialising browser for dromaeo_css test... 14:03:09 INFO - TEST-INFO | started process 9540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdiIjU/profile http://localhost:43016/getInfo.html) 14:03:13 INFO - PROCESS | 9540 | __metrics Screen width/height:1600/1200 14:03:13 INFO - PROCESS | 9540 | colorDepth:24 14:03:13 INFO - PROCESS | 9540 | Browser inner width/height: 1024/697 14:03:13 INFO - PROCESS | 9540 | __metrics 14:03:15 INFO - PROCESS | 9540 | 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" 14:03:15 ERROR - PROCESS | 9540 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:03:15 INFO - TEST-INFO | 9540: exit 0 14:03:15 INFO - Browser initialized. 14:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:15 INFO - TEST-INFO | started process 9632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdiIjU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:27 INFO - PROCESS | 9632 | RSS: Main: 139784192 14:03:27 INFO - PROCESS | 9632 | 14:04:18 INFO - PROCESS | 9632 | 1468962258685 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] 14:06:26 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43016/tests/dromaeo/cssquery-ext.html) 14:06:27 INFO - PROCESS | 9632 | RSS: Main: 251166720 14:06:27 INFO - PROCESS | 9632 | 14:09:29 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-ext.html (next: http://localhost:43016/tests/dromaeo/cssquery-jquery.html) 14:09:29 INFO - PROCESS | 9632 | RSS: Main: 224227328 14:09:29 INFO - PROCESS | 9632 | 14:12:31 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43016/tests/dromaeo/cssquery-mootools.html) 14:12:32 INFO - PROCESS | 9632 | RSS: Main: 218329088 14:12:32 INFO - PROCESS | 9632 | 14:15:34 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43016/tests/dromaeo/cssquery-prototype.html) 14:15:34 INFO - PROCESS | 9632 | RSS: Main: 218107904 14:15:34 INFO - PROCESS | 9632 | 14:18:37 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43016/tests/dromaeo/cssquery-yui.html) 14:18:37 INFO - PROCESS | 9632 | RSS: Main: 213991424 14:18:37 INFO - PROCESS | 9632 | 14:21:39 INFO - PROCESS | 9632 | Cycle 1(1): loaded http://localhost:43016/tests/dromaeo/cssquery-yui.html (next: http://localhost:43016/tests/dromaeo/cssquery-dojo.html) 14:21:40 INFO - PROCESS | 9632 | RSS: Main: 241377280 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | __start_tp_report 14:21:40 INFO - PROCESS | 9632 | _x_x_mozilla_page_load 14:21:40 INFO - PROCESS | 9632 | _x_x_mozilla_page_load_details 14:21:40 INFO - PROCESS | 9632 | |i|pagename|runs| 14:21:40 INFO - PROCESS | 9632 | |0;dojo.html;3314.834258287086;3383.8646454141835;3400.914977125573;3400.9659903400957;3428.639992800756;5562.471565201305;5602.187682785999;5618.550515958724;5621.297337832771;5623.859403514914;5559.360673522546;5623.212750214963;5629.746661400237;5633.549316054716;5634.4928956393915;4875.609951203895;5056.696598204101;5144.819931302405;5190.558802501791;5220.216967454893;5010.323606313155;5027.195648696209;5051.5453609175165;5091;5098.4901509848905;5002.59979201663;5017.272495488152;5064.721440320781;5078.949210507903;5091.287219789214;5060.316857224265;5114.514121158502;5149.742512874342;5160.56135228506;5175.8188463403785;4977.253411988195;4991.176455884774;5050.964552266776;5054.873628159326;5076.695398276115;5413.485718856702;5431.809886653988;5444;5474.753636086346;5475.917861232085;6043.8791224175275;6075.149479072933;6080.635161890256;6084;6086.421789929949;5961.195238642815;6019.939800601982;6051.389095969368;6070.635761854259;6105.32841387447;5626.099824028177;5675.772969081232;5679.432056794329;5680.517156041783;5680.5455563554815;5970.671613061323;6196.287426945959;6198.256209254918;6211.409916057967;6211.534134939807;5859.501942334864;5913.231279933581;5928.436798504222;5930.52555795544;5939.554533410012;5900.527957763455;5905.43898329658;5905.734241959122;5908.409159084057;5916.526677865761;5827.562932780059;5839.824805255849;5846.678432686158;5854.8536286592325;5875.588708790429;5946.375630558816;5948.67282299469;5953.166556682068;5958.612690175125;5997.010493268562;4540.091981603692;4552.499225085238;4555;4555.794989225493;4584.15193189261;3997.4603428537357;4053.351463765783;4069.328560787496;4073.572274911151;4104.651104656137;5673.262475878192;5682.119271512922;5695.373508914016;5718.228039214736;5726.77092916287;6030.909536356959;6035.849103772353;6039.033754599331;6041.365656606081;6042.244719410074;5654.971725141348;5663.660180389107;5714.571407144481;5785.71071446426;5805.129230615442;5084.211947148198;5090.567301779391;5101.20931255656;5105.617078719111;5117.667351622133;6251.624902505864;6287;6287.056941458818;6287.685615719196;6288.151099601495;5838.5037271831525;6052.092186172109;6109.34393638171;6138.416850399205;6140.140380346845;6265;6310.842228944313;6315.463185629273;6330.303666596763;6332.271788744353;5816.982028145142;5923.7926672566255;5939.554533409925;5955.76176952917;5961.344252132175;6045.365236650265;6068;6092.603980741238;6093.2078829751845;6112.235970503687;5848.210491583582;5861.120831875252;5868.618539794899;5884.823455296348;5885.55858310637;5735.7418916148035;5820.1560773688425;5862.472377486047;5875.50058245054;5887.028640274307;5757.798477053283;5786.826395208151;5791.739371728367;5796.536277097906;5832.650040997553;5898.439648233411;5908.113782932594;5910.320313164041;5925.40745925404;5926.614770039933;5689.573282003784;5798.82603521895;5799.565032622486;5830.300363956352;5878.617889837147 14:21:40 INFO - PROCESS | 9632 | |1;ext.html;661.4972620808185;679.6058286194007;679.6975345971044;733.2484203691213;737.6016950846544;32121.19697007573;32711.67288327116;32726.018219453425;32735.345293094124;32743.836280818563;33142.171445713866;41294.99999999993;42185;42254.36618450726;42308;8755;8966.865497017518;8975.820483590323;8979.551022448884;8981.101889811032;8763.95618021909;8884.8667269991;8887.777805554848;8889.066648001964;8889.377743557954;8914.197722205;8986.820263594724;8987.236084932789;8988.910110898905;8991.370604057685;8907.198352148305;8930.37487375884;8938.508382038985;8945.46327220369;8948.015718271017;9061.411008284505;9164.725058248196;9166.129217724305;9170.358074934757;9183.632654693803;44018;44376.3343549847;44470.33294500585;44479;44516.55483445156;3884.261990221877;4036.455078564415;4200.579942005806;4353.390525326457;4629.51390104041;33628.49557256643;33924;34007.4898876517;34151.146221344665;35009.6499035009;4433;4528.909421811578;4541.341505481687;4552.590266875997;4602.332661764059;309043.4547827269;309606;310821;311408;311640;60733;61066.38933610607;61439;61486.69256653778;61535.38464615386;71101;72700.27299726935;72863;72902;72993.6350318245;19450.70823937642;19570.608587828163;19647.312344068174;19657.901710491642;19679.31122410709;15527.068375897483;15622.296996634952;15622.76565851513;15625.921870390575;15633.609159771097;20841;21082.894585526974;21089.367318980454;21104.577908441745;21155.048022839008;7598.544087354777;7661.731839385595;7703.6918523259565;7749.225077492319;7758.9612051939375;1141.263884794303;1155.9595414160465;1193.3496244546743;1198.7035651957117;1267.4930027988878;33851.322973540395;33983;34001.14997125092;34400.311993759984;34618.30763384718;1206.6018213989362;1234.9938250308692;1243.440451796695;1247.607003793802;1416.2564653556758;17416.738748918775;18123;18294.17676204574;18311.908440457977;18317.54206144857;523934;524281;531322;535302;536019;62550.0617490738;63299;63353.68323158355;63400;63525;1509.781081743163;1519.187234829361;1555.2612509058333;1646.514278287908;1655.389739575277;29520.704792951794;29933.251668708457;32123.67876321207;33265.83367083149;33378.49932251067;50128.498715012385;50394;50728.746356267984;50764.23853642272;50859.491405086956;300438;304913;305029;305193;306380;27344.179674609793;27967.860160699067;30390;31226.687733122377;31451.685483144876;44340;44921.32618010798;45348.31977520406;46018.76990615026;46048.76975615101;37499;37938.241235175694;37968;38193.80903095578;38514.229715404974;36956.44565331576;36986;37108.443373348884;39394;39637.80181099076;42273;42705.35941960811;42965;43131.568684314014;43196.78401607972;35166;36004.639953600126;36370.63629363672;36643.45034824427;36924.630753692116;28117.297067573476;28194.718052819208;28287.29281767972;28343.291417713895;28429.289267768472 14:21:40 INFO - PROCESS | 9632 | |2;jquery.html;421.62896650947164;424.83006797281064;428.33821745403367;435.1731709751472;443.3925522034813;18771.43685689428;19548.609027819453;19553;20056.59886802263;20774.376768696926;13302.534411295606;13621.591352259424;16583.91708041458;20400.693989590167;20413;5299.867503312429;5365.275687782138;5480.671159730429;5516.558675305986;5546.084895992157;5461.808836690717;5477.424870388611;5488.121900495921;5509.559235261169;5510.559155267589;5486.094794358946;5491.039068163075;5493.176023596453;5493.450654934494;5692.686902220376;5956.106584012389;5981.1028345748055;5988.850278743044;5991.640501569898;6027.698615069251;5761.279840019997;5822.737976791054;5830.591858569902;5830.7667693292215;5831.329397119343;14594.927025364805;14653.267336633126;14870.330835112338;15014.399424023026;15027.09837409759;2681.5441374966304;2922.313256384748;3158.589383380169;3206.7915585487103;3241.465158248886;12788.936055319757;13821.654458638615;13903.165810051429;14200.431982720678;14755.55733328002;1959.7864591129044;2077.1172251792927;2106.557622899193;2111.8099371056524;2179.901904414305;75223;79670;79944.20055799368;80048.19951800523;81461.59269203675;11606.361650109326;11730.88269117315;11836.112291578165;11858.762824743457;11905.166638335233;16764.1617919106;16793.496195114167;16880.240389182516;16885;16893.831061689227;8785.604647790864;8794.34042446819;8817.338699597556;8972;9017.143371379709;8341.332693384515;8379.413441059189;8412.327013839;8433.620487078097;8577.742667719978;5083;5131.076406246912;5153.484651534892;5162.096633089194;5220.608454365938;2085.18677715691;2114.9471263218543;2128.872267663945;2140.6467932790915;2172.3482955113404;1011.6256984915481;1027.3989716016215;1036.2694300518117;1092.819684752007;1111.1388673777888;18500.259989600265;18832.340868069827;18935.33726319572;19444.02779861001;19738.90130549367;1073.2487258918788;1076.8169411200115;1077.355093246079;1154.3016475032653;1173.636172786439;10734.194935379877;10975.231733778559;11073.446327683583;11137.10903127764;11316.151288653384;528596;559056;570516;572135;574493;76331;83870.58064709637;86472;97476.51261743646;101102;1160.489384670742;1163.831244469547;1184.691980085184;1191.350713860948;1191.8808119188186;17347.479575612753;17710;17919.37282195117;18037.90981045139;18451.44645660632;40743.7962810184;41073.58926410697;41209.38185927153;42603.14793704171;43142.35286470768;61450;61720.69139654273;61730;61855.38144618676;61914.69042654758;9274.165325120772;9304;9310.767230819283;9430.811383772423;9569.138777510057;10014.499275036365;13151.53969611059;13396.93301533486;13592.32038398096;13616.727665446833;11504.424778761197;11812.82280765772;11896.524139034342;12061.75876482483;12550.058745593935;11539.423028848692;11787.646370608552;11887.346195959306;12083.637490875288;12216.328101954477;11623.535058597561;11881.643550693492;12423;12533.435995380047;12640.178388404724;9078.591463384031;9121.133492318218;9152.679656212;9220.769480763034;9439.905600943903;9552.808943821223;11580.189386742848;11853.703657408289;11997.64007079789;12339.07456940715 14:21:40 INFO - PROCESS | 9632 | |3;mootools.html;1430.8783753380962;1607.2606600963557;1612.3067081155104;1866.0949439521837;1936.3029309448596;8375.748727538175;8471.91528084719;8550.230479256865;8581.52801595912;8581.957090214555;8407.075221725605;8586.570671466432;8591.828163436727;8592.699255526059;8607.39748217625;2483.8509689418647;2503.636972638966;2508.2224510401743;2509.623556466526;2510.2469259222253;2400.6159014557675;2502.7121880983645;2503.987480062597;2507.5110353481077;2512.38446580588;2410.9758902410927;2422.6002709552904;2450.742672019439;2463.4949835283724;2469.2098528470897;2416.395901024744;2434.330559096245;2447.645091461737;2477.962830557543;2481.0323973650293;2459.5203935232635;2469.3209367423924;2487.6641653376923;2508.498300339921;2509.9372515687073;8265.214804593554;8443.788905277355;8679.522626255553;8722.694705685333;8725.869111963326;5374.838754837361;5469.535089517396;5474.7810087596445;5521.365043020064;5530.834074977757;3415.470602056685;3441.896743097711;3476.2699833035094;3578.1949061460964;3583.140046388848;1085.4084523934475;1140.7775483780665;1175.659058872926;1182.5860948667982;1229.858566264882;12168;12486.875131248753;12611.936940315332;12613;12655.683607909876;4588.174128656807;4597.42532183477;4663.860084197479;4686.343911852344;4738.218193998021;10026.69919902404;10030.849537256947;10036.64871729486;10063.094321511098;10069.899301006895;5348.277982472394;5387.865303367447;5390.51485366319;5392.973035134878;5402.189671549299;4374.21264172452;4765.046990601893;4859.538343857328;4890.266460030953;5012.523810238022;3947.6052394760295;3958.386450100239;4002.519697636244;4057.289974254553;4060.614241647098;1181.4329122021477;1191.3566673995945;1191.9404029798475;1199.382318106176;1208.9032877369789;913.8949020862553;978.6819283732673;990.3810118675827;1010.9536629588341;1046.7016900183564;6018;6032.095185722177;6043.969780151071;6066.332703402622;6202.689865506707;482.0792286732324;486.6787919972801;487.7804987755524;495.10139097538575;500.29458463566925;4146.771927544014;4229.2598795210715;4259.041715613962;4292;4349.19539885116;10657.25399222047;11050.502727377287;11156.219064665558;11162.497687604076;11162.888371116347;10952.178586605876;10959.232853700165;10975.06711929479;10976.341419514854;10994.230403871812;8290.502569845828;8426.115257897833;8511.191436813617;8524.957375213084;8527.530985795716;6026.427489388501;6091.238595175603;6125.356837531995;6179.969100154471;6221.191245138284;9328.720138395858;9740.12338889475;9767;9921.751956201153;9956.20350371983;9818.950905245429;9908.801823963337;10129.341592796445;10146.949265253626;10150.49247537635;6878;7034.859302814018;7479.439042071976;7984.960075199587;8083.797905052421;8229.547374894439;8254.504729715996;8314.334853211607;8316;8321.043080045873;7444.106707194955;7671.232876712284;7735.303822655988;7792.220777922163;7837.804054898673;7560.697572097055;7603.88594171099;7621.961890190513;7693.1922148173635;7726.4205184610255;6861.142357205349;6872.10662613857;6894.13823272091;6894.413974811997;6898;4907.214845624826;4966.130927087673;5015.247712843103;5022.3219865317715;5098.209777484496;5144.871378215575;5193.143131383431;5286.15421532553;5287.444818294024;5288.68267903927 14:21:40 INFO - PROCESS | 9632 | |4;prototype.html;350.64935064935065;357.403136761608;358.7488757869491;364.58619466905054;372.42646324660024;6056.212692349994;6062.302835173957;6065.545084118687;6089.78685745999;6096.695165241731;6016.849578760533;6037.0340745480735;6039.033754599265;6056.091586262063;6066.272047354312;4500.5049444561155;4594.816207351719;4695.225287827504;4705.435347758274;4709.081729062834;4666.39336886206;4684.43786745591;4695.084458530588;4705.764711764416;4709.434867815867;4488.528704486031;4663.720176789387;4675.579197872191;4680.157571637121;4687;4552.9089418211615;4633.721976681393;4653.139169253699;4658.208104622222;4666.580007799281;4110.280700877334;4113.053997580543;4116.341385378355;4127.988642782538;4128.4632997710405;5781.797637082724;5789.247397838296;5794.275715535558;5795.130730390433;5804.2744656917885;5436.130219164915;5436.157395603688;5445.673259604397;5446.319210098738;5453.072977593819;6381.138546296237;6389.36106389362;6390;6396.968015159941;6398.58409203405;4506.369108324837;4620.19146649335;4624;4646.372739680134;4667.533246675339;6587.275399706028;6646.867062658768;6714.697838597275;6718.8320291993095;6723.899141512881;4760.7619619018915;4764.404449443819;4767.332573439721;4771.23660214364;4775.5224477551965;4820.4456487504385;4826.975865120652;4829.782659780319;4830.082284365959;4830.203016502308;5444.673319600836;5458.563314934796;5476.972615136979;5481.150421684645;5503.889922201533;6350.0792385103905;6483.578567393104;6484.157059582224;6489.059086432535;6489.221293444817;1669.2822086502676;1685.3174464341962;1694.9661006779795;1699.1674079701104;1700.9234584443482;1093.8359246112987;1138.3397629374942;1152.251036826053;1168.5442677355838;1173.4191575170346;6245.96877015612;6252.718627661766;6254.6247225166635;6258.061290806324;6263.217097862767;6610.438112760373;6610.8016759497295;6616.933830661728;6617.702203400859;6625.039369291426;6236.438720515175;6243.313235544087;6246;6262.937370626327;6267.467265282502;3533.699635530957;3556.199855032597;3566.696830769362;3567.4292113261754;3568.982155089208;6748;6884.105066341343;6897.931020689729;6965.233824279325;7013.123359580052;6720.8319792005595;6764.830879228059;6802.489813263926;6823.112995310578;6834.624095674686;6876.277990810993;6893.310668933167;6894.207166175854;6906.274841141708;6923.169219693669;6586.110875031809;6591.703373348115;6600.306967768315;6604.306547812603;6605.504587155887;6278.434940855345;6487.253965793805;6488.221413430419;6496.740130394731;6515.153030106056;6854.862902742017;6878.759243426456;6885.724571017103;6889.242183359726;6889.655517224219;4713.646476514206;4725.432948046257;4764;4764.714117152982;4768.666193366431;6571.572847765071;6578;6578.638174900427;6591.703373348115;6593.109930159367;6290.622562646256;6344.809655710336;6386.042093685985;6390.64851433157;6446.742130314735;6433.839154021187;6443.484521238383;6459.160309159779;6506.837329066811;6508.8047358579315;6363.649999250086;6371.426571608577;6372.745090196526;6378.649174295459;6388.233411990591;6546.476281897341;6552.410283074546;6554.541182117206;6564.737410503526;6569.57297775643;6018.969905150446;6142.815715528542;6172.19761431029;6396.904046439214;6404.263509696445 14:21:40 INFO - PROCESS | 9632 | |5;yui.html;820.4052062254863;849.4181485682308;874.685113359191;881.7531091294439;964.7250533597924;13626.591202263935;13714.24571648559;13765.449382024706;13791.586252412431;13794.379252933604;13246;13259.138156019852;13270.336483175826;13312.134711243762;14065.718685626282;763.4617594595796;917.6283605139929;918.8024574716435;927.638221093774;928.2110206324637;908.3278374003223;930.3627015494408;935.5228833295034;935.9625614975427;936.887573491182;966.3622009473748;969.6509256667593;969.7236287658019;971.0823272007955;972.2950860626061;796.2197046894076;812.597764106765;968.8934217236134;969.2439896880445;969.3699095587854;596.0879853823614;705.3052743048094;719.8380364418016;720.3948683106216;720.697307131001;15355.155466449341;15363;15378.154201519024;15390.846091539053;15423;14939;15439.459618913284;15443.922780386138;15482.845171548253;15532.844671553254;12007.57973470933;12390.442430090667;12411.255324680458;12468.501259949591;12481.251124932533;4045.1707399982934;4098.8360465581345;4103.179364127186;4105.137921036586;4110.972256935766;54442.45557544453;54452.72773636106;54465.72767136178;54484;54877;11565.595204167814;11831.408429578487;11899.226550274378;11974.080952095668;12238.694032649255;22161.66757498639;22391.10435582591;22451.21420750266;22466.887665561895;22470.43823904383;8821.647134114564;8920.8661870072;8961.790158328673;8972.37193396456;9085.091490850862;4739.199249077585;4824.445188803263;4846;4914.827981020647;4996.850094497171;3619.3847046002243;3663.6519530644546;3678.779273243614;3682.6869716073898;3684.428913518409;636.9840753981188;645.2321737132797;762.397705812413;781.2187812187813;784.0395515493589;794.3089512124374;807.9515229086273;823.2138307915926;832.5088197963231;837.1001173738134;9270.30472714549;9527.428354298765;9564.713058608253;9584.137427631547;9808.264380171515;790.4782843323379;797.1351084073845;804.6781287485053;822.0382152881143;860.9225169734754;4559.863204103882;4582.0377720679035;4612.423447069116;4639.907201855944;4701.976490117528;63824.68087659625;64732.35267647357;65035.34964650293;65050;65212.67393663001;55568.16647750287;56189.71905140448;56455.15317270244;56460.153097703565;56695;51012.23481647778;51337.74331128395;51485.7425712869;52267.47732522626;52832.73583632134;7638.847223055396;7982.481138725964;8541.060483346702;9127.863082053907;9452.527373631428;39169.2166156681;39379.212415752096;39863.2027359457;40060.59939400569;40744.185116298104;45125.54874451213;45724.31413528866;48296;50429.74785126051;51183.23225151551;11223.326600404002;11442.599509017144;11538.82691759641;11901.404929753304;12077.456514456695;12985.675358116123;13083.476660933457;13157.736845263233;13210.207387556777;13304.201747895157;12641.747165056464;12721.681957951125;12879.227246365248;12935.223886566837;13124.737505250032;12144.089193310714;12272.38638068111;12306;12309.692257693629;12330.19853709506;12863.871361286641;12870.935645322088;12886.09797314179;12898.613041608767;12946.935265323613;9157.77105572366;9380.108889655472;10006.29955903109;10100;10457.529411176363;10014.549345279334;10519.316244444086;10539.63111291101;10552.525136369035;10662.200334975063 14:21:40 INFO - PROCESS | 9632 | __end_tp_report 14:21:40 INFO - PROCESS | 9632 | __start_cc_report 14:21:40 INFO - PROCESS | 9632 | _x_x_mozilla_cycle_collect,849 14:21:40 INFO - PROCESS | 9632 | __end_cc_report 14:21:40 INFO - PROCESS | 9632 | __startTimestamp1468963300233__endTimestamp 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | ------- Summary: start ------- 14:21:40 INFO - PROCESS | 9632 | Number of tests: 6 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#0] dojo.html Cycles:165 Average:5576.81 Median:5805.13 stddev:635.14 (10.9%) stddev-sans-first:611.80 14:21:40 INFO - PROCESS | 9632 | Values: 3314.8 3383.9 3400.9 3401.0 3428.6 5562.5 5602.2 5618.6 5621.3 5623.9 5559.4 5623.2 5629.7 5633.5 5634.5 4875.6 5056.7 5144.8 5190.6 5220.2 5010.3 5027.2 5051.5 5091.0 5098.5 5002.6 5017.3 5064.7 5078.9 5091.3 5060.3 5114.5 5149.7 5160.6 5175.8 4977.3 4991.2 5051.0 5054.9 5076.7 5413.5 5431.8 5444.0 5474.8 5475.9 6043.9 6075.1 6080.6 6084.0 6086.4 5961.2 6019.9 6051.4 6070.6 6105.3 5626.1 5675.8 5679.4 5680.5 5680.5 5970.7 6196.3 6198.3 6211.4 6211.5 5859.5 5913.2 5928.4 5930.5 5939.6 5900.5 5905.4 5905.7 5908.4 5916.5 5827.6 5839.8 5846.7 5854.9 5875.6 5946.4 5948.7 5953.2 5958.6 5997.0 4540.1 4552.5 4555.0 4555.8 4584.2 3997.5 4053.4 4069.3 4073.6 4104.7 5673.3 5682.1 5695.4 5718.2 5726.8 6030.9 6035.8 6039.0 6041.4 6042.2 5655.0 5663.7 5714.6 5785.7 5805.1 5084.2 5090.6 5101.2 5105.6 5117.7 6251.6 6287.0 6287.1 6287.7 6288.2 5838.5 6052.1 6109.3 6138.4 6140.1 6265.0 6310.8 6315.5 6330.3 6332.3 5817.0 5923.8 5939.6 5955.8 5961.3 6045.4 6068.0 6092.6 6093.2 6112.2 5848.2 5861.1 5868.6 5884.8 5885.6 5735.7 5820.2 5862.5 5875.5 5887.0 5757.8 5786.8 5791.7 5796.5 5832.7 5898.4 5908.1 5910.3 5925.4 5926.6 5689.6 5798.8 5799.6 5830.3 5878.6 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#1] ext.html Cycles:180 Average:55794.38 Median:39515.90 stddev:104822.88 (265.3%) stddev-sans-first:105035.20 14:21:40 INFO - PROCESS | 9632 | Values: 661.5 679.6 679.7 733.2 737.6 32121.2 32711.7 32726.0 32735.3 32743.8 33142.2 41295.0 42185.0 42254.4 42308.0 8755.0 8966.9 8975.8 8979.6 8981.1 8764.0 8884.9 8887.8 8889.1 8889.4 8914.2 8986.8 8987.2 8988.9 8991.4 8907.2 8930.4 8938.5 8945.5 8948.0 9061.4 9164.7 9166.1 9170.4 9183.6 44018.0 44376.3 44470.3 44479.0 44516.6 3884.3 4036.5 4200.6 4353.4 4629.5 33628.5 33924.0 34007.5 34151.1 35009.6 4433.0 4528.9 4541.3 4552.6 4602.3 309043.5 309606.0 310821.0 311408.0 311640.0 60733.0 61066.4 61439.0 61486.7 61535.4 71101.0 72700.3 72863.0 72902.0 72993.6 19450.7 19570.6 19647.3 19657.9 19679.3 15527.1 15622.3 15622.8 15625.9 15633.6 20841.0 21082.9 21089.4 21104.6 21155.0 7598.5 7661.7 7703.7 7749.2 7759.0 1141.3 1156.0 1193.3 1198.7 1267.5 33851.3 33983.0 34001.1 34400.3 34618.3 1206.6 1235.0 1243.4 1247.6 1416.3 17416.7 18123.0 18294.2 18311.9 18317.5 523934.0 524281.0 531322.0 535302.0 536019.0 62550.1 63299.0 63353.7 63400.0 63525.0 1509.8 1519.2 1555.3 1646.5 1655.4 29520.7 29933.3 32123.7 33265.8 33378.5 50128.5 50394.0 50728.7 50764.2 50859.5 300438.0 304913.0 305029.0 305193.0 306380.0 27344.2 27967.9 30390.0 31226.7 31451.7 44340.0 44921.3 45348.3 46018.8 46048.8 37499.0 37938.2 37968.0 38193.8 38514.2 36956.4 36986.0 37108.4 39394.0 39637.8 42273.0 42705.4 42965.0 43131.6 43196.8 35166.0 36004.6 36370.6 36643.5 36924.6 28117.3 28194.7 28287.3 28343.3 28429.3 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#2] jquery.html Cycles:180 Average:30983.47 Median:2121.91 stddev:92127.57 (4341.7%) stddev-sans-first:92357.43 14:21:40 INFO - PROCESS | 9632 | Values: 421.6 424.8 428.3 435.2 443.4 18771.4 19548.6 19553.0 20056.6 20774.4 13302.5 13621.6 16583.9 20400.7 20413.0 5299.9 5365.3 5480.7 5516.6 5546.1 5461.8 5477.4 5488.1 5509.6 5510.6 5486.1 5491.0 5493.2 5493.5 5692.7 5956.1 5981.1 5988.9 5991.6 6027.7 5761.3 5822.7 5830.6 5830.8 5831.3 14594.9 14653.3 14870.3 15014.4 15027.1 2681.5 2922.3 3158.6 3206.8 3241.5 12788.9 13821.7 13903.2 14200.4 14755.6 1959.8 2077.1 2106.6 2111.8 2179.9 75223.0 79670.0 79944.2 80048.2 81461.6 11606.4 11730.9 11836.1 11858.8 11905.2 16764.2 16793.5 16880.2 16885.0 16893.8 8785.6 8794.3 8817.3 8972.0 9017.1 8341.3 8379.4 8412.3 8433.6 8577.7 5083.0 5131.1 5153.5 5162.1 5220.6 2085.2 2114.9 2128.9 2140.6 2172.3 1011.6 1027.4 1036.3 1092.8 1111.1 18500.3 18832.3 18935.3 19444.0 19738.9 1073.2 1076.8 1077.4 1154.3 1173.6 10734.2 10975.2 11073.4 11137.1 11316.2 528596.0 559056.0 570516.0 572135.0 574493.0 76331.0 83870.6 86472.0 97476.5 101102.0 1160.5 1163.8 1184.7 1191.4 1191.9 17347.5 17710.0 17919.4 18037.9 18451.4 40743.8 41073.6 41209.4 42603.1 43142.4 61450.0 61720.7 61730.0 61855.4 61914.7 9274.2 9304.0 9310.8 9430.8 9569.1 10014.5 13151.5 13396.9 13592.3 13616.7 11504.4 11812.8 11896.5 12061.8 12550.1 11539.4 11787.6 11887.3 12083.6 12216.3 11623.5 11881.6 12423.0 12533.4 12640.2 9078.6 9121.1 9152.7 9220.8 9439.9 9552.8 11580.2 11853.7 11997.6 12339.1 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#3] mootools.html Cycles:180 Average:5800.63 Median:2689.02 stddev:3253.77 (121.0%) stddev-sans-first:3246.33 14:21:40 INFO - PROCESS | 9632 | Values: 1430.9 1607.3 1612.3 1866.1 1936.3 8375.7 8471.9 8550.2 8581.5 8582.0 8407.1 8586.6 8591.8 8592.7 8607.4 2483.9 2503.6 2508.2 2509.6 2510.2 2400.6 2502.7 2504.0 2507.5 2512.4 2411.0 2422.6 2450.7 2463.5 2469.2 2416.4 2434.3 2447.6 2478.0 2481.0 2459.5 2469.3 2487.7 2508.5 2509.9 8265.2 8443.8 8679.5 8722.7 8725.9 5374.8 5469.5 5474.8 5521.4 5530.8 3415.5 3441.9 3476.3 3578.2 3583.1 1085.4 1140.8 1175.7 1182.6 1229.9 12168.0 12486.9 12611.9 12613.0 12655.7 4588.2 4597.4 4663.9 4686.3 4738.2 10026.7 10030.8 10036.6 10063.1 10069.9 5348.3 5387.9 5390.5 5393.0 5402.2 4374.2 4765.0 4859.5 4890.3 5012.5 3947.6 3958.4 4002.5 4057.3 4060.6 1181.4 1191.4 1191.9 1199.4 1208.9 913.9 978.7 990.4 1011.0 1046.7 6018.0 6032.1 6044.0 6066.3 6202.7 482.1 486.7 487.8 495.1 500.3 4146.8 4229.3 4259.0 4292.0 4349.2 10657.3 11050.5 11156.2 11162.5 11162.9 10952.2 10959.2 10975.1 10976.3 10994.2 8290.5 8426.1 8511.2 8525.0 8527.5 6026.4 6091.2 6125.4 6180.0 6221.2 9328.7 9740.1 9767.0 9921.8 9956.2 9819.0 9908.8 10129.3 10146.9 10150.5 6878.0 7034.9 7479.4 7985.0 8083.8 8229.5 8254.5 8314.3 8316.0 8321.0 7444.1 7671.2 7735.3 7792.2 7837.8 7560.7 7603.9 7622.0 7693.2 7726.4 6861.1 6872.1 6894.1 6894.4 6898.0 4907.2 4966.1 5015.2 5022.3 5098.2 5144.9 5193.1 5286.2 5287.4 5288.7 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#4] prototype.html Cycles:180 Average:5417.12 Median:6119.76 stddev:1600.45 (26.2%) stddev-sans-first:1559.11 14:21:40 INFO - PROCESS | 9632 | Values: 350.6 357.4 358.7 364.6 372.4 6056.2 6062.3 6065.5 6089.8 6096.7 6016.8 6037.0 6039.0 6056.1 6066.3 4500.5 4594.8 4695.2 4705.4 4709.1 4666.4 4684.4 4695.1 4705.8 4709.4 4488.5 4663.7 4675.6 4680.2 4687.0 4552.9 4633.7 4653.1 4658.2 4666.6 4110.3 4113.1 4116.3 4128.0 4128.5 5781.8 5789.2 5794.3 5795.1 5804.3 5436.1 5436.2 5445.7 5446.3 5453.1 6381.1 6389.4 6390.0 6397.0 6398.6 4506.4 4620.2 4624.0 4646.4 4667.5 6587.3 6646.9 6714.7 6718.8 6723.9 4760.8 4764.4 4767.3 4771.2 4775.5 4820.4 4827.0 4829.8 4830.1 4830.2 5444.7 5458.6 5477.0 5481.2 5503.9 6350.1 6483.6 6484.2 6489.1 6489.2 1669.3 1685.3 1695.0 1699.2 1700.9 1093.8 1138.3 1152.3 1168.5 1173.4 6246.0 6252.7 6254.6 6258.1 6263.2 6610.4 6610.8 6616.9 6617.7 6625.0 6236.4 6243.3 6246.0 6262.9 6267.5 3533.7 3556.2 3566.7 3567.4 3569.0 6748.0 6884.1 6897.9 6965.2 7013.1 6720.8 6764.8 6802.5 6823.1 6834.6 6876.3 6893.3 6894.2 6906.3 6923.2 6586.1 6591.7 6600.3 6604.3 6605.5 6278.4 6487.3 6488.2 6496.7 6515.2 6854.9 6878.8 6885.7 6889.2 6889.7 4713.6 4725.4 4764.0 4764.7 4768.7 6571.6 6578.0 6578.6 6591.7 6593.1 6290.6 6344.8 6386.0 6390.6 6446.7 6433.8 6443.5 6459.2 6506.8 6508.8 6363.6 6371.4 6372.7 6378.6 6388.2 6546.5 6552.4 6554.5 6564.7 6569.6 6019.0 6142.8 6172.2 6396.9 6404.3 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - PROCESS | 9632 | [#5] yui.html Cycles:180 Average:15414.87 Median:4781.82 stddev:17796.91 (372.2%) stddev-sans-first:17813.09 14:21:40 INFO - PROCESS | 9632 | Values: 820.4 849.4 874.7 881.8 964.7 13626.6 13714.2 13765.4 13791.6 13794.4 13246.0 13259.1 13270.3 13312.1 14065.7 763.5 917.6 918.8 927.6 928.2 908.3 930.4 935.5 936.0 936.9 966.4 969.7 969.7 971.1 972.3 796.2 812.6 968.9 969.2 969.4 596.1 705.3 719.8 720.4 720.7 15355.2 15363.0 15378.2 15390.8 15423.0 14939.0 15439.5 15443.9 15482.8 15532.8 12007.6 12390.4 12411.3 12468.5 12481.3 4045.2 4098.8 4103.2 4105.1 4111.0 54442.5 54452.7 54465.7 54484.0 54877.0 11565.6 11831.4 11899.2 11974.1 12238.7 22161.7 22391.1 22451.2 22466.9 22470.4 8821.6 8920.9 8961.8 8972.4 9085.1 4739.2 4824.4 4846.0 4914.8 4996.9 3619.4 3663.7 3678.8 3682.7 3684.4 637.0 645.2 762.4 781.2 784.0 794.3 808.0 823.2 832.5 837.1 9270.3 9527.4 9564.7 9584.1 9808.3 790.5 797.1 804.7 822.0 860.9 4559.9 4582.0 4612.4 4639.9 4702.0 63824.7 64732.4 65035.3 65050.0 65212.7 55568.2 56189.7 56455.2 56460.2 56695.0 51012.2 51337.7 51485.7 52267.5 52832.7 7638.8 7982.5 8541.1 9127.9 9452.5 39169.2 39379.2 39863.2 40060.6 40744.2 45125.5 45724.3 48296.0 50429.7 51183.2 11223.3 11442.6 11538.8 11901.4 12077.5 12985.7 13083.5 13157.7 13210.2 13304.2 12641.7 12721.7 12879.2 12935.2 13124.7 12144.1 12272.4 12306.0 12309.7 12330.2 12863.9 12870.9 12886.1 12898.6 12946.9 9157.8 9380.1 10006.3 10100.0 10457.5 10014.5 10519.3 10539.6 10552.5 10662.2 14:21:40 INFO - PROCESS | 9632 | -------- Summary: end -------- 14:21:40 INFO - PROCESS | 9632 | 14:21:40 INFO - TEST-INFO | 9632: exit 0 14:21:40 INFO - TEST-OK | dromaeo_css | took 1111937ms 14:21:40 INFO - TEST-START | kraken 14:21:40 INFO - operating with platform_type : linux_ 14:21:40 INFO - Initialising browser for kraken test... 14:21:41 INFO - TEST-INFO | started process 9821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmyS1o/profile http://localhost:43016/getInfo.html) 14:21:45 INFO - PROCESS | 9821 | __metrics Screen width/height:1600/1200 14:21:45 INFO - PROCESS | 9821 | colorDepth:24 14:21:45 INFO - PROCESS | 9821 | Browser inner width/height: 1024/697 14:21:45 INFO - PROCESS | 9821 | __metrics 14:21:46 INFO - PROCESS | 9821 | 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" 14:21:46 ERROR - PROCESS | 9821 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:21:47 INFO - TEST-INFO | 9821: exit 0 14:21:47 INFO - Browser initialized. 14:21:47 INFO - Running cycle 1/1 for kraken test... 14:21:47 INFO - TEST-INFO | started process 9917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmyS1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:58 INFO - PROCESS | 9917 | RSS: Main: 139403264 14:21:58 INFO - PROCESS | 9917 | 14:22:01 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43016/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:02 INFO - PROCESS | 9917 | RSS: Main: 197402624 14:22:02 INFO - PROCESS | 9917 | 14:22:04 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43016/tests/kraken/driver.html?testName=audio-dft) 14:22:05 INFO - PROCESS | 9917 | RSS: Main: 184221696 14:22:05 INFO - PROCESS | 9917 | 14:22:08 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43016/tests/kraken/driver.html?testName=audio-fft) 14:22:08 INFO - PROCESS | 9917 | RSS: Main: 272781312 14:22:08 INFO - PROCESS | 9917 | 14:22:10 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43016/tests/kraken/driver.html?testName=audio-oscillator) 14:22:11 INFO - PROCESS | 9917 | RSS: Main: 179699712 14:22:11 INFO - PROCESS | 9917 | 14:22:13 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:14 INFO - PROCESS | 9917 | RSS: Main: 178601984 14:22:14 INFO - PROCESS | 9917 | 14:22:17 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43016/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:17 INFO - PROCESS | 9917 | RSS: Main: 212709376 14:22:17 INFO - PROCESS | 9917 | 14:22:21 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43016/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:21 INFO - PROCESS | 9917 | RSS: Main: 212512768 14:22:21 INFO - PROCESS | 9917 | 14:22:24 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43016/tests/kraken/driver.html?testName=json-parse-financial) 14:22:25 INFO - PROCESS | 9917 | RSS: Main: 212598784 14:22:25 INFO - PROCESS | 9917 | 14:22:26 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:27 INFO - PROCESS | 9917 | RSS: Main: 196521984 14:22:27 INFO - PROCESS | 9917 | 14:22:28 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:29 INFO - PROCESS | 9917 | RSS: Main: 198721536 14:22:29 INFO - PROCESS | 9917 | 14:22:31 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:32 INFO - PROCESS | 9917 | RSS: Main: 209940480 14:22:32 INFO - PROCESS | 9917 | 14:22:34 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:35 INFO - PROCESS | 9917 | RSS: Main: 217329664 14:22:35 INFO - PROCESS | 9917 | 14:22:37 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:38 INFO - PROCESS | 9917 | RSS: Main: 213733376 14:22:38 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | Cycle 1(1): loaded http://localhost:43016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43016/tests/kraken/driver.html?testName=ai-astar) 14:22:40 INFO - PROCESS | 9917 | RSS: Main: 274649088 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | __start_tp_report 14:22:40 INFO - PROCESS | 9917 | _x_x_mozilla_page_load 14:22:40 INFO - PROCESS | 9917 | _x_x_mozilla_page_load_details 14:22:40 INFO - PROCESS | 9917 | |i|pagename|runs| 14:22:40 INFO - PROCESS | 9917 | |0;ai-astar;109;108;110;110;110;110;106;109;110;109 14:22:40 INFO - PROCESS | 9917 | |1;audio-beat-detection;155;132;161;174;136;156;164;126;177;125 14:22:40 INFO - PROCESS | 9917 | |2;audio-dft;161;159;161;160;160;160;161;160;159;160 14:22:40 INFO - PROCESS | 9917 | |3;audio-fft;83;76;75;185;73;75;73;75;168;75 14:22:40 INFO - PROCESS | 9917 | |4;audio-oscillator;92;92;156;93;92;92;153;92;91;147 14:22:40 INFO - PROCESS | 9917 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;116;117 14:22:40 INFO - PROCESS | 9917 | |6;imaging-darkroom;147;146;146;146;145;145;144;145;146;145 14:22:40 INFO - PROCESS | 9917 | |7;imaging-desaturate;94;95;95;94;94;94;95;95;95;94 14:22:40 INFO - PROCESS | 9917 | |8;json-parse-financial;59;53;52;52;53;53;61;72;51;52 14:22:40 INFO - PROCESS | 9917 | |9;json-stringify-tinderbox;57;60;58;58;57;64;58;58;59;57 14:22:40 INFO - PROCESS | 9917 | |10;stanford-crypto-aes;72;71;72;81;76;75;74;74;73;73 14:22:40 INFO - PROCESS | 9917 | |11;stanford-crypto-ccm;117;120;117;113;112;112;119;110;132;124 14:22:40 INFO - PROCESS | 9917 | |12;stanford-crypto-pbkdf2;164;155;154;155;156;158;155;154;155;157 14:22:40 INFO - PROCESS | 9917 | |13;stanford-crypto-sha256-iterative;67;69;66;66;64;66;66;64;65;66 14:22:40 INFO - PROCESS | 9917 | __end_tp_report 14:22:40 INFO - PROCESS | 9917 | __start_cc_report 14:22:40 INFO - PROCESS | 9917 | _x_x_mozilla_cycle_collect,1605 14:22:40 INFO - PROCESS | 9917 | __end_cc_report 14:22:40 INFO - PROCESS | 9917 | __startTimestamp1468963360301__endTimestamp 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | ------- Summary: start ------- 14:22:40 INFO - PROCESS | 9917 | Number of tests: 14 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.29 (1.2%) stddev-sans-first:1.36 14:22:40 INFO - PROCESS | 9917 | Values: 109.0 108.0 110.0 110.0 110.0 110.0 106.0 109.0 110.0 109.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:158.50 stddev:19.44 (12.3%) stddev-sans-first:20.55 14:22:40 INFO - PROCESS | 9917 | Values: 155.0 132.0 161.0 174.0 136.0 156.0 164.0 126.0 177.0 125.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 14:22:40 INFO - PROCESS | 9917 | Values: 161.0 159.0 161.0 160.0 160.0 160.0 161.0 160.0 159.0 160.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#3] audio-fft Cycles:10 Average:95.80 Median:75.00 stddev:42.81 (57.1%) stddev-sans-first:45.16 14:22:40 INFO - PROCESS | 9917 | Values: 83.0 76.0 75.0 185.0 73.0 75.0 73.0 75.0 168.0 75.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:29.07 (31.6%) stddev-sans-first:30.09 14:22:40 INFO - PROCESS | 9917 | Values: 92.0 92.0 156.0 93.0 92.0 92.0 153.0 92.0 91.0 147.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:22:40 INFO - PROCESS | 9917 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 14:22:40 INFO - PROCESS | 9917 | Values: 147.0 146.0 146.0 146.0 145.0 145.0 144.0 145.0 146.0 145.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:22:40 INFO - PROCESS | 9917 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:53.00 stddev:6.58 (12.4%) stddev-sans-first:6.88 14:22:40 INFO - PROCESS | 9917 | Values: 59.0 53.0 52.0 52.0 53.0 53.0 61.0 72.0 51.0 52.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:2.12 (3.7%) stddev-sans-first:2.17 14:22:40 INFO - PROCESS | 9917 | Values: 57.0 60.0 58.0 58.0 57.0 64.0 58.0 58.0 59.0 57.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:2.85 (3.8%) stddev-sans-first:2.92 14:22:40 INFO - PROCESS | 9917 | Values: 72.0 71.0 72.0 81.0 76.0 75.0 74.0 74.0 73.0 73.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.00 stddev:6.65 (5.6%) stddev-sans-first:7.05 14:22:40 INFO - PROCESS | 9917 | Values: 117.0 120.0 117.0 113.0 112.0 112.0 119.0 110.0 132.0 124.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:155.50 stddev:2.98 (1.9%) stddev-sans-first:1.33 14:22:40 INFO - PROCESS | 9917 | Values: 164.0 155.0 154.0 155.0 156.0 158.0 155.0 154.0 155.0 157.0 14:22:40 INFO - PROCESS | 9917 | 14:22:40 INFO - PROCESS | 9917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 14:22:40 INFO - PROCESS | 9917 | Values: 67.0 69.0 66.0 66.0 64.0 66.0 66.0 64.0 65.0 66.0 14:22:40 INFO - PROCESS | 9917 | -------- Summary: end -------- 14:22:40 INFO - PROCESS | 9917 | 14:22:41 INFO - TEST-INFO | 9917: exit 0 14:22:41 INFO - TEST-OK | kraken | took 60346ms 14:22:41 INFO - SUITE-END | took 1172s 14:22:41 INFO - Completed test suite (00:19:32) 14:22:41 INFO - javascript benchmark 14:22:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.834258287086, 3383.8646454141835, 3400.914977125573, 3400.9659903400957, 3428.639992800756, 5562.471565201305, 5602.187682785999, 5618.550515958724, 5621.297337832771, 5623.859403514914, 5559.360673522546, 5623.212750214963, 5629.746661400237, 5633.549316054716, 5634.4928956393915, 4875.609951203895, 5056.696598204101, 5144.819931302405, 5190.558802501791, 5220.216967454893, 5010.323606313155, 5027.195648696209, 5051.5453609175165, 5091.0, 5098.4901509848905, 5002.59979201663, 5017.272495488152, 5064.721440320781, 5078.949210507903, 5091.287219789214, 5060.316857224265, 5114.514121158502, 5149.742512874342, 5160.56135228506, 5175.8188463403785, 4977.253411988195, 4991.176455884774, 5050.964552266776, 5054.873628159326, 5076.695398276115, 5413.485718856702, 5431.809886653988, 5444.0, 5474.753636086346, 5475.917861232085, 6043.8791224175275, 6075.149479072933, 6080.635161890256, 6084.0, 6086.421789929949, 5961.195238642815, 6019.939800601982, 6051.389095969368, 6070.635761854259, 6105.32841387447, 5626.099824028177, 5675.772969081232, 5679.432056794329, 5680.517156041783, 5680.5455563554815, 5970.671613061323, 6196.287426945959, 6198.256209254918, 6211.409916057967, 6211.534134939807, 5859.501942334864, 5913.231279933581, 5928.436798504222, 5930.52555795544, 5939.554533410012, 5900.527957763455, 5905.43898329658, 5905.734241959122, 5908.409159084057, 5916.526677865761, 5827.562932780059, 5839.824805255849, 5846.678432686158, 5854.8536286592325, 5875.588708790429, 5946.375630558816, 5948.67282299469, 5953.166556682068, 5958.612690175125, 5997.010493268562, 4540.091981603692, 4552.499225085238, 4555.0, 4555.794989225493, 4584.15193189261, 3997.4603428537357, 4053.351463765783, 4069.328560787496, 4073.572274911151, 4104.651104656137, 5673.262475878192, 5682.119271512922, 5695.373508914016, 5718.228039214736, 5726.77092916287, 6030.909536356959, 6035.849103772353, 6039.033754599331, 6041.365656606081, 6042.244719410074, 5654.971725141348, 5663.660180389107, 5714.571407144481, 5785.71071446426, 5805.129230615442, 5084.211947148198, 5090.567301779391, 5101.20931255656, 5105.617078719111, 5117.667351622133, 6251.624902505864, 6287.0, 6287.056941458818, 6287.685615719196, 6288.151099601495, 5838.5037271831525, 6052.092186172109, 6109.34393638171, 6138.416850399205, 6140.140380346845, 6265.0, 6310.842228944313, 6315.463185629273, 6330.303666596763, 6332.271788744353, 5816.982028145142, 5923.7926672566255, 5939.554533409925, 5955.76176952917, 5961.344252132175, 6045.365236650265, 6068.0, 6092.603980741238, 6093.2078829751845, 6112.235970503687, 5848.210491583582, 5861.120831875252, 5868.618539794899, 5884.823455296348, 5885.55858310637, 5735.7418916148035, 5820.1560773688425, 5862.472377486047, 5875.50058245054, 5887.028640274307, 5757.798477053283, 5786.826395208151, 5791.739371728367, 5796.536277097906, 5832.650040997553, 5898.439648233411, 5908.113782932594, 5910.320313164041, 5925.40745925404, 5926.614770039933, 5689.573282003784, 5798.82603521895, 5799.565032622486, 5830.300363956352, 5878.617889837147], "value": 5534.770896747228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.4972620808185, 679.6058286194007, 679.6975345971044, 733.2484203691213, 737.6016950846544, 32121.19697007573, 32711.67288327116, 32726.018219453425, 32735.345293094124, 32743.836280818563, 33142.171445713866, 41294.99999999993, 42185.0, 42254.36618450726, 42308.0, 8755.0, 8966.865497017518, 8975.820483590323, 8979.551022448884, 8981.101889811032, 8763.95618021909, 8884.8667269991, 8887.777805554848, 8889.066648001964, 8889.377743557954, 8914.197722205, 8986.820263594724, 8987.236084932789, 8988.910110898905, 8991.370604057685, 8907.198352148305, 8930.37487375884, 8938.508382038985, 8945.46327220369, 8948.015718271017, 9061.411008284505, 9164.725058248196, 9166.129217724305, 9170.358074934757, 9183.632654693803, 44018.0, 44376.3343549847, 44470.33294500585, 44479.0, 44516.55483445156, 3884.261990221877, 4036.455078564415, 4200.579942005806, 4353.390525326457, 4629.51390104041, 33628.49557256643, 33924.0, 34007.4898876517, 34151.146221344665, 35009.6499035009, 4433.0, 4528.909421811578, 4541.341505481687, 4552.590266875997, 4602.332661764059, 309043.4547827269, 309606.0, 310821.0, 311408.0, 311640.0, 60733.0, 61066.38933610607, 61439.0, 61486.69256653778, 61535.38464615386, 71101.0, 72700.27299726935, 72863.0, 72902.0, 72993.6350318245, 19450.70823937642, 19570.608587828163, 19647.312344068174, 19657.901710491642, 19679.31122410709, 15527.068375897483, 15622.296996634952, 15622.76565851513, 15625.921870390575, 15633.609159771097, 20841.0, 21082.894585526974, 21089.367318980454, 21104.577908441745, 21155.048022839008, 7598.544087354777, 7661.731839385595, 7703.6918523259565, 7749.225077492319, 7758.9612051939375, 1141.263884794303, 1155.9595414160465, 1193.3496244546743, 1198.7035651957117, 1267.4930027988878, 33851.322973540395, 33983.0, 34001.14997125092, 34400.311993759984, 34618.30763384718, 1206.6018213989362, 1234.9938250308692, 1243.440451796695, 1247.607003793802, 1416.2564653556758, 17416.738748918775, 18123.0, 18294.17676204574, 18311.908440457977, 18317.54206144857, 523934.0, 524281.0, 531322.0, 535302.0, 536019.0, 62550.0617490738, 63299.0, 63353.68323158355, 63400.0, 63525.0, 1509.781081743163, 1519.187234829361, 1555.2612509058333, 1646.514278287908, 1655.389739575277, 29520.704792951794, 29933.251668708457, 32123.67876321207, 33265.83367083149, 33378.49932251067, 50128.498715012385, 50394.0, 50728.746356267984, 50764.23853642272, 50859.491405086956, 300438.0, 304913.0, 305029.0, 305193.0, 306380.0, 27344.179674609793, 27967.860160699067, 30390.0, 31226.687733122377, 31451.685483144876, 44340.0, 44921.32618010798, 45348.31977520406, 46018.76990615026, 46048.76975615101, 37499.0, 37938.241235175694, 37968.0, 38193.80903095578, 38514.229715404974, 36956.44565331576, 36986.0, 37108.443373348884, 39394.0, 39637.80181099076, 42273.0, 42705.35941960811, 42965.0, 43131.568684314014, 43196.78401607972, 35166.0, 36004.639953600126, 36370.63629363672, 36643.45034824427, 36924.630753692116, 28117.297067573476, 28194.718052819208, 28287.29281767972, 28343.291417713895, 28429.289267768472], "value": 20650.288394383067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.62896650947164, 424.83006797281064, 428.33821745403367, 435.1731709751472, 443.3925522034813, 18771.43685689428, 19548.609027819453, 19553.0, 20056.59886802263, 20774.376768696926, 13302.534411295606, 13621.591352259424, 16583.91708041458, 20400.693989590167, 20413.0, 5299.867503312429, 5365.275687782138, 5480.671159730429, 5516.558675305986, 5546.084895992157, 5461.808836690717, 5477.424870388611, 5488.121900495921, 5509.559235261169, 5510.559155267589, 5486.094794358946, 5491.039068163075, 5493.176023596453, 5493.450654934494, 5692.686902220376, 5956.106584012389, 5981.1028345748055, 5988.850278743044, 5991.640501569898, 6027.698615069251, 5761.279840019997, 5822.737976791054, 5830.591858569902, 5830.7667693292215, 5831.329397119343, 14594.927025364805, 14653.267336633126, 14870.330835112338, 15014.399424023026, 15027.09837409759, 2681.5441374966304, 2922.313256384748, 3158.589383380169, 3206.7915585487103, 3241.465158248886, 12788.936055319757, 13821.654458638615, 13903.165810051429, 14200.431982720678, 14755.55733328002, 1959.7864591129044, 2077.1172251792927, 2106.557622899193, 2111.8099371056524, 2179.901904414305, 75223.0, 79670.0, 79944.20055799368, 80048.19951800523, 81461.59269203675, 11606.361650109326, 11730.88269117315, 11836.112291578165, 11858.762824743457, 11905.166638335233, 16764.1617919106, 16793.496195114167, 16880.240389182516, 16885.0, 16893.831061689227, 8785.604647790864, 8794.34042446819, 8817.338699597556, 8972.0, 9017.143371379709, 8341.332693384515, 8379.413441059189, 8412.327013839, 8433.620487078097, 8577.742667719978, 5083.0, 5131.076406246912, 5153.484651534892, 5162.096633089194, 5220.608454365938, 2085.18677715691, 2114.9471263218543, 2128.872267663945, 2140.6467932790915, 2172.3482955113404, 1011.6256984915481, 1027.3989716016215, 1036.2694300518117, 1092.819684752007, 1111.1388673777888, 18500.259989600265, 18832.340868069827, 18935.33726319572, 19444.02779861001, 19738.90130549367, 1073.2487258918788, 1076.8169411200115, 1077.355093246079, 1154.3016475032653, 1173.636172786439, 10734.194935379877, 10975.231733778559, 11073.446327683583, 11137.10903127764, 11316.151288653384, 528596.0, 559056.0, 570516.0, 572135.0, 574493.0, 76331.0, 83870.58064709637, 86472.0, 97476.51261743646, 101102.0, 1160.489384670742, 1163.831244469547, 1184.691980085184, 1191.350713860948, 1191.8808119188186, 17347.479575612753, 17710.0, 17919.37282195117, 18037.90981045139, 18451.44645660632, 40743.7962810184, 41073.58926410697, 41209.38185927153, 42603.14793704171, 43142.35286470768, 61450.0, 61720.69139654273, 61730.0, 61855.38144618676, 61914.69042654758, 9274.165325120772, 9304.0, 9310.767230819283, 9430.811383772423, 9569.138777510057, 10014.499275036365, 13151.53969611059, 13396.93301533486, 13592.32038398096, 13616.727665446833, 11504.424778761197, 11812.82280765772, 11896.524139034342, 12061.75876482483, 12550.058745593935, 11539.423028848692, 11787.646370608552, 11887.346195959306, 12083.637490875288, 12216.328101954477, 11623.535058597561, 11881.643550693492, 12423.0, 12533.435995380047, 12640.178388404724, 9078.591463384031, 9121.133492318218, 9152.679656212, 9220.769480763034, 9439.905600943903, 9552.808943821223, 11580.189386742848, 11853.703657408289, 11997.64007079789, 12339.07456940715], "value": 9571.469683872567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.8783753380962, 1607.2606600963557, 1612.3067081155104, 1866.0949439521837, 1936.3029309448596, 8375.748727538175, 8471.91528084719, 8550.230479256865, 8581.52801595912, 8581.957090214555, 8407.075221725605, 8586.570671466432, 8591.828163436727, 8592.699255526059, 8607.39748217625, 2483.8509689418647, 2503.636972638966, 2508.2224510401743, 2509.623556466526, 2510.2469259222253, 2400.6159014557675, 2502.7121880983645, 2503.987480062597, 2507.5110353481077, 2512.38446580588, 2410.9758902410927, 2422.6002709552904, 2450.742672019439, 2463.4949835283724, 2469.2098528470897, 2416.395901024744, 2434.330559096245, 2447.645091461737, 2477.962830557543, 2481.0323973650293, 2459.5203935232635, 2469.3209367423924, 2487.6641653376923, 2508.498300339921, 2509.9372515687073, 8265.214804593554, 8443.788905277355, 8679.522626255553, 8722.694705685333, 8725.869111963326, 5374.838754837361, 5469.535089517396, 5474.7810087596445, 5521.365043020064, 5530.834074977757, 3415.470602056685, 3441.896743097711, 3476.2699833035094, 3578.1949061460964, 3583.140046388848, 1085.4084523934475, 1140.7775483780665, 1175.659058872926, 1182.5860948667982, 1229.858566264882, 12168.0, 12486.875131248753, 12611.936940315332, 12613.0, 12655.683607909876, 4588.174128656807, 4597.42532183477, 4663.860084197479, 4686.343911852344, 4738.218193998021, 10026.69919902404, 10030.849537256947, 10036.64871729486, 10063.094321511098, 10069.899301006895, 5348.277982472394, 5387.865303367447, 5390.51485366319, 5392.973035134878, 5402.189671549299, 4374.21264172452, 4765.046990601893, 4859.538343857328, 4890.266460030953, 5012.523810238022, 3947.6052394760295, 3958.386450100239, 4002.519697636244, 4057.289974254553, 4060.614241647098, 1181.4329122021477, 1191.3566673995945, 1191.9404029798475, 1199.382318106176, 1208.9032877369789, 913.8949020862553, 978.6819283732673, 990.3810118675827, 1010.9536629588341, 1046.7016900183564, 6018.0, 6032.095185722177, 6043.969780151071, 6066.332703402622, 6202.689865506707, 482.0792286732324, 486.6787919972801, 487.7804987755524, 495.10139097538575, 500.29458463566925, 4146.771927544014, 4229.2598795210715, 4259.041715613962, 4292.0, 4349.19539885116, 10657.25399222047, 11050.502727377287, 11156.219064665558, 11162.497687604076, 11162.888371116347, 10952.178586605876, 10959.232853700165, 10975.06711929479, 10976.341419514854, 10994.230403871812, 8290.502569845828, 8426.115257897833, 8511.191436813617, 8524.957375213084, 8527.530985795716, 6026.427489388501, 6091.238595175603, 6125.356837531995, 6179.969100154471, 6221.191245138284, 9328.720138395858, 9740.12338889475, 9767.0, 9921.751956201153, 9956.20350371983, 9818.950905245429, 9908.801823963337, 10129.341592796445, 10146.949265253626, 10150.49247537635, 6878.0, 7034.859302814018, 7479.439042071976, 7984.960075199587, 8083.797905052421, 8229.547374894439, 8254.504729715996, 8314.334853211607, 8316.0, 8321.043080045873, 7444.106707194955, 7671.232876712284, 7735.303822655988, 7792.220777922163, 7837.804054898673, 7560.697572097055, 7603.88594171099, 7621.961890190513, 7693.1922148173635, 7726.4205184610255, 6861.142357205349, 6872.10662613857, 6894.13823272091, 6894.413974811997, 6898.0, 4907.214845624826, 4966.130927087673, 5015.247712843103, 5022.3219865317715, 5098.209777484496, 5144.871378215575, 5193.143131383431, 5286.15421532553, 5287.444818294024, 5288.68267903927], "value": 4612.337188248559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.64935064935065, 357.403136761608, 358.7488757869491, 364.58619466905054, 372.42646324660024, 6056.212692349994, 6062.302835173957, 6065.545084118687, 6089.78685745999, 6096.695165241731, 6016.849578760533, 6037.0340745480735, 6039.033754599265, 6056.091586262063, 6066.272047354312, 4500.5049444561155, 4594.816207351719, 4695.225287827504, 4705.435347758274, 4709.081729062834, 4666.39336886206, 4684.43786745591, 4695.084458530588, 4705.764711764416, 4709.434867815867, 4488.528704486031, 4663.720176789387, 4675.579197872191, 4680.157571637121, 4687.0, 4552.9089418211615, 4633.721976681393, 4653.139169253699, 4658.208104622222, 4666.580007799281, 4110.280700877334, 4113.053997580543, 4116.341385378355, 4127.988642782538, 4128.4632997710405, 5781.797637082724, 5789.247397838296, 5794.275715535558, 5795.130730390433, 5804.2744656917885, 5436.130219164915, 5436.157395603688, 5445.673259604397, 5446.319210098738, 5453.072977593819, 6381.138546296237, 6389.36106389362, 6390.0, 6396.968015159941, 6398.58409203405, 4506.369108324837, 4620.19146649335, 4624.0, 4646.372739680134, 4667.533246675339, 6587.275399706028, 6646.867062658768, 6714.697838597275, 6718.8320291993095, 6723.899141512881, 4760.7619619018915, 4764.404449443819, 4767.332573439721, 4771.23660214364, 4775.5224477551965, 4820.4456487504385, 4826.975865120652, 4829.782659780319, 4830.082284365959, 4830.203016502308, 5444.673319600836, 5458.563314934796, 5476.972615136979, 5481.150421684645, 5503.889922201533, 6350.0792385103905, 6483.578567393104, 6484.157059582224, 6489.059086432535, 6489.221293444817, 1669.2822086502676, 1685.3174464341962, 1694.9661006779795, 1699.1674079701104, 1700.9234584443482, 1093.8359246112987, 1138.3397629374942, 1152.251036826053, 1168.5442677355838, 1173.4191575170346, 6245.96877015612, 6252.718627661766, 6254.6247225166635, 6258.061290806324, 6263.217097862767, 6610.438112760373, 6610.8016759497295, 6616.933830661728, 6617.702203400859, 6625.039369291426, 6236.438720515175, 6243.313235544087, 6246.0, 6262.937370626327, 6267.467265282502, 3533.699635530957, 3556.199855032597, 3566.696830769362, 3567.4292113261754, 3568.982155089208, 6748.0, 6884.105066341343, 6897.931020689729, 6965.233824279325, 7013.123359580052, 6720.8319792005595, 6764.830879228059, 6802.489813263926, 6823.112995310578, 6834.624095674686, 6876.277990810993, 6893.310668933167, 6894.207166175854, 6906.274841141708, 6923.169219693669, 6586.110875031809, 6591.703373348115, 6600.306967768315, 6604.306547812603, 6605.504587155887, 6278.434940855345, 6487.253965793805, 6488.221413430419, 6496.740130394731, 6515.153030106056, 6854.862902742017, 6878.759243426456, 6885.724571017103, 6889.242183359726, 6889.655517224219, 4713.646476514206, 4725.432948046257, 4764.0, 4764.714117152982, 4768.666193366431, 6571.572847765071, 6578.0, 6578.638174900427, 6591.703373348115, 6593.109930159367, 6290.622562646256, 6344.809655710336, 6386.042093685985, 6390.64851433157, 6446.742130314735, 6433.839154021187, 6443.484521238383, 6459.160309159779, 6506.837329066811, 6508.8047358579315, 6363.649999250086, 6371.426571608577, 6372.745090196526, 6378.649174295459, 6388.233411990591, 6546.476281897341, 6552.410283074546, 6554.541182117206, 6564.737410503526, 6569.57297775643, 6018.969905150446, 6142.815715528542, 6172.19761431029, 6396.904046439214, 6404.263509696445], "value": 4905.419190739181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.4052062254863, 849.4181485682308, 874.685113359191, 881.7531091294439, 964.7250533597924, 13626.591202263935, 13714.24571648559, 13765.449382024706, 13791.586252412431, 13794.379252933604, 13246.0, 13259.138156019852, 13270.336483175826, 13312.134711243762, 14065.718685626282, 763.4617594595796, 917.6283605139929, 918.8024574716435, 927.638221093774, 928.2110206324637, 908.3278374003223, 930.3627015494408, 935.5228833295034, 935.9625614975427, 936.887573491182, 966.3622009473748, 969.6509256667593, 969.7236287658019, 971.0823272007955, 972.2950860626061, 796.2197046894076, 812.597764106765, 968.8934217236134, 969.2439896880445, 969.3699095587854, 596.0879853823614, 705.3052743048094, 719.8380364418016, 720.3948683106216, 720.697307131001, 15355.155466449341, 15363.0, 15378.154201519024, 15390.846091539053, 15423.0, 14939.0, 15439.459618913284, 15443.922780386138, 15482.845171548253, 15532.844671553254, 12007.57973470933, 12390.442430090667, 12411.255324680458, 12468.501259949591, 12481.251124932533, 4045.1707399982934, 4098.8360465581345, 4103.179364127186, 4105.137921036586, 4110.972256935766, 54442.45557544453, 54452.72773636106, 54465.72767136178, 54484.0, 54877.0, 11565.595204167814, 11831.408429578487, 11899.226550274378, 11974.080952095668, 12238.694032649255, 22161.66757498639, 22391.10435582591, 22451.21420750266, 22466.887665561895, 22470.43823904383, 8821.647134114564, 8920.8661870072, 8961.790158328673, 8972.37193396456, 9085.091490850862, 4739.199249077585, 4824.445188803263, 4846.0, 4914.827981020647, 4996.850094497171, 3619.3847046002243, 3663.6519530644546, 3678.779273243614, 3682.6869716073898, 3684.428913518409, 636.9840753981188, 645.2321737132797, 762.397705812413, 781.2187812187813, 784.0395515493589, 794.3089512124374, 807.9515229086273, 823.2138307915926, 832.5088197963231, 837.1001173738134, 9270.30472714549, 9527.428354298765, 9564.713058608253, 9584.137427631547, 9808.264380171515, 790.4782843323379, 797.1351084073845, 804.6781287485053, 822.0382152881143, 860.9225169734754, 4559.863204103882, 4582.0377720679035, 4612.423447069116, 4639.907201855944, 4701.976490117528, 63824.68087659625, 64732.35267647357, 65035.34964650293, 65050.0, 65212.67393663001, 55568.16647750287, 56189.71905140448, 56455.15317270244, 56460.153097703565, 56695.0, 51012.23481647778, 51337.74331128395, 51485.7425712869, 52267.47732522626, 52832.73583632134, 7638.847223055396, 7982.481138725964, 8541.060483346702, 9127.863082053907, 9452.527373631428, 39169.2166156681, 39379.212415752096, 39863.2027359457, 40060.59939400569, 40744.185116298104, 45125.54874451213, 45724.31413528866, 48296.0, 50429.74785126051, 51183.23225151551, 11223.326600404002, 11442.599509017144, 11538.82691759641, 11901.404929753304, 12077.456514456695, 12985.675358116123, 13083.476660933457, 13157.736845263233, 13210.207387556777, 13304.201747895157, 12641.747165056464, 12721.681957951125, 12879.227246365248, 12935.223886566837, 13124.737505250032, 12144.089193310714, 12272.38638068111, 12306.0, 12309.692257693629, 12330.19853709506, 12863.871361286641, 12870.935645322088, 12886.09797314179, 12898.613041608767, 12946.935265323613, 9157.77105572366, 9380.108889655472, 10006.29955903109, 10100.0, 10457.529411176363, 10014.549345279334, 10519.316244444086, 10539.63111291101, 10552.525136369035, 10662.200334975063], "value": 7115.909433002377, "unit": "score"}], "name": "dromaeo_css", "value": 7487.073372222678, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 110.0, 110.0, 110.0, 110.0, 106.0, 109.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 161.0, 174.0, 136.0, 156.0, 164.0, 126.0, 177.0, 125.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 75.0, 185.0, 73.0, 75.0, 73.0, 75.0, 168.0, 75.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 93.0, 92.0, 92.0, 153.0, 92.0, 91.0, 147.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 144.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 52.0, 52.0, 53.0, 53.0, 61.0, 72.0, 51.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 58.0, 57.0, 64.0, 58.0, 58.0, 59.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 81.0, 76.0, 75.0, 74.0, 74.0, 73.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 117.0, 113.0, 112.0, 112.0, 119.0, 110.0, 132.0, 124.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 155.0, 154.0, 155.0, 156.0, 158.0, 155.0, 154.0, 155.0, 157.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 66.0, 64.0, 66.0, 66.0, 64.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1510.4999999999998, "alertThreshold": 2.0}]} 14:22:41 INFO - Return code: 0 14:22:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:22:41 ERROR - # TBPL SUCCESS # 14:22:41 INFO - Running post-action listener: _resource_record_post_action 14:22:41 INFO - Running post-run listener: _resource_record_post_run 14:22:42 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 36864; Write bytes: 290037760; Read time: 712; Write time: 350280 14:22:42 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 69300224; Read time: 560; Write time: 87016 14:22:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 213565440; Read time: 136; Write time: 256888 14:22:42 INFO - Running post-run listener: _upload_blobber_files 14:22:42 INFO - Blob upload gear active. 14:22:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:22:42 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 14:22:42 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'] 14:22:42 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 14:22:43 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:43 INFO - (blobuploader) - INFO - Done attempting. 14:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:44 INFO - (blobuploader) - INFO - Done attempting. 14:22:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:44 INFO - Return code: 0 14:22:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c132c3b6e1074acd520e4d39ae55b00ec60f4cd01ee042207e8b3b70ff2e49671720969e1c0ff16e4edb68828ab2fc882bf467c7b2327574cd54cc8bed303f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51a540c32ee23a508ad6144c7e5758d46e84db40d2bf26a1714010b0c5050c987b5c0c984516d5655acb3296bb4f9f61494eb1c2f4551585525dd4a9056b2fba"} 14:22:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:44 INFO - Contents: 14:22:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c132c3b6e1074acd520e4d39ae55b00ec60f4cd01ee042207e8b3b70ff2e49671720969e1c0ff16e4edb68828ab2fc882bf467c7b2327574cd54cc8bed303f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51a540c32ee23a508ad6144c7e5758d46e84db40d2bf26a1714010b0c5050c987b5c0c984516d5655acb3296bb4f9f61494eb1c2f4551585525dd4a9056b2fba"} 14:22:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:44 INFO - Copying logs to upload dir... 14:22:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.910993 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-19 14:22:44.665092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:44.668325) ========= 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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 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/4c132c3b6e1074acd520e4d39ae55b00ec60f4cd01ee042207e8b3b70ff2e49671720969e1c0ff16e4edb68828ab2fc882bf467c7b2327574cd54cc8bed303f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51a540c32ee23a508ad6144c7e5758d46e84db40d2bf26a1714010b0c5050c987b5c0c984516d5655acb3296bb4f9f61494eb1c2f4551585525dd4a9056b2fba"} build_url:https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/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/4c132c3b6e1074acd520e4d39ae55b00ec60f4cd01ee042207e8b3b70ff2e49671720969e1c0ff16e4edb68828ab2fc882bf467c7b2327574cd54cc8bed303f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51a540c32ee23a508ad6144c7e5758d46e84db40d2bf26a1714010b0c5050c987b5c0c984516d5655acb3296bb4f9f61494eb1c2f4551585525dd4a9056b2fba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:44.700590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:44.700935) ========= 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=8783db0840cc980e80bb0bd400000236-1468961531.44235-300757634 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:44.784173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:22:44.784834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:22:44.785484) ========= ========= Total master_lag: 0.20 =========