builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1465035977.98 results: success (0) buildid: 20160604004005 builduid: 3bb2275371504e288b069880101f44c1 revision: ab782095ef4ab44dae4cc5f919858c5684837378 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:17.983582) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:17.983999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:17.984290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.032297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.032628) ========= 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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 03:26:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.8M=0s 2016-06-04 03:26:18 (48.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151588 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.216845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.217152) ========= 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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.267877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.268189) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab782095ef4ab44dae4cc5f919858c5684837378 --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-aurora --rev ab782095ef4ab44dae4cc5f919858c5684837378 --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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 03:26:18,410 truncating revision to first 12 chars 2016-06-04 03:26:18,410 Setting DEBUG logging. 2016-06-04 03:26:18,410 attempt 1/10 2016-06-04 03:26:18,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab782095ef4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 03:26:18,742 unpacking tar archive at: mozilla-aurora-ab782095ef4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.964831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.965169) ========= script_repo_revision: ab782095ef4ab44dae4cc5f919858c5684837378 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.965596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.965876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 03:26:18.974739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-04 03:26:18.975079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:19 INFO - MultiFileLogger online at 20160604 03:26:19 in /builds/slave/test 03:26:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:26:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:19 INFO - {'append_to_log': False, 03:26:19 INFO - 'base_work_dir': '/builds/slave/test', 03:26:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:19 INFO - 'branch': 'Mozilla-Aurora', 03:26:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:19 INFO - 'config_files': ('talos/linux_config.py',), 03:26:19 INFO - 'default_actions': ('clobber', 03:26:19 INFO - 'read-buildbot-config', 03:26:19 INFO - 'download-and-extract', 03:26:19 INFO - 'populate-webroot', 03:26:19 INFO - 'create-virtualenv', 03:26:19 INFO - 'install', 03:26:19 INFO - 'run-tests'), 03:26:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:19 INFO - 'download_minidump_stackwalk': True, 03:26:19 INFO - 'download_symbols': 'ondemand', 03:26:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:19 INFO - 'installer_path': 'installer.exe', 03:26:19 INFO - 'log_level': 'info', 03:26:19 INFO - 'log_name': 'talos', 03:26:19 INFO - 'log_to_console': True, 03:26:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:19 INFO - 'opt_config_files': (), 03:26:19 INFO - 'pip_index': False, 03:26:19 INFO - 'sps_profile': False, 03:26:19 INFO - 'sps_profile_interval': 0, 03:26:19 INFO - 'suite': 'dromaeojs', 03:26:19 INFO - 'system_bits': '32', 03:26:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:19 INFO - 'title': 'talos-linux64-ix-003', 03:26:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:19 INFO - 'use_talos_json': True, 03:26:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:19 INFO - 'work_dir': 'build'} 03:26:19 INFO - ##### 03:26:19 INFO - ##### Running clobber step. 03:26:19 INFO - ##### 03:26:19 INFO - Running pre-action listener: _resource_record_pre_action 03:26:19 INFO - Running main action method: clobber 03:26:19 INFO - rmtree: /builds/slave/test/build 03:26:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:20 INFO - Running post-action listener: _resource_record_post_action 03:26:20 INFO - ##### 03:26:20 INFO - ##### Running read-buildbot-config step. 03:26:20 INFO - ##### 03:26:20 INFO - Running pre-action listener: _resource_record_pre_action 03:26:20 INFO - Running main action method: read_buildbot_config 03:26:20 INFO - Using buildbot properties: 03:26:20 INFO - { 03:26:20 INFO - "project": "", 03:26:20 INFO - "product": "firefox", 03:26:20 INFO - "script_repo_revision": "production", 03:26:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:26:20 INFO - "repository": "", 03:26:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:26:20 INFO - "buildid": "20160604004005", 03:26:20 INFO - "stage_platform": "linux64-pgo", 03:26:20 INFO - "basedir": "/builds/slave/test", 03:26:20 INFO - "nightly_build": "True", 03:26:20 INFO - "buildnumber": 281, 03:26:20 INFO - "slavename": "talos-linux64-ix-003", 03:26:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:26:20 INFO - "platform": "ubuntu64_hw", 03:26:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:20 INFO - "branch": "mozilla-aurora", 03:26:20 INFO - "repo_path": "releases/mozilla-aurora", 03:26:20 INFO - "revision": "ab782095ef4ab44dae4cc5f919858c5684837378", 03:26:20 INFO - "pgo_build": "True", 03:26:20 INFO - "builduid": "3bb2275371504e288b069880101f44c1", 03:26:20 INFO - "slavebuilddir": "test" 03:26:20 INFO - } 03:26:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:26:20 INFO - Running post-action listener: _resource_record_post_action 03:26:20 INFO - ##### 03:26:20 INFO - ##### Running download-and-extract step. 03:26:20 INFO - ##### 03:26:20 INFO - Running pre-action listener: _resource_record_pre_action 03:26:20 INFO - Running main action method: download_and_extract 03:26:20 INFO - mkdir: /builds/slave/test/build/tests 03:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:20 INFO - https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:26:29 INFO - Downloaded 1361 bytes. 03:26:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:29 INFO - Using the following test package requirements: 03:26:29 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:29 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:29 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:29 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'jsshell-linux-x86_64.zip'], 03:26:29 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:29 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:29 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:29 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:29 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:29 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:29 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:34 INFO - Downloaded 24177598 bytes. 03:26:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:36 INFO - Return code: 0 03:26:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:36 INFO - https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:43 INFO - Downloaded 24177598 bytes. 03:26:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:44 INFO - Return code: 0 03:26: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')]} 03:26:44 INFO - https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:26:45 INFO - Downloaded 10840145 bytes. 03:26:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:26:46 INFO - Return code: 0 03:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:46 INFO - https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:26:47 INFO - Downloaded 62788433 bytes. 03:26:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:47 INFO - mkdir: /builds/slave/test/properties 03:26:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:47 INFO - Contents: 03:26:47 INFO - build_url:https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - Running post-action listener: set_extra_try_arguments 03:26:48 INFO - ##### 03:26:48 INFO - ##### Running populate-webroot step. 03:26:48 INFO - ##### 03:26:48 INFO - Running pre-action listener: _resource_record_pre_action 03:26:48 INFO - Running main action method: populate_webroot 03:26:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:48 INFO - '--tppagecycles', 03:26:48 INFO - '7'], 03:26:48 INFO - 'tests': ['tsvgm']}}, 03:26:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['damp', 'tps']}, 03:26:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'tests': ['damp', 'tps']}, 03:26:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['dromaeo_dom']}, 03:26:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint']}, 03:26:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['tsvgx', 03:26:48 INFO - 'tsvgr_opacity', 03:26:48 INFO - 'tart', 03:26:48 INFO - 'tscrollx', 03:26:48 INFO - 'cart']}, 03:26:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:48 INFO - 'tsvgr_opacity', 03:26:48 INFO - 'tart', 03:26:48 INFO - 'tscrollx', 03:26:48 INFO - 'cart']}, 03:26:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-e10s'], 03:26:48 INFO - 'tests': ['tp5o']}, 03:26:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'tests': ['tp5o']}, 03:26:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-e10s', 03:26:48 INFO - '--xperf_path', 03:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:48 INFO - 'tests': ['tp5n']}, 03:26:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:48 INFO - 'talos_options': ['--xperf_path', 03:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:48 INFO - 'tests': ['tp5n']}}, 03:26:48 INFO - 'talos.zip': {'path': '', 03:26:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - ##### 03:26:48 INFO - ##### Running create-virtualenv step. 03:26:48 INFO - ##### 03:26:48 INFO - Running pre-action listener: _resource_record_pre_action 03:26:48 INFO - Running main action method: create_virtualenv 03:26:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:48 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 03:26:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:48 INFO - Using real prefix '/usr' 03:26:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:51 INFO - Installing pip.................done. 03:26:51 INFO - Return code: 0 03:26:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:26: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', 'pip>=1.5'] in /builds/slave/test/build 03:26: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 pip>=1.5 03:26:51 INFO - Using env: {'DISPLAY': ':0', 03:26:51 INFO - 'HOME': '/home/cltbld', 03:26:51 INFO - 'LANG': 'en_US.UTF-8', 03:26:51 INFO - 'LANGUAGE': 'en_US:en', 03:26:51 INFO - 'LOGNAME': 'cltbld', 03:26:51 INFO - 'MAIL': '/var/mail/cltbld', 03:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:51 INFO - 'MOZ_NO_REMOTE': '1', 03:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:51 INFO - 'NO_EM_RESTART': '1', 03:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:51 INFO - 'PWD': '/builds/slave/test', 03:26:51 INFO - 'SHELL': '/bin/bash', 03:26:51 INFO - 'SHLVL': '1', 03:26:51 INFO - 'TERM': 'linux', 03:26:51 INFO - 'TMOUT': '86400', 03:26:51 INFO - 'USER': 'cltbld', 03:26:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:51 INFO - '_': '/tools/buildbot/bin/python'} 03:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:51 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 03:26:51 INFO - Cleaning up... 03:26:51 INFO - Return code: 0 03:26:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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', '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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:26: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:26: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 psutil>=0.7.1 03:26:51 INFO - Using env: {'DISPLAY': ':0', 03:26:51 INFO - 'HOME': '/home/cltbld', 03:26:51 INFO - 'LANG': 'en_US.UTF-8', 03:26:51 INFO - 'LANGUAGE': 'en_US:en', 03:26:51 INFO - 'LOGNAME': 'cltbld', 03:26:51 INFO - 'MAIL': '/var/mail/cltbld', 03:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:51 INFO - 'MOZ_NO_REMOTE': '1', 03:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:51 INFO - 'NO_EM_RESTART': '1', 03:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:51 INFO - 'PWD': '/builds/slave/test', 03:26:51 INFO - 'SHELL': '/bin/bash', 03:26:51 INFO - 'SHLVL': '1', 03:26:51 INFO - 'TERM': 'linux', 03:26:51 INFO - 'TMOUT': '86400', 03:26:51 INFO - 'USER': 'cltbld', 03:26:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:51 INFO - '_': '/tools/buildbot/bin/python'} 03:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:51 INFO - Downloading/unpacking psutil>=0.7.1 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:53 INFO - Installing collected packages: psutil 03:26:53 INFO - Running setup.py install for psutil 03:26:53 INFO - building 'psutil._psutil_linux' extension 03:26:53 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 03:26:55 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 03:26:55 INFO - building 'psutil._psutil_posix' extension 03:26:55 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 03:26:55 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 03:26:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:55 INFO - Successfully installed psutil 03:26:55 INFO - Cleaning up... 03:26:56 INFO - Return code: 0 03:26:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26:56 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')]} 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 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')]} 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:26:56 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 03:26:56 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 03:26:56 INFO - Using env: {'DISPLAY': ':0', 03:26:56 INFO - 'HOME': '/home/cltbld', 03:26:56 INFO - 'LANG': 'en_US.UTF-8', 03:26:56 INFO - 'LANGUAGE': 'en_US:en', 03:26:56 INFO - 'LOGNAME': 'cltbld', 03:26:56 INFO - 'MAIL': '/var/mail/cltbld', 03:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:56 INFO - 'MOZ_NO_REMOTE': '1', 03:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:56 INFO - 'NO_EM_RESTART': '1', 03:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:56 INFO - 'PWD': '/builds/slave/test', 03:26:56 INFO - 'SHELL': '/bin/bash', 03:26:56 INFO - 'SHLVL': '1', 03:26:56 INFO - 'TERM': 'linux', 03:26:56 INFO - 'TMOUT': '86400', 03:26:56 INFO - 'USER': 'cltbld', 03:26:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:56 INFO - '_': '/tools/buildbot/bin/python'} 03:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:58 INFO - Installing collected packages: mozsystemmonitor 03:26:58 INFO - Running setup.py install for mozsystemmonitor 03:26:58 INFO - Successfully installed mozsystemmonitor 03:26:58 INFO - Cleaning up... 03:26:58 INFO - Return code: 0 03:26:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:58 INFO - Using env: {'DISPLAY': ':0', 03:26:58 INFO - 'HOME': '/home/cltbld', 03:26:58 INFO - 'LANG': 'en_US.UTF-8', 03:26:58 INFO - 'LANGUAGE': 'en_US:en', 03:26:58 INFO - 'LOGNAME': 'cltbld', 03:26:58 INFO - 'MAIL': '/var/mail/cltbld', 03:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:58 INFO - 'MOZ_NO_REMOTE': '1', 03:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:58 INFO - 'NO_EM_RESTART': '1', 03:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:58 INFO - 'PWD': '/builds/slave/test', 03:26:58 INFO - 'SHELL': '/bin/bash', 03:26:58 INFO - 'SHLVL': '1', 03:26:58 INFO - 'TERM': 'linux', 03:26:58 INFO - 'TMOUT': '86400', 03:26:58 INFO - 'USER': 'cltbld', 03:26:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:58 INFO - '_': '/tools/buildbot/bin/python'} 03:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:01 INFO - Downloading docopt-0.6.1.tar.gz 03:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:01 INFO - Running setup.py install for blobuploader 03:27:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:01 INFO - Running setup.py install for requests 03:27:01 INFO - Running setup.py install for docopt 03:27:01 INFO - Successfully installed blobuploader requests docopt 03:27:01 INFO - Cleaning up... 03:27:02 INFO - Return code: 0 03:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:02 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')]} 03:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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')]} 03:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:27:02 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 03:27:02 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 03:27:02 INFO - Using env: {'DISPLAY': ':0', 03:27:02 INFO - 'HOME': '/home/cltbld', 03:27:02 INFO - 'LANG': 'en_US.UTF-8', 03:27:02 INFO - 'LANGUAGE': 'en_US:en', 03:27:02 INFO - 'LOGNAME': 'cltbld', 03:27:02 INFO - 'MAIL': '/var/mail/cltbld', 03:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:02 INFO - 'MOZ_NO_REMOTE': '1', 03:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:02 INFO - 'NO_EM_RESTART': '1', 03:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:02 INFO - 'PWD': '/builds/slave/test', 03:27:02 INFO - 'SHELL': '/bin/bash', 03:27:02 INFO - 'SHLVL': '1', 03:27:02 INFO - 'TERM': 'linux', 03:27:02 INFO - 'TMOUT': '86400', 03:27:02 INFO - 'USER': 'cltbld', 03:27:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:02 INFO - '_': '/tools/buildbot/bin/python'} 03:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:02 INFO - Running setup.py (path:/tmp/pip-BIsOHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 INFO - Running setup.py (path:/tmp/pip-VYbmCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Running setup.py (path:/tmp/pip-o6bisU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Running setup.py (path:/tmp/pip-kzmxAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:02 INFO - Running setup.py (path:/tmp/pip-SYweZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 INFO - Running setup.py (path:/tmp/pip-SOKnCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 INFO - Running setup.py (path:/tmp/pip-mvoV6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 INFO - Running setup.py (path:/tmp/pip-xR5X7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:02 INFO - Running setup.py (path:/tmp/pip-DkoS_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:02 INFO - Running setup.py (path:/tmp/pip-kvIWeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:02 INFO - Running setup.py (path:/tmp/pip-k_CclB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 INFO - Running setup.py (path:/tmp/pip-jzExvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 INFO - Running setup.py (path:/tmp/pip-rEwk1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 INFO - Running setup.py (path:/tmp/pip-tmxMM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 INFO - Running setup.py (path:/tmp/pip-8mWrA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:03 INFO - Running setup.py (path:/tmp/pip-BCpxve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:03 INFO - Running setup.py (path:/tmp/pip-0sVMC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:03 INFO - Running setup.py install for manifestparser 03:27:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:03 INFO - Running setup.py install for mozcrash 03:27:03 INFO - Running setup.py install for mozdebug 03:27:03 INFO - Running setup.py install for mozdevice 03:27:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:03 INFO - Running setup.py install for mozfile 03:27:04 INFO - Running setup.py install for mozhttpd 03:27:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozinfo 03:27:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozInstall 03:27:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozleak 03:27:04 INFO - Running setup.py install for mozlog 03:27:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for moznetwork 03:27:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozprocess 03:27:04 INFO - Running setup.py install for mozprofile 03:27:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozrunner 03:27:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:04 INFO - Running setup.py install for mozscreenshot 03:27:05 INFO - Running setup.py install for moztest 03:27:05 INFO - Running setup.py install for mozversion 03:27:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:05 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')]} 03:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:05 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')]} 03:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:05 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:27:05 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 03:27:05 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 03:27:05 INFO - Using env: {'DISPLAY': ':0', 03:27:05 INFO - 'HOME': '/home/cltbld', 03:27:05 INFO - 'LANG': 'en_US.UTF-8', 03:27:05 INFO - 'LANGUAGE': 'en_US:en', 03:27:05 INFO - 'LOGNAME': 'cltbld', 03:27:05 INFO - 'MAIL': '/var/mail/cltbld', 03:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:05 INFO - 'MOZ_NO_REMOTE': '1', 03:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:05 INFO - 'NO_EM_RESTART': '1', 03:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:05 INFO - 'PWD': '/builds/slave/test', 03:27:05 INFO - 'SHELL': '/bin/bash', 03:27:05 INFO - 'SHLVL': '1', 03:27:05 INFO - 'TERM': 'linux', 03:27:05 INFO - 'TMOUT': '86400', 03:27:05 INFO - 'USER': 'cltbld', 03:27:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:05 INFO - '_': '/tools/buildbot/bin/python'} 03:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:05 INFO - Running setup.py (path:/tmp/pip-C0tRzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:05 INFO - Running setup.py (path:/tmp/pip-12IXL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:05 INFO - Running setup.py (path:/tmp/pip-pAGTiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:05 INFO - Running setup.py (path:/tmp/pip-HJtXTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:05 INFO - Running setup.py (path:/tmp/pip-Wo2S0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:05 INFO - Running setup.py (path:/tmp/pip-4nDXNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:05 INFO - Running setup.py (path:/tmp/pip-LDsjHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:05 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)) 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:06 INFO - Running setup.py (path:/tmp/pip-NH4VRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:06 INFO - Running setup.py (path:/tmp/pip-aHdss0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:06 INFO - Running setup.py (path:/tmp/pip-zUmyCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:06 INFO - Running setup.py (path:/tmp/pip-0FnXBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:06 INFO - Running setup.py (path:/tmp/pip-7zqbmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:06 INFO - Running setup.py (path:/tmp/pip-N8rWmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:06 INFO - Running setup.py (path:/tmp/pip-6tWLv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:06 INFO - Running setup.py (path:/tmp/pip-CttC0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:06 INFO - Running setup.py (path:/tmp/pip-tueXqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:06 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)) 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:06 INFO - Running setup.py (path:/tmp/pip-cOBINn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:06 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)) 03:27:06 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)) 03:27:06 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)) 03:27:06 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)) 03:27:06 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)) 03:27:06 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)) 03:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:06 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 03:27:06 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 03:27:06 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 03:27:06 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 03:27:06 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 03:27:06 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 03:27:08 INFO - Downloading blessings-1.6.tar.gz 03:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:08 INFO - Installing collected packages: blessings 03:27:08 INFO - Running setup.py install for blessings 03:27:08 INFO - Successfully installed blessings 03:27:08 INFO - Cleaning up... 03:27:08 INFO - Return code: 0 03:27:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:09 INFO - Reading from file tmpfile_stdout 03:27:09 INFO - Current package versions: 03:27:09 INFO - argparse == 1.2.1 03:27:09 INFO - blessings == 1.6 03:27:09 INFO - blobuploader == 1.2.4 03:27:09 INFO - docopt == 0.6.1 03:27:09 INFO - manifestparser == 1.1 03:27:09 INFO - mozInstall == 1.12 03:27:09 INFO - mozcrash == 0.17 03:27:09 INFO - mozdebug == 0.1 03:27:09 INFO - mozdevice == 0.48 03:27:09 INFO - mozfile == 1.2 03:27:09 INFO - mozhttpd == 0.7 03:27:09 INFO - mozinfo == 0.9 03:27:09 INFO - mozleak == 0.1 03:27:09 INFO - mozlog == 3.1 03:27:09 INFO - moznetwork == 0.27 03:27:09 INFO - mozprocess == 0.22 03:27:09 INFO - mozprofile == 0.28 03:27:09 INFO - mozrunner == 6.11 03:27:09 INFO - mozscreenshot == 0.1 03:27:09 INFO - mozsystemmonitor == 0.0 03:27:09 INFO - moztest == 0.7 03:27:09 INFO - mozversion == 1.4 03:27:09 INFO - psutil == 3.1.1 03:27:09 INFO - requests == 1.2.3 03:27:09 INFO - wsgiref == 0.1.2 03:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:09 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')]} 03:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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')]} 03:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:27:09 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 03:27:09 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 03:27:09 INFO - Using env: {'DISPLAY': ':0', 03:27:09 INFO - 'HOME': '/home/cltbld', 03:27:09 INFO - 'LANG': 'en_US.UTF-8', 03:27:09 INFO - 'LANGUAGE': 'en_US:en', 03:27:09 INFO - 'LOGNAME': 'cltbld', 03:27:09 INFO - 'MAIL': '/var/mail/cltbld', 03:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:09 INFO - 'MOZ_NO_REMOTE': '1', 03:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:09 INFO - 'NO_EM_RESTART': '1', 03:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:09 INFO - 'PWD': '/builds/slave/test', 03:27:09 INFO - 'SHELL': '/bin/bash', 03:27:09 INFO - 'SHLVL': '1', 03:27:09 INFO - 'TERM': 'linux', 03:27:09 INFO - 'TMOUT': '86400', 03:27:09 INFO - 'USER': 'cltbld', 03:27:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:09 INFO - '_': '/tools/buildbot/bin/python'} 03:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 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)) 03:27:09 INFO - Cleaning up... 03:27:09 INFO - Return code: 0 03:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:09 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')]} 03:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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')]} 03:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:27:09 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 03:27:09 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 03:27:09 INFO - Using env: {'DISPLAY': ':0', 03:27:09 INFO - 'HOME': '/home/cltbld', 03:27:09 INFO - 'LANG': 'en_US.UTF-8', 03:27:09 INFO - 'LANGUAGE': 'en_US:en', 03:27:09 INFO - 'LOGNAME': 'cltbld', 03:27:09 INFO - 'MAIL': '/var/mail/cltbld', 03:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:09 INFO - 'MOZ_NO_REMOTE': '1', 03:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:09 INFO - 'NO_EM_RESTART': '1', 03:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:09 INFO - 'PWD': '/builds/slave/test', 03:27:09 INFO - 'SHELL': '/bin/bash', 03:27:09 INFO - 'SHLVL': '1', 03:27:09 INFO - 'TERM': 'linux', 03:27:09 INFO - 'TMOUT': '86400', 03:27:09 INFO - 'USER': 'cltbld', 03:27:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:09 INFO - '_': '/tools/buildbot/bin/python'} 03:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:09 INFO - Downloading/unpacking jsonschema 03:27:09 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 03:27:09 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 03:27:09 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 03:27:09 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 03:27:09 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 03:27:09 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 03:27:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:11 INFO - warning: no files found matching '*.txt' 03:27:11 INFO - no previously-included directories found matching 'build' 03:27:11 INFO - no previously-included directories found matching 'dist' 03:27:11 INFO - no previously-included directories found matching '.git*' 03:27:11 INFO - Installing collected packages: jsonschema, functools32 03:27:11 INFO - Running setup.py install for functools32 03:27:11 INFO - warning: no files found matching '*.txt' 03:27:11 INFO - no previously-included directories found matching 'build' 03:27:11 INFO - no previously-included directories found matching 'dist' 03:27:11 INFO - no previously-included directories found matching '.git*' 03:27:11 INFO - Successfully installed jsonschema functools32 03:27:11 INFO - Cleaning up... 03:27:11 INFO - Return code: 0 03:27:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:27:11 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')]} 03:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:11 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')]} 03:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:11 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 0x7f3eed064f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, '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': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', '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 03:27:11 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 03:27:11 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 03:27:11 INFO - Using env: {'DISPLAY': ':0', 03:27:11 INFO - 'HOME': '/home/cltbld', 03:27:11 INFO - 'LANG': 'en_US.UTF-8', 03:27:11 INFO - 'LANGUAGE': 'en_US:en', 03:27:11 INFO - 'LOGNAME': 'cltbld', 03:27:11 INFO - 'MAIL': '/var/mail/cltbld', 03:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:11 INFO - 'MOZ_NO_REMOTE': '1', 03:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:11 INFO - 'NO_EM_RESTART': '1', 03:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:11 INFO - 'PWD': '/builds/slave/test', 03:27:11 INFO - 'SHELL': '/bin/bash', 03:27:11 INFO - 'SHLVL': '1', 03:27:11 INFO - 'TERM': 'linux', 03:27:11 INFO - 'TMOUT': '86400', 03:27:11 INFO - 'USER': 'cltbld', 03:27:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:11 INFO - '_': '/tools/buildbot/bin/python'} 03:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:12 INFO - Downloading/unpacking flake8 03:27:12 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 03:27:12 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 03:27:12 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 03:27:12 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 03:27:12 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 03:27:12 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 03:27:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:27:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:27:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 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 03:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:14 INFO - no previously-included directories found matching 'docs/_build' 03:27:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:27:14 INFO - Running setup.py install for pep8 03:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:14 INFO - no previously-included directories found matching 'docs/_build' 03:27:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:27:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:27:14 INFO - Cleaning up... 03:27:14 INFO - Return code: 0 03:27:14 INFO - Running post-action listener: _resource_record_post_action 03:27:14 INFO - Running post-action listener: _start_resource_monitoring 03:27:15 INFO - Starting resource monitoring. 03:27:15 INFO - ##### 03:27:15 INFO - ##### Running install step. 03:27:15 INFO - ##### 03:27:15 INFO - Running pre-action listener: _resource_record_pre_action 03:27:15 INFO - Running main action method: install 03:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:15 INFO - Reading from file tmpfile_stdout 03:27:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:15 INFO - Reading from file tmpfile_stdout 03:27:15 INFO - Output received: 03:27:15 INFO - Usage: mozinstall [options] installer 03:27:15 INFO - Options: 03:27:15 INFO - -h, --help show this help message and exit 03:27:15 INFO - -d DEST, --destination=DEST 03:27:15 INFO - Directory to install application into. [default: 03:27:15 INFO - "/builds/slave/test"] 03:27:15 INFO - --app=APP Application being installed. [default: firefox] 03:27:15 INFO - mkdir: /builds/slave/test/build/application 03:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:27:30 INFO - Reading from file tmpfile_stdout 03:27:30 INFO - Output received: 03:27:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:30 INFO - Running post-action listener: _resource_record_post_action 03:27:30 INFO - ##### 03:27:30 INFO - ##### Running run-tests step. 03:27:30 INFO - ##### 03:27:30 INFO - Running pre-action listener: _resource_record_pre_action 03:27:30 INFO - Running main action method: run_tests 03:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:30 INFO - Python 2.7.3 03:27:30 INFO - Return code: 0 03:27:30 INFO - grabbing minidump binary from tooltool 03:27: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')]} 03:27:30 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 0x2b06410>, '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 0x2b07310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b077a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:30 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 03:27:30 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 03:27:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:30 INFO - Return code: 0 03:27:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:31 INFO - Return code: 0 03:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 03:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 03:27:31 INFO - Using env: {'DISPLAY': ':0', 03:27:31 INFO - 'HOME': '/home/cltbld', 03:27:31 INFO - 'LANG': 'en_US.UTF-8', 03:27:31 INFO - 'LANGUAGE': 'en_US:en', 03:27:31 INFO - 'LOGNAME': 'cltbld', 03:27:31 INFO - 'MAIL': '/var/mail/cltbld', 03:27:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:31 INFO - 'MOZ_NO_REMOTE': '1', 03:27:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:31 INFO - 'NO_EM_RESTART': '1', 03:27:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:31 INFO - 'PWD': '/builds/slave/test', 03:27:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:31 INFO - 'SHELL': '/bin/bash', 03:27:31 INFO - 'SHLVL': '1', 03:27:31 INFO - 'TERM': 'linux', 03:27:31 INFO - 'TMOUT': '86400', 03:27:31 INFO - 'USER': 'cltbld', 03:27:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465033301.161717-578434308', 03:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:31 INFO - '_': '/tools/buildbot/bin/python'} 03:27:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 03:27:32 INFO - mozversion application_buildid: 20160604004005 03:27:32 INFO - mozversion application_changeset: ab782095ef4ab44dae4cc5f919858c5684837378 03:27:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:32 INFO - mozversion application_name: Firefox 03:27:32 INFO - mozversion application_remotingname: firefox-dev 03:27:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:32 INFO - mozversion application_vendor: Mozilla 03:27:32 INFO - mozversion application_version: 48.0a2 03:27:32 INFO - mozversion platform_buildid: 20160604004005 03:27:32 INFO - mozversion platform_changeset: ab782095ef4ab44dae4cc5f919858c5684837378 03:27:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:32 INFO - mozversion platform_version: 48.0a2 03:27:32 INFO - using testdate: 1465036052 03:27:32 INFO - actual date: 1465036052 03:27:32 INFO - starting webserver on 'localhost:53565' 03:27:32 INFO - SUITE-START | Running 2 tests 03:27:32 INFO - TEST-START | dromaeo_css 03:27:32 INFO - operating with platform_type : linux_ 03:27:32 INFO - Initialising browser for dromaeo_css test... 03:27:32 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMHFCuB/profile http://localhost:53565/getInfo.html) 03:27:37 INFO - PROCESS | 3313 | __metrics Screen width/height:1600/1200 03:27:37 INFO - PROCESS | 3313 | colorDepth:24 03:27:37 INFO - PROCESS | 3313 | Browser inner width/height: 1024/697 03:27:37 INFO - PROCESS | 3313 | __metrics 03:27:38 ERROR - PROCESS | 3313 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:39 INFO - TEST-INFO | 3313: exit 0 03:27:39 INFO - Browser initialized. 03:27:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:39 INFO - TEST-INFO | started process 3405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMHFCuB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:51 INFO - PROCESS | 3405 | RSS: Main: 142372864 03:27:51 INFO - PROCESS | 3405 | 03:28:43 INFO - PROCESS | 3405 | 1465036123290 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] 03:30:50 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53565/tests/dromaeo/cssquery-ext.html) 03:30:51 INFO - PROCESS | 3405 | RSS: Main: 239316992 03:30:51 INFO - PROCESS | 3405 | 03:33:53 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-ext.html (next: http://localhost:53565/tests/dromaeo/cssquery-jquery.html) 03:33:54 INFO - PROCESS | 3405 | RSS: Main: 221057024 03:33:54 INFO - PROCESS | 3405 | 03:36:56 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53565/tests/dromaeo/cssquery-mootools.html) 03:36:56 INFO - PROCESS | 3405 | RSS: Main: 218877952 03:36:56 INFO - PROCESS | 3405 | 03:39:58 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53565/tests/dromaeo/cssquery-prototype.html) 03:39:59 INFO - PROCESS | 3405 | RSS: Main: 217706496 03:39:59 INFO - PROCESS | 3405 | 03:43:01 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53565/tests/dromaeo/cssquery-yui.html) 03:43:02 INFO - PROCESS | 3405 | RSS: Main: 181153792 03:43:02 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | Cycle 1(1): loaded http://localhost:53565/tests/dromaeo/cssquery-yui.html (next: http://localhost:53565/tests/dromaeo/cssquery-dojo.html) 03:46:04 INFO - PROCESS | 3405 | RSS: Main: 268869632 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | __start_tp_report 03:46:04 INFO - PROCESS | 3405 | _x_x_mozilla_page_load 03:46:04 INFO - PROCESS | 3405 | _x_x_mozilla_page_load_details 03:46:04 INFO - PROCESS | 3405 | |i|pagename|runs| 03:46:04 INFO - PROCESS | 3405 | |0;dojo.html;3280.7211387032103;3369.4440417331143;3378.9831050844728;3405.659434056593;3413.8634454621815;5543.029969755296;5550.056490396632;5550.27846379971;5581.023320918844;5588.692621905789;5529;5576.776928922848;5578.386377498472;5582.7766889324475;5618.719064046792;4864.7324397158145;4955.479674634165;4990.376202974638;5084.339035925324;5132.435432102466;4938.358013458245;4973.900521989558;4976.701397916118;5063.31645227895;5096.006278775641;5118.360204974379;5151.974240128794;5155.432902380735;5165;5182;5137.101007323722;5148.073346797575;5159.019786240639;5167.147420675584;5187.636865419422;4921.434035085939;4983.626228032912;5015.673981191211;5052.570531504826;5066.797328106872;5361.785528578891;5433.375161856397;5446.482584154539;5447.237386765816;5460.399356070829;5988.131720900488;6005.60963537373;6006.159137720722;6052.152698622196;6052.72762725674;5793.478586927196;5930.584859059867;6023.668698221596;6069.969650151721;6098.29688551976;5565;5570.498655121018;5570.805021824257;5579.414161513064;5589.273394458735;6058.1518587397795;6064.514838812885;6070.2108725865355;6092.543059270483;6099.9085013724825;5691.459311365414;5758.165066065397;5812.447817457335;5839.970800146057;5855.3851845556455;5903.321118071477;5908.05471124618;5915.763369465173;5922.911156332659;5925.170476133345;5728.140778883201;5893.970530147321;5894.056950887837;5896.204012458349;5896.823095307148;5882.941170588325;5950.761969521171;5955.0769630706445;5983.880322393615;5996.5202783777195;4531.501534831166;4534.455865296186;4537.342085397665;4537.659675524349;4566.862994110182;3985.2826491231276;3991.7006224533275;4082.4284600156;4083.3466645336603;4103.322951712994;5637.689927054052;5652.63257888236;5663.093904975184;5680.68756218412;5681.857953551112;5915.319738230072;5930.525557955353;5937.287525496968;5938.317093534212;5941.108833674897;5593.244911936918;5621.353544342372;5644.774209031675;5658.660480371191;5670.036093864053;5047.9495205048215;5054.090263752486;5055.064813009605;5073.036123136592;5083.796648134034;6195.907061394083;6197.938020619736;6199.628022318675;6240.407161319758;6243.96878015607;5886.411358864079;6048.939510604838;6057.3639767824625;6073;6073.331933487401;6215.875682486416;6216.191895053614;6249.125122482765;6251.531135164972;6253.187085678833;5930.229070220844;5944.8236717502205;5949.553783466171;5955.464008239279;5981.7906373278465;5780.046292361882;5996.100584912124;6044.15381846533;6053.092036194606;6068.939310606837;5775.884482310246;5813.476787089182;5831.562632802472;5845.152452894392;5848.883022339614;5777.191193232867;5798.942010580009;5813.883722325614;5817.854553636193;5837.474627283565;5548.722563871871;5684.658920464785;5747.166660834239;5751.338596061507;5775.855603609775;5806.709664516842;5844.47399734026;5854.443827836349;5874.970625146847;5881.794137205177;5737.770489180553;5737.856553586027;5739.655620662774;5745.224394706661;5765.798197063083 03:46:04 INFO - PROCESS | 3405 | |1;ext.html;673.589110642508;675.9425448836848;676.1683129750404;681.3765404654741;734.9963250183752;33633.66366336336;40741.79629101854;41278.380824287626;41492.58507414925;41496.58503414965;44424.555754442445;45022.09955800882;45047.32429013567;45086.32370514445;45095.54904450954;8247.628856701433;8796.076411976746;8955.014948355676;8955.37312388133;10453;10700.892991070068;10918.454077296143;10921.180911431675;10923;10924.453777311142;10972.670819875417;11070.944645276762;11072.889271107306;11074.335539867594;11078.501467433944;8674.349423793241;10738.677839664744;10891.455427228646;11049.28179668319;11060.668179954533;10475.633352832614;10501.159907207406;10594.947025264824;10600.356944673587;10610.787784244349;44248;44987;45011.09977800426;45066.54933450656;45100;4105.404716316118;4113.691473139496;4548.4541854977615;4618.884527886796;4679.976600116977;34053;34446.13884652879;34517.48223776645;34663.480047799305;35492.64507354919;4576.267797152473;4607.562281583244;4651.139539185261;4661.650376221797;4737.336772851803;344453;345418;349476;349807;351241;66856;67099.66450167718;67580;67594.3240567588;67604;71477.6426117866;73484;73960.63019684974;74112;74330;19597.314094006928;19818.108185131703;19827.30604428867;19828.306009289605;19835.305764298468;13846.238456884968;15591.376344946075;15900;15905.125218112884;15911.761323580156;20639.277625283044;20746.377608671763;20897.47756306074;20959;21004.78995210059;7544.358729508053;7609.923900761032;7719.150893401721;7743.225677432324;7842.64708088126;1122.7922834275685;1163.610190586163;1185.9525618975317;1227.8403807504967;1248.3134276148264;33889.661103389146;34155.487667685;34579.48130778041;34597.30805383878;35027.82486087553;1233.340163012784;1252.9976019184617;1254.711416374239;1260.4013093780381;1315;18393.908030459763;18426.447206583824;18545.44363669092;18626.906865465586;18703.532411689815;556529;556600;563904;565297;565367;63931;64293.678531607045;64356.034659480145;64542;64824;1414.1868425655289;1464.1288433382333;1464.2239613005124;1475.48358074673;1497.7378958682186;30997.380052398374;31518;31951.680483194872;32803.34393312073;33558.832205838815;48811.26783098185;48820.2676959853;49194.278200262816;49225.26162107643;49226.01547969092;314787;316802;316850;316916;317558;28170.718292816808;31121.68878311188;31370.843145784125;31533.52699709552;32127.839360803046;46507.30239046349;47137.7643111796;47434.76282618565;47527.287090692975;47530;38413.039674007254;38701;39375.80312098536;43116.78441607772;43339.78330108456;41940.79029604955;42312.95972589525;42749.35875961925;43040.78479607582;43229.351559727256;42921.570784291755;43957.78021109874;44520.527583165494;44918;45030.324545131196;35784.642153578134;36540;37841;37974.7713811308;38291.808540958235;28735.281617959718;29054.418911622073;29095.854520727262;29235;29259.268518287212 03:46:04 INFO - PROCESS | 3405 | |2;jquery.html;430.8431860454679;436.4435344935208;438.09314718532613;440.4516377110497;448.9259272220084;18408.63182736346;18920.90539547302;19121.52196195094;19429.12568934398;19923.800761992377;18870.245190192374;18904.716429253538;20494.282700105497;20499.282525111623;20524.28165014225;5633.211350410936;5699.629524080921;5763.654180749148;5848.824535263949;5854.619449735775;4277.294246449332;5783.9710801445935;5786.508146807527;6050.878982420349;6349.111124442582;6295.968520157393;6317.620942743427;6330.65181415022;6334.081558174062;6339.809805705836;5667.8583035424235;5921.940780592225;5932.0508718604815;5943.702814859262;6474.676266186695;3983.1237127831832;4145.067359844041;5691.317041954951;5733.082706766939;5806.5354771618595;13516.729665406736;13608.727825443435;13681.657958551017;13748.93125534366;18912.621747564972;2226.565819665166;2302.2632757517435;2370.3481542575755;2592.831465954726;2800.80394372394;10442.060214580724;11189.873923954505;11443.970042696114;13223.206607603479;14055.437782488689;1912.722655214986;1955.2179128348632;2010.3566858605107;2017.9697304540443;2135.9252426165167;73437.63281183613;73531.63234183849;76089;77271.22728772752;78227.60886195532;11296;11494.42527873603;11535.653930382103;11690.47392867323;12023.458944347525;16361.181940902907;16444;16527.421540246276;16571.17144142788;16576.585585360463;9084.40951338161;9109.316801239802;9118.99691033999;9147.313951453667;9190.816183676288;9006.909930900738;9063.728088157366;9188.310876684276;9232.261419086592;9327.813443731224;5143.254228136974;5178.741062946838;5186.325777648882;5209.609279303992;5258.526732594085;1837.690615506635;1999.2402886902885;2050.8359331253464;2104.3371338028473;2111.033997233889;478.4927976345085;494.89854579811055;1010.3533738407425;1054.2093429927554;1064.7125276175389;11943.88056119445;12045.578404755792;12104.15270931044;12403;12630.747385052247;511;522.5975998481148;524.2529395611239;528.4556906386429;539.802971915256;6612.206535215805;6665.733370665119;6712.798616041527;6762.222344430355;6823.69293381799;187989;531813.409329532;534747;547347.8428255072;577105;98226.50886745521;100095.49952250192;100193.49903250583;100215.49892250638;100842.49578752206;521.8825764203024;523.9528442440198;524.1875093604973;526.7761201489352;527.16970771035;16784.58038549046;16813.74779378286;17043.31826726917;17757;17837.46487605374;36605.63394366022;37086.814565927;37909;38180.42729359117;39108;48438.273425899344;53510;57638.423615763306;57738.42261577331;57753.422465774805;8792.560371981503;8921.464712117293;8939.418937769024;9069.637214511346;9088.863667045132;8737.868931965899;9673;12624.179428337497;12918.612441626767;13016.349182541024;11968.521259149536;12101.878981210075;12144.392780361124;12245.938770306448;12338.321392323509;11799.115066370228;12096.395180241128;12278.693032673897;12383.442745076673;12606.747865042831;6714.731410743516;9146.679866204651;10398.948005259925;12414.875851241371;12644.178128421623;8854.114588541095;9075.727728168165;9132.726018219464;9150.954245228731;9466.763330916781;11468.598599048993;12351.444185011516;12364.381780911099;12504.249745015328;12505.124641275024 03:46:04 INFO - PROCESS | 3405 | |3;mootools.html;1429.3139293139286;1567.9999999999998;1582.3275108079072;1773.432501599488;1917.2810196176433;8311.335093192538;8609.182127697874;8612.913870861305;8615.43999640023;8625.870611940818;8342.91657083429;8531.87202191966;8543.487390756543;8545.273651739593;8547.230749232567;2199.868007919522;2442.9877850610765;2446.6330050492393;2480.2807185916154;2500.4749002709455;2481.5781317176034;2515.937101572457;2528.329992551975;2531.9873400632973;2532.151729170721;2456.435019945414;2456.6192240202795;2457.741937096606;2467.0501856785177;2468.691413573303;2180.8800515971616;2339;2390.5218956208655;2390.9282721518207;2391.796697280733;2351.341624345169;2393.8204634652297;2408.1089996701335;2415.070197973793;2419.9153029644053;8394.24451799341;8425.11536288693;8443.831123377498;8460.915390846136;8469.491830490191;5274.736263186864;5390.865228369283;5393.298871146726;5434.103372943459;5507.504324610804;3525.94711079334;3562.9667396454997;3628.5645722513204;3680.834362453696;3696.741228114033;1114.654457118296;1124.1400328748514;1124.6907100547332;1133.9433028348549;1145.856767904012;11792.29246245228;11854.822177667427;11964.760704785942;11983.94008029963;11999.280043197436;4562.498125206224;4611.93082103762;4648.628109751212;4661.930071048937;4690.249560070372;10298.536565854554;10304.639337623148;10313.27807053499;10316;10327.896721032845;4924.162892308316;5407.486288802557;5408.594355423359;5408.891822163535;5411.458854114557;4917.434495033045;4945.159322915113;4958.9008219835405;4975.278584605212;5012.523810238022;4104.979475102665;4123.113530590937;4173.061061261253;4190.497140343117;4202.201581699528;1293.8512071111943;1313.5402609086743;1319.3732976835927;1321.4978308242999;1328.3395755305867;903.2683526343683;961.1733908838394;964.2478866484154;1075.8224892892742;1092.415557676639;5920.111983202468;6052.909206361908;6074.210352654127;6147.692615369214;6283.214598175228;452.9275315949432;456.99233190814175;457.65675743192605;1092.317301686446;1094.7700982793542;4020.3768415895584;4079.347304431277;4079.63283304504;4095.9385609215888;4118.155778065489;10391.168706503462;10822.40476773785;10967.122630189566;11003.504842282116;11008.064314533194;10753.408562528979;10797.784044319069;10818.080463160562;10836.837447438294;10845;8354.122817104238;8365.749027529184;8479.448835825775;8481.745547633582;8486.872696909551;5354.170103633787;5615.241942337732;5697.886042279214;5739.684317362585;5795.8551036224435;9307.813843723223;9598.280128990215;9606.375585586915;9837.557309921214;9857.950710246403;9729.270304727315;9793.02069793015;9930.553125109243;10073.19414446857;10139.138173255356;6669.1330127083165;7154.284571542804;7344.96327518359;7560.054993125859;7620.199879012624;8343.666253349798;8375.162483751576;8383.245507904317;8419.073901870666;8440.366972477212;7451.962740186264;7637.541747495168;7674.270944260286;7688.807779805549;7701.883226932176;7440.665170067252;7491.737789177353;7500.437467190091;7591.051118610174;7624.58064806441;6978.302169782981;7046.859062818612;7067.540609860343;7181.210066892533;7186.24544422849;4989.700617962933;5053.545180933734;5085.160948443613;5161.458046905021;5209.947900521098;5034.773435195351;5101.642884998163;5104.279375415607;5186.481351864783;5206.193040078794 03:46:04 INFO - PROCESS | 3405 | |4;prototype.html;352.3182641588526;362.8385368511013;364.1751433004245;371.90702324418913;373.719710217337;6229.785191887578;6266.624002559844;6296;6351.841203969903;6354.841128971778;5952.672603006833;6104.4200800923845;6256.562040657156;6258.84352891178;6266.9373306266925;4761.381020467335;4782.617390608761;4800.447948485917;4801.327814106028;4810.951890481103;4782.473927867932;4786.305985632099;4789.5928846047955;4801.375821143247;4818.385840743355;4579.862604121881;4669.322948172513;4750.049990002013;4774.80900763969;4784.3780308559835;4719.268513380432;4770.97614511927;4771.737554434522;4777.450593181794;4780.354652121954;4222.2611043067645;4224.894377640553;4231.788410579489;4233.23801715691;4235.3646952957;6010.519158467312;6017.338092809788;6022.367651396584;6029.879402411971;6033.607815492023;5534.169874518814;5593.272874526327;5595.972020139914;5601.831945041656;5602.271704678406;6394.58435201715;6597.373249541334;6626.93373066268;6630.900536491957;6636.8672626547195;4598.770061496912;4618.65360097994;4624.583787459145;4630.9536904631195;4632.884177895579;6840.828979275509;6913.75801846938;6923.134608173978;6935.029095926574;6941.34057264559;4705.788239529229;4714.834980775657;4717.952820471752;4718.079974404958;4720.221163508051;4769.833055843029;4772.737499437495;4772.904541909143;4777.092352453093;4778.737169455713;5270.894582108336;5403.108487099585;5525.834224973257;5532.972335138379;5542.0301447246575;6443.96778016107;6476.158099447136;6496.480281577463;6498.415142637091;6556.213254409406;1586.1910425682984;1636.051090367584;1663.8585720213916;1673.983260167407;1679.5129412470246;1071.5392381276126;1099.7745462180235;1105.4859490337033;1106.9557217711363;1113.0761467981556;6423.4861211103;6425.297296216507;6435.74748837903;6438.6136831790245;6444.7744328948265;6774.593524388552;6785.796426107225;6787.966060169668;6795.762148324785;6810.421114205249;6397.552171348054;6412.198475190601;6412.2625898022325;6419.967900160469;6423.550351475352;3596.8741094061584;3647.8176091195332;3650.361186792301;3651.1967367179177;3654.634536546324;6888.138982627172;7025.964870175617;7054.823629409306;7070.39901608369;7081.07945967021;6842.4183944364295;6843.315668433216;6863.828404289933;6870.416014638712;6880.139982502187;7037.753678621224;7049.343404299985;7059.082319298458;7064.858702825914;7064.92935070653;6759.121314229119;6771.356721111487;6773.085633439423;6776.728930842908;6783;6532.150820393508;6624.470042396693;6663.900041499284;6670.099536562502;6679.632620205741;6947.861042779015;6989.231184569591;6993.510454268152;6998.195207551197;7006.719731210695;4690.554397332248;4699.4830568636735;4702.882427939329;4705.5059218781535;4706.294055891643;6728.461723062242;6733.494987875831;6736.360045795642;6737.461003119641;6744.898826517508;6403.615783053032;6512.5766825156215;6586.604803711793;6593.934060659524;6612.933870661232;6683.498737594603;6705.2959439258175;6712;6722.193336799615;6725.932740672531;6585.835354116185;6586.769463068769;6591.967040164768;6600.306967768315;6606.933930660824;6557.786809440268;6738.225104113089;6749.190097188369;6750.5274630775375;6753.15585551806;6561.934380656132;6564.179477565304;6566.770163044271;6569.113169722026;6570.47436205112 03:46:04 INFO - PROCESS | 3405 | |5;yui.html;921.2629896083134;943.6791490893097;967.2697113679176;986.0829428631374;991.4299277915201;14660.973731838776;15434.845651543495;15510.922445387758;15660.530184094467;15680;14578.781318280235;14758.557243282692;14793.260336983161;14799.038062525955;14809.629759256024;759.3583422008394;900.3517467423477;922.4603606889978;927.332320729074;931.2317338195982;920.3189639666665;924.6486335192617;926.1710768861865;927.536231884058;927.9953600231989;969.2924165359292;974.0843607009389;974.7611835100411;975.2149519636689;976.0191008036913;812.6424373275739;958.7267628725815;969.9272554558436;972.9173020293283;973.4305431322649;717.3830505765038;717.519262094398;717.5766297884221;718.174099785246;719.4999475364624;15220.543383698507;15298.158601276926;15311.617209569738;15314.617134571614;15336.233188340539;14664.41342346305;14931.402743890232;15099.924500377538;15122.621934451618;15223;12134.453949572291;12166.81749773754;12193;12325.815112773316;12691.74616507674;4001.0597509585223;4032.4556184915245;4090.032668311733;4126.525449573308;4148.128892932487;53196;53899.461005389836;53916.730416347666;54252;54756.452435475534;11549.191556591126;11711.531538738354;11727.179097463095;11735.295882247092;12053.698657533632;21546.03042863075;21679.67480487794;22034.11863525473;22084.33746987593;22087.779122208573;8237.670493180205;8283.25450709439;8556.529390883561;8564.100769419121;8614.18165274298;4890.877728056827;4925.950740492621;4952.579030782424;4998.300237966688;5093.032323858455;3474.808885511321;3528.964710352915;3536.169000284931;3539.486774417695;3547.3614749345365;662.5031226580065;690.7340673840507;703.9788806335819;711.7331000874672;717.0713925466533;707.6921539130494;735.2977906099662;752.4883079505879;841.8989721233492;852.4203541591653;10052.497375131361;10147.898521014695;10391.53238104287;10399;10438.530266138043;729.5258082246476;826.7065191856924;832.3091833778071;837.2213841127688;855.0679759062651;4572.977135114304;4603.148417542765;4774.904501910012;4832.420109586872;4931.630127740434;64277;64712;64807;64974;65077.349226507125;55536.44463555393;57324;57438.425615743305;57624.711876441186;58849.41150588525;50042.499575003785;51304.74347628238;52599.737001315516;52700;52752;9481.525923703924;9621.749172607517;9670.226381889574;9777.9022209777;9813.362131461432;36713;37093.443598345504;37690.623093768714;38311.233775324894;39334.40998384969;45964.310535342665;47001.76499117619;47378;48191.75904120457;48846.26730599115;12724.936375318064;12749.87250127487;13246.536371226961;13403.262820544964;13605.387757551132;14513.709725805636;14910.552683419515;15053.322600483223;15122.773158402853;15488.922555387151;13779.586612401645;13970.930145349208;14123.081999669988;14402.783958240425;14806.333714983068;13813.585592432242;13973.161610303414;14092.647683807987;14116.717665646835;14201.573952781433;13849.930750346184;14036.929815350857;14056.156630602196;14407.207603581903;14605.92697036508;10968.780624387628;11176.832347514632;11336.263142895685;11350.886491134983;11643.184977051525;10982.06652434552;11200.77549980242;11390.316581005167;11579.247348922294;11623.360715160408 03:46:04 INFO - PROCESS | 3405 | __end_tp_report 03:46:04 INFO - PROCESS | 3405 | __start_cc_report 03:46:04 INFO - PROCESS | 3405 | _x_x_mozilla_cycle_collect,823 03:46:04 INFO - PROCESS | 3405 | __end_cc_report 03:46:04 INFO - PROCESS | 3405 | __startTimestamp1465037164801__endTimestamp 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | ------- Summary: start ------- 03:46:04 INFO - PROCESS | 3405 | Number of tests: 6 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#0] dojo.html Cycles:165 Average:5536.21 Median:5745.22 stddev:620.59 (10.8%) stddev-sans-first:596.74 03:46:04 INFO - PROCESS | 3405 | Values: 3280.7 3369.4 3379.0 3405.7 3413.9 5543.0 5550.1 5550.3 5581.0 5588.7 5529.0 5576.8 5578.4 5582.8 5618.7 4864.7 4955.5 4990.4 5084.3 5132.4 4938.4 4973.9 4976.7 5063.3 5096.0 5118.4 5152.0 5155.4 5165.0 5182.0 5137.1 5148.1 5159.0 5167.1 5187.6 4921.4 4983.6 5015.7 5052.6 5066.8 5361.8 5433.4 5446.5 5447.2 5460.4 5988.1 6005.6 6006.2 6052.2 6052.7 5793.5 5930.6 6023.7 6070.0 6098.3 5565.0 5570.5 5570.8 5579.4 5589.3 6058.2 6064.5 6070.2 6092.5 6099.9 5691.5 5758.2 5812.4 5840.0 5855.4 5903.3 5908.1 5915.8 5922.9 5925.2 5728.1 5894.0 5894.1 5896.2 5896.8 5882.9 5950.8 5955.1 5983.9 5996.5 4531.5 4534.5 4537.3 4537.7 4566.9 3985.3 3991.7 4082.4 4083.3 4103.3 5637.7 5652.6 5663.1 5680.7 5681.9 5915.3 5930.5 5937.3 5938.3 5941.1 5593.2 5621.4 5644.8 5658.7 5670.0 5047.9 5054.1 5055.1 5073.0 5083.8 6195.9 6197.9 6199.6 6240.4 6244.0 5886.4 6048.9 6057.4 6073.0 6073.3 6215.9 6216.2 6249.1 6251.5 6253.2 5930.2 5944.8 5949.6 5955.5 5981.8 5780.0 5996.1 6044.2 6053.1 6068.9 5775.9 5813.5 5831.6 5845.2 5848.9 5777.2 5798.9 5813.9 5817.9 5837.5 5548.7 5684.7 5747.2 5751.3 5775.9 5806.7 5844.5 5854.4 5875.0 5881.8 5737.8 5737.9 5739.7 5745.2 5765.8 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#1] ext.html Cycles:180 Average:59201.11 Median:35638.64 stddev:111991.67 (314.2%) stddev-sans-first:112219.63 03:46:04 INFO - PROCESS | 3405 | Values: 673.6 675.9 676.2 681.4 735.0 33633.7 40741.8 41278.4 41492.6 41496.6 44424.6 45022.1 45047.3 45086.3 45095.5 8247.6 8796.1 8955.0 8955.4 10453.0 10700.9 10918.5 10921.2 10923.0 10924.5 10972.7 11070.9 11072.9 11074.3 11078.5 8674.3 10738.7 10891.5 11049.3 11060.7 10475.6 10501.2 10594.9 10600.4 10610.8 44248.0 44987.0 45011.1 45066.5 45100.0 4105.4 4113.7 4548.5 4618.9 4680.0 34053.0 34446.1 34517.5 34663.5 35492.6 4576.3 4607.6 4651.1 4661.7 4737.3 344453.0 345418.0 349476.0 349807.0 351241.0 66856.0 67099.7 67580.0 67594.3 67604.0 71477.6 73484.0 73960.6 74112.0 74330.0 19597.3 19818.1 19827.3 19828.3 19835.3 13846.2 15591.4 15900.0 15905.1 15911.8 20639.3 20746.4 20897.5 20959.0 21004.8 7544.4 7609.9 7719.2 7743.2 7842.6 1122.8 1163.6 1186.0 1227.8 1248.3 33889.7 34155.5 34579.5 34597.3 35027.8 1233.3 1253.0 1254.7 1260.4 1315.0 18393.9 18426.4 18545.4 18626.9 18703.5 556529.0 556600.0 563904.0 565297.0 565367.0 63931.0 64293.7 64356.0 64542.0 64824.0 1414.2 1464.1 1464.2 1475.5 1497.7 30997.4 31518.0 31951.7 32803.3 33558.8 48811.3 48820.3 49194.3 49225.3 49226.0 314787.0 316802.0 316850.0 316916.0 317558.0 28170.7 31121.7 31370.8 31533.5 32127.8 46507.3 47137.8 47434.8 47527.3 47530.0 38413.0 38701.0 39375.8 43116.8 43339.8 41940.8 42313.0 42749.4 43040.8 43229.4 42921.6 43957.8 44520.5 44918.0 45030.3 35784.6 36540.0 37841.0 37974.8 38291.8 28735.3 29054.4 29095.9 29235.0 29259.3 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#2] jquery.html Cycles:180 Average:28104.49 Median:4211.18 stddev:82280.16 (1953.9%) stddev-sans-first:82484.74 03:46:04 INFO - PROCESS | 3405 | Values: 430.8 436.4 438.1 440.5 448.9 18408.6 18920.9 19121.5 19429.1 19923.8 18870.2 18904.7 20494.3 20499.3 20524.3 5633.2 5699.6 5763.7 5848.8 5854.6 4277.3 5784.0 5786.5 6050.9 6349.1 6296.0 6317.6 6330.7 6334.1 6339.8 5667.9 5921.9 5932.1 5943.7 6474.7 3983.1 4145.1 5691.3 5733.1 5806.5 13516.7 13608.7 13681.7 13748.9 18912.6 2226.6 2302.3 2370.3 2592.8 2800.8 10442.1 11189.9 11444.0 13223.2 14055.4 1912.7 1955.2 2010.4 2018.0 2135.9 73437.6 73531.6 76089.0 77271.2 78227.6 11296.0 11494.4 11535.7 11690.5 12023.5 16361.2 16444.0 16527.4 16571.2 16576.6 9084.4 9109.3 9119.0 9147.3 9190.8 9006.9 9063.7 9188.3 9232.3 9327.8 5143.3 5178.7 5186.3 5209.6 5258.5 1837.7 1999.2 2050.8 2104.3 2111.0 478.5 494.9 1010.4 1054.2 1064.7 11943.9 12045.6 12104.2 12403.0 12630.7 511.0 522.6 524.3 528.5 539.8 6612.2 6665.7 6712.8 6762.2 6823.7 187989.0 531813.4 534747.0 547347.8 577105.0 98226.5 100095.5 100193.5 100215.5 100842.5 521.9 524.0 524.2 526.8 527.2 16784.6 16813.7 17043.3 17757.0 17837.5 36605.6 37086.8 37909.0 38180.4 39108.0 48438.3 53510.0 57638.4 57738.4 57753.4 8792.6 8921.5 8939.4 9069.6 9088.9 8737.9 9673.0 12624.2 12918.6 13016.3 11968.5 12101.9 12144.4 12245.9 12338.3 11799.1 12096.4 12278.7 12383.4 12606.7 6714.7 9146.7 10398.9 12414.9 12644.2 8854.1 9075.7 9132.7 9151.0 9466.8 11468.6 12351.4 12364.4 12504.2 12505.1 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#3] mootools.html Cycles:180 Average:5760.14 Median:4934.66 stddev:3194.07 (64.7%) stddev-sans-first:3186.44 03:46:04 INFO - PROCESS | 3405 | Values: 1429.3 1568.0 1582.3 1773.4 1917.3 8311.3 8609.2 8612.9 8615.4 8625.9 8342.9 8531.9 8543.5 8545.3 8547.2 2199.9 2443.0 2446.6 2480.3 2500.5 2481.6 2515.9 2528.3 2532.0 2532.2 2456.4 2456.6 2457.7 2467.1 2468.7 2180.9 2339.0 2390.5 2390.9 2391.8 2351.3 2393.8 2408.1 2415.1 2419.9 8394.2 8425.1 8443.8 8460.9 8469.5 5274.7 5390.9 5393.3 5434.1 5507.5 3525.9 3563.0 3628.6 3680.8 3696.7 1114.7 1124.1 1124.7 1133.9 1145.9 11792.3 11854.8 11964.8 11983.9 11999.3 4562.5 4611.9 4648.6 4661.9 4690.2 10298.5 10304.6 10313.3 10316.0 10327.9 4924.2 5407.5 5408.6 5408.9 5411.5 4917.4 4945.2 4958.9 4975.3 5012.5 4105.0 4123.1 4173.1 4190.5 4202.2 1293.9 1313.5 1319.4 1321.5 1328.3 903.3 961.2 964.2 1075.8 1092.4 5920.1 6052.9 6074.2 6147.7 6283.2 452.9 457.0 457.7 1092.3 1094.8 4020.4 4079.3 4079.6 4095.9 4118.2 10391.2 10822.4 10967.1 11003.5 11008.1 10753.4 10797.8 10818.1 10836.8 10845.0 8354.1 8365.7 8479.4 8481.7 8486.9 5354.2 5615.2 5697.9 5739.7 5795.9 9307.8 9598.3 9606.4 9837.6 9858.0 9729.3 9793.0 9930.6 10073.2 10139.1 6669.1 7154.3 7345.0 7560.1 7620.2 8343.7 8375.2 8383.2 8419.1 8440.4 7452.0 7637.5 7674.3 7688.8 7701.9 7440.7 7491.7 7500.4 7591.1 7624.6 6978.3 7046.9 7067.5 7181.2 7186.2 4989.7 5053.5 5085.2 5161.5 5209.9 5034.8 5101.6 5104.3 5186.5 5206.2 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#4] prototype.html Cycles:180 Average:5533.30 Median:6396.07 stddev:1661.72 (26.0%) stddev-sans-first:1620.24 03:46:04 INFO - PROCESS | 3405 | Values: 352.3 362.8 364.2 371.9 373.7 6229.8 6266.6 6296.0 6351.8 6354.8 5952.7 6104.4 6256.6 6258.8 6266.9 4761.4 4782.6 4800.4 4801.3 4811.0 4782.5 4786.3 4789.6 4801.4 4818.4 4579.9 4669.3 4750.0 4774.8 4784.4 4719.3 4771.0 4771.7 4777.5 4780.4 4222.3 4224.9 4231.8 4233.2 4235.4 6010.5 6017.3 6022.4 6029.9 6033.6 5534.2 5593.3 5596.0 5601.8 5602.3 6394.6 6597.4 6626.9 6630.9 6636.9 4598.8 4618.7 4624.6 4631.0 4632.9 6840.8 6913.8 6923.1 6935.0 6941.3 4705.8 4714.8 4718.0 4718.1 4720.2 4769.8 4772.7 4772.9 4777.1 4778.7 5270.9 5403.1 5525.8 5533.0 5542.0 6444.0 6476.2 6496.5 6498.4 6556.2 1586.2 1636.1 1663.9 1674.0 1679.5 1071.5 1099.8 1105.5 1107.0 1113.1 6423.5 6425.3 6435.7 6438.6 6444.8 6774.6 6785.8 6788.0 6795.8 6810.4 6397.6 6412.2 6412.3 6420.0 6423.6 3596.9 3647.8 3650.4 3651.2 3654.6 6888.1 7026.0 7054.8 7070.4 7081.1 6842.4 6843.3 6863.8 6870.4 6880.1 7037.8 7049.3 7059.1 7064.9 7064.9 6759.1 6771.4 6773.1 6776.7 6783.0 6532.2 6624.5 6663.9 6670.1 6679.6 6947.9 6989.2 6993.5 6998.2 7006.7 4690.6 4699.5 4702.9 4705.5 4706.3 6728.5 6733.5 6736.4 6737.5 6744.9 6403.6 6512.6 6586.6 6593.9 6612.9 6683.5 6705.3 6712.0 6722.2 6725.9 6585.8 6586.8 6592.0 6600.3 6606.9 6557.8 6738.2 6749.2 6750.5 6753.2 6561.9 6564.2 6566.8 6569.1 6570.5 03:46:04 INFO - PROCESS | 3405 | 03:46:04 INFO - PROCESS | 3405 | [#5] yui.html Cycles:180 Average:15732.97 Median:25268.64 stddev:17658.62 (69.9%) stddev-sans-first:17673.12 03:46:04 INFO - PROCESS | 3405 | Values: 921.3 943.7 967.3 986.1 991.4 14661.0 15434.8 15510.9 15660.5 15680.0 14578.8 14758.6 14793.3 14799.0 14809.6 759.4 900.4 922.5 927.3 931.2 920.3 924.6 926.2 927.5 928.0 969.3 974.1 974.8 975.2 976.0 812.6 958.7 969.9 972.9 973.4 717.4 717.5 717.6 718.2 719.5 15220.5 15298.2 15311.6 15314.6 15336.2 14664.4 14931.4 15099.9 15122.6 15223.0 12134.5 12166.8 12193.0 12325.8 12691.7 4001.1 4032.5 4090.0 4126.5 4148.1 53196.0 53899.5 53916.7 54252.0 54756.5 11549.2 11711.5 11727.2 11735.3 12053.7 21546.0 21679.7 22034.1 22084.3 22087.8 8237.7 8283.3 8556.5 8564.1 8614.2 4890.9 4926.0 4952.6 4998.3 5093.0 3474.8 3529.0 3536.2 3539.5 3547.4 662.5 690.7 704.0 711.7 717.1 707.7 735.3 752.5 841.9 852.4 10052.5 10147.9 10391.5 10399.0 10438.5 729.5 826.7 832.3 837.2 855.1 4573.0 4603.1 4774.9 4832.4 4931.6 64277.0 64712.0 64807.0 64974.0 65077.3 55536.4 57324.0 57438.4 57624.7 58849.4 50042.5 51304.7 52599.7 52700.0 52752.0 9481.5 9621.7 9670.2 9777.9 9813.4 36713.0 37093.4 37690.6 38311.2 39334.4 45964.3 47001.8 47378.0 48191.8 48846.3 12724.9 12749.9 13246.5 13403.3 13605.4 14513.7 14910.6 15053.3 15122.8 15488.9 13779.6 13970.9 14123.1 14402.8 14806.3 13813.6 13973.2 14092.6 14116.7 14201.6 13849.9 14036.9 14056.2 14407.2 14605.9 10968.8 11176.8 11336.3 11350.9 11643.2 10982.1 11200.8 11390.3 11579.2 11623.4 03:46:04 INFO - PROCESS | 3405 | -------- Summary: end -------- 03:46:04 INFO - PROCESS | 3405 | 03:46:05 INFO - TEST-INFO | 3405: exit 0 03:46:05 INFO - TEST-OK | dromaeo_css | took 1113159ms 03:46:05 INFO - TEST-START | kraken 03:46:05 INFO - operating with platform_type : linux_ 03:46:05 INFO - Initialising browser for kraken test... 03:46:05 INFO - TEST-INFO | started process 3595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIgAPb/profile http://localhost:53565/getInfo.html) 03:46:09 INFO - PROCESS | 3595 | __metrics Screen width/height:1600/1200 03:46:09 INFO - PROCESS | 3595 | colorDepth:24 03:46:09 INFO - PROCESS | 3595 | Browser inner width/height: 1024/697 03:46:09 INFO - PROCESS | 3595 | __metrics 03:46:10 ERROR - PROCESS | 3595 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:46:11 INFO - TEST-INFO | 3595: exit 0 03:46:11 INFO - Browser initialized. 03:46:11 INFO - Running cycle 1/1 for kraken test... 03:46:11 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIgAPb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:23 INFO - PROCESS | 3689 | RSS: Main: 142540800 03:46:23 INFO - PROCESS | 3689 | 03:46:25 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53565/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:26 INFO - PROCESS | 3689 | RSS: Main: 196091904 03:46:26 INFO - PROCESS | 3689 | 03:46:29 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53565/tests/kraken/driver.html?testName=audio-dft) 03:46:29 INFO - PROCESS | 3689 | RSS: Main: 180989952 03:46:29 INFO - PROCESS | 3689 | 03:46:32 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53565/tests/kraken/driver.html?testName=audio-fft) 03:46:32 INFO - PROCESS | 3689 | RSS: Main: 272216064 03:46:32 INFO - PROCESS | 3689 | 03:46:35 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53565/tests/kraken/driver.html?testName=audio-oscillator) 03:46:35 INFO - PROCESS | 3689 | RSS: Main: 178061312 03:46:35 INFO - PROCESS | 3689 | 03:46:37 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:38 INFO - PROCESS | 3689 | RSS: Main: 177225728 03:46:38 INFO - PROCESS | 3689 | 03:46:41 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53565/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:41 INFO - PROCESS | 3689 | RSS: Main: 211357696 03:46:41 INFO - PROCESS | 3689 | 03:46:45 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53565/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:45 INFO - PROCESS | 3689 | RSS: Main: 211783680 03:46:45 INFO - PROCESS | 3689 | 03:46:48 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53565/tests/kraken/driver.html?testName=json-parse-financial) 03:46:49 INFO - PROCESS | 3689 | RSS: Main: 211570688 03:46:49 INFO - PROCESS | 3689 | 03:46:50 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:51 INFO - PROCESS | 3689 | RSS: Main: 191123456 03:46:51 INFO - PROCESS | 3689 | 03:46:53 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:53 INFO - PROCESS | 3689 | RSS: Main: 191275008 03:46:53 INFO - PROCESS | 3689 | 03:46:55 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:56 INFO - PROCESS | 3689 | RSS: Main: 205471744 03:46:56 INFO - PROCESS | 3689 | 03:46:58 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:59 INFO - PROCESS | 3689 | RSS: Main: 214560768 03:46:59 INFO - PROCESS | 3689 | 03:47:02 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:02 INFO - PROCESS | 3689 | RSS: Main: 209698816 03:47:02 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:53565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53565/tests/kraken/driver.html?testName=ai-astar) 03:47:04 INFO - PROCESS | 3689 | RSS: Main: 273575936 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | __start_tp_report 03:47:04 INFO - PROCESS | 3689 | _x_x_mozilla_page_load 03:47:04 INFO - PROCESS | 3689 | _x_x_mozilla_page_load_details 03:47:04 INFO - PROCESS | 3689 | |i|pagename|runs| 03:47:04 INFO - PROCESS | 3689 | |0;ai-astar;112;110;110;110;111;110;105;111;111;109 03:47:04 INFO - PROCESS | 3689 | |1;audio-beat-detection;152;125;152;175;128;157;174;130;172;132 03:47:04 INFO - PROCESS | 3689 | |2;audio-dft;160;162;160;160;159;165;160;160;159;161 03:47:04 INFO - PROCESS | 3689 | |3;audio-fft;76;74;76;168;75;78;73;76;169;75 03:47:04 INFO - PROCESS | 3689 | |4;audio-oscillator;92;92;148;91;92;92;141;91;92;148 03:47:04 INFO - PROCESS | 3689 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 03:47:04 INFO - PROCESS | 3689 | |6;imaging-darkroom;145;145;145;145;145;144;145;145;146;145 03:47:04 INFO - PROCESS | 3689 | |7;imaging-desaturate;95;94;95;94;94;94;95;95;94;94 03:47:04 INFO - PROCESS | 3689 | |8;json-parse-financial;59;53;54;55;56;55;56;76;53;53 03:47:04 INFO - PROCESS | 3689 | |9;json-stringify-tinderbox;57;58;56;57;57;57;57;57;58;59 03:47:04 INFO - PROCESS | 3689 | |10;stanford-crypto-aes;74;71;73;77;77;76;73;74;73;74 03:47:04 INFO - PROCESS | 3689 | |11;stanford-crypto-ccm;118;116;112;113;119;121;109;114;137;132 03:47:04 INFO - PROCESS | 3689 | |12;stanford-crypto-pbkdf2;166;158;157;158;164;158;158;162;163;156 03:47:04 INFO - PROCESS | 3689 | |13;stanford-crypto-sha256-iterative;68;65;67;66;66;65;65;65;66;63 03:47:04 INFO - PROCESS | 3689 | __end_tp_report 03:47:04 INFO - PROCESS | 3689 | __start_cc_report 03:47:04 INFO - PROCESS | 3689 | _x_x_mozilla_cycle_collect,1557 03:47:04 INFO - PROCESS | 3689 | __end_cc_report 03:47:04 INFO - PROCESS | 3689 | __startTimestamp1465037224543__endTimestamp 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | ------- Summary: start ------- 03:47:04 INFO - PROCESS | 3689 | Number of tests: 14 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.91 (1.7%) stddev-sans-first:1.87 03:47:04 INFO - PROCESS | 3689 | Values: 112.0 110.0 110.0 110.0 111.0 110.0 105.0 111.0 111.0 109.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.50 stddev:19.93 (12.9%) stddev-sans-first:21.12 03:47:04 INFO - PROCESS | 3689 | Values: 152.0 125.0 152.0 175.0 128.0 157.0 174.0 130.0 172.0 132.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.00 stddev:1.78 (1.1%) stddev-sans-first:1.87 03:47:04 INFO - PROCESS | 3689 | Values: 160.0 162.0 160.0 160.0 159.0 165.0 160.0 160.0 159.0 161.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.29 (52.0%) stddev-sans-first:41.13 03:47:04 INFO - PROCESS | 3689 | Values: 76.0 74.0 76.0 168.0 75.0 78.0 73.0 76.0 169.0 75.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.00 stddev:26.13 (28.4%) stddev-sans-first:27.08 03:47:04 INFO - PROCESS | 3689 | Values: 92.0 92.0 148.0 91.0 92.0 92.0 141.0 91.0 92.0 148.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:47:04 INFO - PROCESS | 3689 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 03:47:04 INFO - PROCESS | 3689 | Values: 145.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 146.0 145.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:47:04 INFO - PROCESS | 3689 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.50 stddev:6.93 (12.5%) stddev-sans-first:7.31 03:47:04 INFO - PROCESS | 3689 | Values: 59.0 53.0 54.0 55.0 56.0 55.0 56.0 76.0 53.0 53.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 03:47:04 INFO - PROCESS | 3689 | Values: 57.0 58.0 56.0 57.0 57.0 57.0 57.0 57.0 58.0 59.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:1.93 (2.6%) stddev-sans-first:2.05 03:47:04 INFO - PROCESS | 3689 | Values: 74.0 71.0 73.0 77.0 77.0 76.0 73.0 74.0 73.0 74.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:118.50 stddev:8.92 (7.5%) stddev-sans-first:9.46 03:47:04 INFO - PROCESS | 3689 | Values: 118.0 116.0 112.0 113.0 119.0 121.0 109.0 114.0 137.0 132.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.00 stddev:3.43 (2.1%) stddev-sans-first:2.87 03:47:04 INFO - PROCESS | 3689 | Values: 166.0 158.0 157.0 158.0 164.0 158.0 158.0 162.0 163.0 156.0 03:47:04 INFO - PROCESS | 3689 | 03:47:04 INFO - PROCESS | 3689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.35 (2.0%) stddev-sans-first:1.12 03:47:04 INFO - PROCESS | 3689 | Values: 68.0 65.0 67.0 66.0 66.0 65.0 65.0 65.0 66.0 63.0 03:47:04 INFO - PROCESS | 3689 | -------- Summary: end -------- 03:47:04 INFO - PROCESS | 3689 | 03:47:05 INFO - TEST-INFO | 3689: exit 0 03:47:05 INFO - TEST-OK | kraken | took 59980ms 03:47:05 INFO - SUITE-END | took 1173s 03:47:05 INFO - Completed test suite (00:19:33) 03:47:05 INFO - javascript benchmark 03:47:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.7211387032103, 3369.4440417331143, 3378.9831050844728, 3405.659434056593, 3413.8634454621815, 5543.029969755296, 5550.056490396632, 5550.27846379971, 5581.023320918844, 5588.692621905789, 5529.0, 5576.776928922848, 5578.386377498472, 5582.7766889324475, 5618.719064046792, 4864.7324397158145, 4955.479674634165, 4990.376202974638, 5084.339035925324, 5132.435432102466, 4938.358013458245, 4973.900521989558, 4976.701397916118, 5063.31645227895, 5096.006278775641, 5118.360204974379, 5151.974240128794, 5155.432902380735, 5165.0, 5182.0, 5137.101007323722, 5148.073346797575, 5159.019786240639, 5167.147420675584, 5187.636865419422, 4921.434035085939, 4983.626228032912, 5015.673981191211, 5052.570531504826, 5066.797328106872, 5361.785528578891, 5433.375161856397, 5446.482584154539, 5447.237386765816, 5460.399356070829, 5988.131720900488, 6005.60963537373, 6006.159137720722, 6052.152698622196, 6052.72762725674, 5793.478586927196, 5930.584859059867, 6023.668698221596, 6069.969650151721, 6098.29688551976, 5565.0, 5570.498655121018, 5570.805021824257, 5579.414161513064, 5589.273394458735, 6058.1518587397795, 6064.514838812885, 6070.2108725865355, 6092.543059270483, 6099.9085013724825, 5691.459311365414, 5758.165066065397, 5812.447817457335, 5839.970800146057, 5855.3851845556455, 5903.321118071477, 5908.05471124618, 5915.763369465173, 5922.911156332659, 5925.170476133345, 5728.140778883201, 5893.970530147321, 5894.056950887837, 5896.204012458349, 5896.823095307148, 5882.941170588325, 5950.761969521171, 5955.0769630706445, 5983.880322393615, 5996.5202783777195, 4531.501534831166, 4534.455865296186, 4537.342085397665, 4537.659675524349, 4566.862994110182, 3985.2826491231276, 3991.7006224533275, 4082.4284600156, 4083.3466645336603, 4103.322951712994, 5637.689927054052, 5652.63257888236, 5663.093904975184, 5680.68756218412, 5681.857953551112, 5915.319738230072, 5930.525557955353, 5937.287525496968, 5938.317093534212, 5941.108833674897, 5593.244911936918, 5621.353544342372, 5644.774209031675, 5658.660480371191, 5670.036093864053, 5047.9495205048215, 5054.090263752486, 5055.064813009605, 5073.036123136592, 5083.796648134034, 6195.907061394083, 6197.938020619736, 6199.628022318675, 6240.407161319758, 6243.96878015607, 5886.411358864079, 6048.939510604838, 6057.3639767824625, 6073.0, 6073.331933487401, 6215.875682486416, 6216.191895053614, 6249.125122482765, 6251.531135164972, 6253.187085678833, 5930.229070220844, 5944.8236717502205, 5949.553783466171, 5955.464008239279, 5981.7906373278465, 5780.046292361882, 5996.100584912124, 6044.15381846533, 6053.092036194606, 6068.939310606837, 5775.884482310246, 5813.476787089182, 5831.562632802472, 5845.152452894392, 5848.883022339614, 5777.191193232867, 5798.942010580009, 5813.883722325614, 5817.854553636193, 5837.474627283565, 5548.722563871871, 5684.658920464785, 5747.166660834239, 5751.338596061507, 5775.855603609775, 5806.709664516842, 5844.47399734026, 5854.443827836349, 5874.970625146847, 5881.794137205177, 5737.770489180553, 5737.856553586027, 5739.655620662774, 5745.224394706661, 5765.798197063083], "value": 5495.7336145851405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.589110642508, 675.9425448836848, 676.1683129750404, 681.3765404654741, 734.9963250183752, 33633.66366336336, 40741.79629101854, 41278.380824287626, 41492.58507414925, 41496.58503414965, 44424.555754442445, 45022.09955800882, 45047.32429013567, 45086.32370514445, 45095.54904450954, 8247.628856701433, 8796.076411976746, 8955.014948355676, 8955.37312388133, 10453.0, 10700.892991070068, 10918.454077296143, 10921.180911431675, 10923.0, 10924.453777311142, 10972.670819875417, 11070.944645276762, 11072.889271107306, 11074.335539867594, 11078.501467433944, 8674.349423793241, 10738.677839664744, 10891.455427228646, 11049.28179668319, 11060.668179954533, 10475.633352832614, 10501.159907207406, 10594.947025264824, 10600.356944673587, 10610.787784244349, 44248.0, 44987.0, 45011.09977800426, 45066.54933450656, 45100.0, 4105.404716316118, 4113.691473139496, 4548.4541854977615, 4618.884527886796, 4679.976600116977, 34053.0, 34446.13884652879, 34517.48223776645, 34663.480047799305, 35492.64507354919, 4576.267797152473, 4607.562281583244, 4651.139539185261, 4661.650376221797, 4737.336772851803, 344453.0, 345418.0, 349476.0, 349807.0, 351241.0, 66856.0, 67099.66450167718, 67580.0, 67594.3240567588, 67604.0, 71477.6426117866, 73484.0, 73960.63019684974, 74112.0, 74330.0, 19597.314094006928, 19818.108185131703, 19827.30604428867, 19828.306009289605, 19835.305764298468, 13846.238456884968, 15591.376344946075, 15900.0, 15905.125218112884, 15911.761323580156, 20639.277625283044, 20746.377608671763, 20897.47756306074, 20959.0, 21004.78995210059, 7544.358729508053, 7609.923900761032, 7719.150893401721, 7743.225677432324, 7842.64708088126, 1122.7922834275685, 1163.610190586163, 1185.9525618975317, 1227.8403807504967, 1248.3134276148264, 33889.661103389146, 34155.487667685, 34579.48130778041, 34597.30805383878, 35027.82486087553, 1233.340163012784, 1252.9976019184617, 1254.711416374239, 1260.4013093780381, 1315.0, 18393.908030459763, 18426.447206583824, 18545.44363669092, 18626.906865465586, 18703.532411689815, 556529.0, 556600.0, 563904.0, 565297.0, 565367.0, 63931.0, 64293.678531607045, 64356.034659480145, 64542.0, 64824.0, 1414.1868425655289, 1464.1288433382333, 1464.2239613005124, 1475.48358074673, 1497.7378958682186, 30997.380052398374, 31518.0, 31951.680483194872, 32803.34393312073, 33558.832205838815, 48811.26783098185, 48820.2676959853, 49194.278200262816, 49225.26162107643, 49226.01547969092, 314787.0, 316802.0, 316850.0, 316916.0, 317558.0, 28170.718292816808, 31121.68878311188, 31370.843145784125, 31533.52699709552, 32127.839360803046, 46507.30239046349, 47137.7643111796, 47434.76282618565, 47527.287090692975, 47530.0, 38413.039674007254, 38701.0, 39375.80312098536, 43116.78441607772, 43339.78330108456, 41940.79029604955, 42312.95972589525, 42749.35875961925, 43040.78479607582, 43229.351559727256, 42921.570784291755, 43957.78021109874, 44520.527583165494, 44918.0, 45030.324545131196, 35784.642153578134, 36540.0, 37841.0, 37974.7713811308, 38291.808540958235, 28735.281617959718, 29054.418911622073, 29095.854520727262, 29235.0, 29259.268518287212], "value": 21669.12345538217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.8431860454679, 436.4435344935208, 438.09314718532613, 440.4516377110497, 448.9259272220084, 18408.63182736346, 18920.90539547302, 19121.52196195094, 19429.12568934398, 19923.800761992377, 18870.245190192374, 18904.716429253538, 20494.282700105497, 20499.282525111623, 20524.28165014225, 5633.211350410936, 5699.629524080921, 5763.654180749148, 5848.824535263949, 5854.619449735775, 4277.294246449332, 5783.9710801445935, 5786.508146807527, 6050.878982420349, 6349.111124442582, 6295.968520157393, 6317.620942743427, 6330.65181415022, 6334.081558174062, 6339.809805705836, 5667.8583035424235, 5921.940780592225, 5932.0508718604815, 5943.702814859262, 6474.676266186695, 3983.1237127831832, 4145.067359844041, 5691.317041954951, 5733.082706766939, 5806.5354771618595, 13516.729665406736, 13608.727825443435, 13681.657958551017, 13748.93125534366, 18912.621747564972, 2226.565819665166, 2302.2632757517435, 2370.3481542575755, 2592.831465954726, 2800.80394372394, 10442.060214580724, 11189.873923954505, 11443.970042696114, 13223.206607603479, 14055.437782488689, 1912.722655214986, 1955.2179128348632, 2010.3566858605107, 2017.9697304540443, 2135.9252426165167, 73437.63281183613, 73531.63234183849, 76089.0, 77271.22728772752, 78227.60886195532, 11296.0, 11494.42527873603, 11535.653930382103, 11690.47392867323, 12023.458944347525, 16361.181940902907, 16444.0, 16527.421540246276, 16571.17144142788, 16576.585585360463, 9084.40951338161, 9109.316801239802, 9118.99691033999, 9147.313951453667, 9190.816183676288, 9006.909930900738, 9063.728088157366, 9188.310876684276, 9232.261419086592, 9327.813443731224, 5143.254228136974, 5178.741062946838, 5186.325777648882, 5209.609279303992, 5258.526732594085, 1837.690615506635, 1999.2402886902885, 2050.8359331253464, 2104.3371338028473, 2111.033997233889, 478.4927976345085, 494.89854579811055, 1010.3533738407425, 1054.2093429927554, 1064.7125276175389, 11943.88056119445, 12045.578404755792, 12104.15270931044, 12403.0, 12630.747385052247, 511.0, 522.5975998481148, 524.2529395611239, 528.4556906386429, 539.802971915256, 6612.206535215805, 6665.733370665119, 6712.798616041527, 6762.222344430355, 6823.69293381799, 187989.0, 531813.409329532, 534747.0, 547347.8428255072, 577105.0, 98226.50886745521, 100095.49952250192, 100193.49903250583, 100215.49892250638, 100842.49578752206, 521.8825764203024, 523.9528442440198, 524.1875093604973, 526.7761201489352, 527.16970771035, 16784.58038549046, 16813.74779378286, 17043.31826726917, 17757.0, 17837.46487605374, 36605.63394366022, 37086.814565927, 37909.0, 38180.42729359117, 39108.0, 48438.273425899344, 53510.0, 57638.423615763306, 57738.42261577331, 57753.422465774805, 8792.560371981503, 8921.464712117293, 8939.418937769024, 9069.637214511346, 9088.863667045132, 8737.868931965899, 9673.0, 12624.179428337497, 12918.612441626767, 13016.349182541024, 11968.521259149536, 12101.878981210075, 12144.392780361124, 12245.938770306448, 12338.321392323509, 11799.115066370228, 12096.395180241128, 12278.693032673897, 12383.442745076673, 12606.747865042831, 6714.731410743516, 9146.679866204651, 10398.948005259925, 12414.875851241371, 12644.178128421623, 8854.114588541095, 9075.727728168165, 9132.726018219464, 9150.954245228731, 9466.763330916781, 11468.598599048993, 12351.444185011516, 12364.381780911099, 12504.249745015328, 12505.124641275024], "value": 8693.12402429625, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.3139293139286, 1567.9999999999998, 1582.3275108079072, 1773.432501599488, 1917.2810196176433, 8311.335093192538, 8609.182127697874, 8612.913870861305, 8615.43999640023, 8625.870611940818, 8342.91657083429, 8531.87202191966, 8543.487390756543, 8545.273651739593, 8547.230749232567, 2199.868007919522, 2442.9877850610765, 2446.6330050492393, 2480.2807185916154, 2500.4749002709455, 2481.5781317176034, 2515.937101572457, 2528.329992551975, 2531.9873400632973, 2532.151729170721, 2456.435019945414, 2456.6192240202795, 2457.741937096606, 2467.0501856785177, 2468.691413573303, 2180.8800515971616, 2339.0, 2390.5218956208655, 2390.9282721518207, 2391.796697280733, 2351.341624345169, 2393.8204634652297, 2408.1089996701335, 2415.070197973793, 2419.9153029644053, 8394.24451799341, 8425.11536288693, 8443.831123377498, 8460.915390846136, 8469.491830490191, 5274.736263186864, 5390.865228369283, 5393.298871146726, 5434.103372943459, 5507.504324610804, 3525.94711079334, 3562.9667396454997, 3628.5645722513204, 3680.834362453696, 3696.741228114033, 1114.654457118296, 1124.1400328748514, 1124.6907100547332, 1133.9433028348549, 1145.856767904012, 11792.29246245228, 11854.822177667427, 11964.760704785942, 11983.94008029963, 11999.280043197436, 4562.498125206224, 4611.93082103762, 4648.628109751212, 4661.930071048937, 4690.249560070372, 10298.536565854554, 10304.639337623148, 10313.27807053499, 10316.0, 10327.896721032845, 4924.162892308316, 5407.486288802557, 5408.594355423359, 5408.891822163535, 5411.458854114557, 4917.434495033045, 4945.159322915113, 4958.9008219835405, 4975.278584605212, 5012.523810238022, 4104.979475102665, 4123.113530590937, 4173.061061261253, 4190.497140343117, 4202.201581699528, 1293.8512071111943, 1313.5402609086743, 1319.3732976835927, 1321.4978308242999, 1328.3395755305867, 903.2683526343683, 961.1733908838394, 964.2478866484154, 1075.8224892892742, 1092.415557676639, 5920.111983202468, 6052.909206361908, 6074.210352654127, 6147.692615369214, 6283.214598175228, 452.9275315949432, 456.99233190814175, 457.65675743192605, 1092.317301686446, 1094.7700982793542, 4020.3768415895584, 4079.347304431277, 4079.63283304504, 4095.9385609215888, 4118.155778065489, 10391.168706503462, 10822.40476773785, 10967.122630189566, 11003.504842282116, 11008.064314533194, 10753.408562528979, 10797.784044319069, 10818.080463160562, 10836.837447438294, 10845.0, 8354.122817104238, 8365.749027529184, 8479.448835825775, 8481.745547633582, 8486.872696909551, 5354.170103633787, 5615.241942337732, 5697.886042279214, 5739.684317362585, 5795.8551036224435, 9307.813843723223, 9598.280128990215, 9606.375585586915, 9837.557309921214, 9857.950710246403, 9729.270304727315, 9793.02069793015, 9930.553125109243, 10073.19414446857, 10139.138173255356, 6669.1330127083165, 7154.284571542804, 7344.96327518359, 7560.054993125859, 7620.199879012624, 8343.666253349798, 8375.162483751576, 8383.245507904317, 8419.073901870666, 8440.366972477212, 7451.962740186264, 7637.541747495168, 7674.270944260286, 7688.807779805549, 7701.883226932176, 7440.665170067252, 7491.737789177353, 7500.437467190091, 7591.051118610174, 7624.58064806441, 6978.302169782981, 7046.859062818612, 7067.540609860343, 7181.210066892533, 7186.24544422849, 4989.700617962933, 5053.545180933734, 5085.160948443613, 5161.458046905021, 5209.947900521098, 5034.773435195351, 5101.642884998163, 5104.279375415607, 5186.481351864783, 5206.193040078794], "value": 4634.784793732031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3182641588526, 362.8385368511013, 364.1751433004245, 371.90702324418913, 373.719710217337, 6229.785191887578, 6266.624002559844, 6296.0, 6351.841203969903, 6354.841128971778, 5952.672603006833, 6104.4200800923845, 6256.562040657156, 6258.84352891178, 6266.9373306266925, 4761.381020467335, 4782.617390608761, 4800.447948485917, 4801.327814106028, 4810.951890481103, 4782.473927867932, 4786.305985632099, 4789.5928846047955, 4801.375821143247, 4818.385840743355, 4579.862604121881, 4669.322948172513, 4750.049990002013, 4774.80900763969, 4784.3780308559835, 4719.268513380432, 4770.97614511927, 4771.737554434522, 4777.450593181794, 4780.354652121954, 4222.2611043067645, 4224.894377640553, 4231.788410579489, 4233.23801715691, 4235.3646952957, 6010.519158467312, 6017.338092809788, 6022.367651396584, 6029.879402411971, 6033.607815492023, 5534.169874518814, 5593.272874526327, 5595.972020139914, 5601.831945041656, 5602.271704678406, 6394.58435201715, 6597.373249541334, 6626.93373066268, 6630.900536491957, 6636.8672626547195, 4598.770061496912, 4618.65360097994, 4624.583787459145, 4630.9536904631195, 4632.884177895579, 6840.828979275509, 6913.75801846938, 6923.134608173978, 6935.029095926574, 6941.34057264559, 4705.788239529229, 4714.834980775657, 4717.952820471752, 4718.079974404958, 4720.221163508051, 4769.833055843029, 4772.737499437495, 4772.904541909143, 4777.092352453093, 4778.737169455713, 5270.894582108336, 5403.108487099585, 5525.834224973257, 5532.972335138379, 5542.0301447246575, 6443.96778016107, 6476.158099447136, 6496.480281577463, 6498.415142637091, 6556.213254409406, 1586.1910425682984, 1636.051090367584, 1663.8585720213916, 1673.983260167407, 1679.5129412470246, 1071.5392381276126, 1099.7745462180235, 1105.4859490337033, 1106.9557217711363, 1113.0761467981556, 6423.4861211103, 6425.297296216507, 6435.74748837903, 6438.6136831790245, 6444.7744328948265, 6774.593524388552, 6785.796426107225, 6787.966060169668, 6795.762148324785, 6810.421114205249, 6397.552171348054, 6412.198475190601, 6412.2625898022325, 6419.967900160469, 6423.550351475352, 3596.8741094061584, 3647.8176091195332, 3650.361186792301, 3651.1967367179177, 3654.634536546324, 6888.138982627172, 7025.964870175617, 7054.823629409306, 7070.39901608369, 7081.07945967021, 6842.4183944364295, 6843.315668433216, 6863.828404289933, 6870.416014638712, 6880.139982502187, 7037.753678621224, 7049.343404299985, 7059.082319298458, 7064.858702825914, 7064.92935070653, 6759.121314229119, 6771.356721111487, 6773.085633439423, 6776.728930842908, 6783.0, 6532.150820393508, 6624.470042396693, 6663.900041499284, 6670.099536562502, 6679.632620205741, 6947.861042779015, 6989.231184569591, 6993.510454268152, 6998.195207551197, 7006.719731210695, 4690.554397332248, 4699.4830568636735, 4702.882427939329, 4705.5059218781535, 4706.294055891643, 6728.461723062242, 6733.494987875831, 6736.360045795642, 6737.461003119641, 6744.898826517508, 6403.615783053032, 6512.5766825156215, 6586.604803711793, 6593.934060659524, 6612.933870661232, 6683.498737594603, 6705.2959439258175, 6712.0, 6722.193336799615, 6725.932740672531, 6585.835354116185, 6586.769463068769, 6591.967040164768, 6600.306967768315, 6606.933930660824, 6557.786809440268, 6738.225104113089, 6749.190097188369, 6750.5274630775375, 6753.15585551806, 6561.934380656132, 6564.179477565304, 6566.770163044271, 6569.113169722026, 6570.47436205112], "value": 4993.875056900213, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.2629896083134, 943.6791490893097, 967.2697113679176, 986.0829428631374, 991.4299277915201, 14660.973731838776, 15434.845651543495, 15510.922445387758, 15660.530184094467, 15680.0, 14578.781318280235, 14758.557243282692, 14793.260336983161, 14799.038062525955, 14809.629759256024, 759.3583422008394, 900.3517467423477, 922.4603606889978, 927.332320729074, 931.2317338195982, 920.3189639666665, 924.6486335192617, 926.1710768861865, 927.536231884058, 927.9953600231989, 969.2924165359292, 974.0843607009389, 974.7611835100411, 975.2149519636689, 976.0191008036913, 812.6424373275739, 958.7267628725815, 969.9272554558436, 972.9173020293283, 973.4305431322649, 717.3830505765038, 717.519262094398, 717.5766297884221, 718.174099785246, 719.4999475364624, 15220.543383698507, 15298.158601276926, 15311.617209569738, 15314.617134571614, 15336.233188340539, 14664.41342346305, 14931.402743890232, 15099.924500377538, 15122.621934451618, 15223.0, 12134.453949572291, 12166.81749773754, 12193.0, 12325.815112773316, 12691.74616507674, 4001.0597509585223, 4032.4556184915245, 4090.032668311733, 4126.525449573308, 4148.128892932487, 53196.0, 53899.461005389836, 53916.730416347666, 54252.0, 54756.452435475534, 11549.191556591126, 11711.531538738354, 11727.179097463095, 11735.295882247092, 12053.698657533632, 21546.03042863075, 21679.67480487794, 22034.11863525473, 22084.33746987593, 22087.779122208573, 8237.670493180205, 8283.25450709439, 8556.529390883561, 8564.100769419121, 8614.18165274298, 4890.877728056827, 4925.950740492621, 4952.579030782424, 4998.300237966688, 5093.032323858455, 3474.808885511321, 3528.964710352915, 3536.169000284931, 3539.486774417695, 3547.3614749345365, 662.5031226580065, 690.7340673840507, 703.9788806335819, 711.7331000874672, 717.0713925466533, 707.6921539130494, 735.2977906099662, 752.4883079505879, 841.8989721233492, 852.4203541591653, 10052.497375131361, 10147.898521014695, 10391.53238104287, 10399.0, 10438.530266138043, 729.5258082246476, 826.7065191856924, 832.3091833778071, 837.2213841127688, 855.0679759062651, 4572.977135114304, 4603.148417542765, 4774.904501910012, 4832.420109586872, 4931.630127740434, 64277.0, 64712.0, 64807.0, 64974.0, 65077.349226507125, 55536.44463555393, 57324.0, 57438.425615743305, 57624.711876441186, 58849.41150588525, 50042.499575003785, 51304.74347628238, 52599.737001315516, 52700.0, 52752.0, 9481.525923703924, 9621.749172607517, 9670.226381889574, 9777.9022209777, 9813.362131461432, 36713.0, 37093.443598345504, 37690.623093768714, 38311.233775324894, 39334.40998384969, 45964.310535342665, 47001.76499117619, 47378.0, 48191.75904120457, 48846.26730599115, 12724.936375318064, 12749.87250127487, 13246.536371226961, 13403.262820544964, 13605.387757551132, 14513.709725805636, 14910.552683419515, 15053.322600483223, 15122.773158402853, 15488.922555387151, 13779.586612401645, 13970.930145349208, 14123.081999669988, 14402.783958240425, 14806.333714983068, 13813.585592432242, 13973.161610303414, 14092.647683807987, 14116.717665646835, 14201.573952781433, 13849.930750346184, 14036.929815350857, 14056.156630602196, 14407.207603581903, 14605.92697036508, 10968.780624387628, 11176.832347514632, 11336.263142895685, 11350.886491134983, 11643.184977051525, 10982.06652434552, 11200.77549980242, 11390.316581005167, 11579.247348922294, 11623.360715160408], "value": 7339.467318110285, "unit": "score"}], "name": "dromaeo_css", "value": 7485.185519133312, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 105.0, 111.0, 111.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 152.0, 175.0, 128.0, 157.0, 174.0, 130.0, 172.0, 132.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 159.0, 165.0, 160.0, 160.0, 159.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 168.0, 75.0, 78.0, 73.0, 76.0, 169.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 91.0, 92.0, 92.0, 141.0, 91.0, 92.0, 148.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 146.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 54.0, 55.0, 56.0, 55.0, 56.0, 76.0, 53.0, 53.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 73.0, 77.0, 77.0, 76.0, 73.0, 74.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 112.0, 113.0, 119.0, 121.0, 109.0, 114.0, 137.0, 132.0], "value": 119.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 157.0, 158.0, 164.0, 158.0, 158.0, 162.0, 163.0, 156.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 63.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1511.4999999999998, "alertThreshold": 2.0}]} 03:47:05 INFO - Return code: 0 03:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:47:05 ERROR - # TBPL SUCCESS # 03:47:05 INFO - Running post-action listener: _resource_record_post_action 03:47:05 INFO - Running post-run listener: _resource_record_post_run 03:47:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 381079552; Read time: 1132; Write time: 407404 03:47:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6303744; Read time: 0; Write time: 528 03:47:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6176768; Write bytes: 374775808; Read time: 1076; Write time: 406876 03:47:06 INFO - Running post-run listener: _upload_blobber_files 03:47:06 INFO - Blob upload gear active. 03:47:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:06 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 03:47:06 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:47:06 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:47:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:08 INFO - (blobuploader) - INFO - Done attempting. 03:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:08 INFO - (blobuploader) - INFO - Done attempting. 03:47:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:08 INFO - Return code: 0 03:47:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/053de5d298115168a34f694b10d63b35b94b910d0fd887ef40a687e7af864457f383c14d4c7032cdbacca1b613f1ea57ad348f66984963a696d1b35d7f5c7c40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/661c8a32162831e0186d23bb3f757c6e889bd62c3040eeb2beb4d57ec0499c94771abed31416ecbed0e092f678cf7daf40bff834d6c2e91479368c8dcda28aaf"} 03:47:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:08 INFO - Contents: 03:47:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/053de5d298115168a34f694b10d63b35b94b910d0fd887ef40a687e7af864457f383c14d4c7032cdbacca1b613f1ea57ad348f66984963a696d1b35d7f5c7c40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/661c8a32162831e0186d23bb3f757c6e889bd62c3040eeb2beb4d57ec0499c94771abed31416ecbed0e092f678cf7daf40bff834d6c2e91479368c8dcda28aaf"} 03:47:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:08 INFO - Copying logs to upload dir... 03:47:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.832095 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-04 03:47:08.842590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 03:47:08.845953) ========= 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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 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-Aurora/sha512/053de5d298115168a34f694b10d63b35b94b910d0fd887ef40a687e7af864457f383c14d4c7032cdbacca1b613f1ea57ad348f66984963a696d1b35d7f5c7c40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/661c8a32162831e0186d23bb3f757c6e889bd62c3040eeb2beb4d57ec0499c94771abed31416ecbed0e092f678cf7daf40bff834d6c2e91479368c8dcda28aaf"} build_url:https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/PpxfV0-eRkK-PN88hUfF5A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/053de5d298115168a34f694b10d63b35b94b910d0fd887ef40a687e7af864457f383c14d4c7032cdbacca1b613f1ea57ad348f66984963a696d1b35d7f5c7c40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/661c8a32162831e0186d23bb3f757c6e889bd62c3040eeb2beb4d57ec0499c94771abed31416ecbed0e092f678cf7daf40bff834d6c2e91479368c8dcda28aaf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 03:47:08.870943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:47:08.871298) ========= 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=7de08804244eb36560b44971000001c3-1465033301.161717-578434308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 03:47:08.953651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 03:47:08.954034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 03:47:08.954359) ========= ========= Total master_lag: 0.20 =========