builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1461670232.97 results: success (0) buildid: 20160426013139 builduid: 904355e6146f4f528aeb09a61be36072 revision: 5b7777972750aa3c57e6f6f6d4e4621072741617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:32.974503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:32.975118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:32.975408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:32.992889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:32.993305) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 04:30:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-26 04:30:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:33.226506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:33.226828) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013784 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:33.275823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 04:30:33.276191) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5b7777972750aa3c57e6f6f6d4e4621072741617 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5b7777972750aa3c57e6f6f6d4e4621072741617 --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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 04:30:33,594 truncating revision to first 12 chars 2016-04-26 04:30:33,594 Setting DEBUG logging. 2016-04-26 04:30:33,594 attempt 1/10 2016-04-26 04:30:33,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5b7777972750?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 04:30:34,726 unpacking tar archive at: mozilla-inbound-5b7777972750/testing/mozharness/ program finished with exit code 0 elapsedTime=1.409760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 04:30:34.698781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:34.699103) ========= script_repo_revision: 5b7777972750aa3c57e6f6f6d4e4621072741617 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:34.699514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:34.699773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 04:30:34.709881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-04-26 04:30:34.710278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:35 INFO - MultiFileLogger online at 20160426 04:30:35 in /builds/slave/test 04:30:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:35 INFO - {'append_to_log': False, 04:30:35 INFO - 'base_work_dir': '/builds/slave/test', 04:30:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:35 INFO - 'branch': 'Mozilla-Inbound', 04:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:35 INFO - 'config_files': ('talos/linux_config.py',), 04:30:35 INFO - 'default_actions': ('clobber', 04:30:35 INFO - 'read-buildbot-config', 04:30:35 INFO - 'download-and-extract', 04:30:35 INFO - 'populate-webroot', 04:30:35 INFO - 'create-virtualenv', 04:30:35 INFO - 'install', 04:30:35 INFO - 'run-tests'), 04:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:35 INFO - 'download_minidump_stackwalk': True, 04:30:35 INFO - 'download_symbols': 'ondemand', 04:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:35 INFO - 'installer_path': 'installer.exe', 04:30:35 INFO - 'log_level': 'info', 04:30:35 INFO - 'log_name': 'talos', 04:30:35 INFO - 'log_to_console': True, 04:30:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:35 INFO - 'opt_config_files': (), 04:30:35 INFO - 'pip_index': False, 04:30:35 INFO - 'sps_profile': False, 04:30:35 INFO - 'sps_profile_interval': 0, 04:30:35 INFO - 'suite': 'dromaeojs-e10s', 04:30:35 INFO - 'system_bits': '32', 04:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:35 INFO - 'title': 'talos-linux64-ix-067', 04:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:35 INFO - 'use_talos_json': True, 04:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:35 INFO - 'work_dir': 'build'} 04:30:35 INFO - ##### 04:30:35 INFO - ##### Running clobber step. 04:30:35 INFO - ##### 04:30:35 INFO - Running pre-action listener: _resource_record_pre_action 04:30:35 INFO - Running main action method: clobber 04:30:35 INFO - rmtree: /builds/slave/test/build 04:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:36 INFO - Running post-action listener: _resource_record_post_action 04:30:36 INFO - ##### 04:30:36 INFO - ##### Running read-buildbot-config step. 04:30:36 INFO - ##### 04:30:36 INFO - Running pre-action listener: _resource_record_pre_action 04:30:36 INFO - Running main action method: read_buildbot_config 04:30:36 INFO - Using buildbot properties: 04:30:36 INFO - { 04:30:36 INFO - "project": "", 04:30:36 INFO - "product": "firefox", 04:30:36 INFO - "script_repo_revision": "production", 04:30:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:30:36 INFO - "repository": "", 04:30:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:30:36 INFO - "buildid": "20160426013139", 04:30:36 INFO - "pgo_build": "True", 04:30:36 INFO - "basedir": "/builds/slave/test", 04:30:36 INFO - "buildnumber": 573, 04:30:36 INFO - "slavename": "talos-linux64-ix-067", 04:30:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:36 INFO - "platform": "ubuntu64_hw", 04:30:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:30:36 INFO - "branch": "mozilla-inbound", 04:30:36 INFO - "repo_path": "integration/mozilla-inbound", 04:30:36 INFO - "revision": "5b7777972750aa3c57e6f6f6d4e4621072741617", 04:30:36 INFO - "stage_platform": "linux64-pgo", 04:30:36 INFO - "builduid": "904355e6146f4f528aeb09a61be36072", 04:30:36 INFO - "slavebuilddir": "test" 04:30:36 INFO - } 04:30:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:30:36 INFO - Running post-action listener: _resource_record_post_action 04:30:36 INFO - ##### 04:30:36 INFO - ##### Running download-and-extract step. 04:30:36 INFO - ##### 04:30:36 INFO - Running pre-action listener: _resource_record_pre_action 04:30:36 INFO - Running main action method: download_and_extract 04:30:36 INFO - mkdir: /builds/slave/test/build/tests 04:30: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')]} 04:30:36 INFO - https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:30:45 INFO - Downloaded 1361 bytes. 04:30:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:30:45 INFO - Using the following test package requirements: 04:30:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:30:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'jsshell-linux-x86_64.zip'], 04:30:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:45 INFO - https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:56 INFO - Downloaded 23863703 bytes. 04:30:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:30:57 INFO - Return code: 0 04:30:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:57 INFO - https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:04 INFO - Downloaded 23863703 bytes. 04:31:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:05 INFO - Return code: 0 04:31: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')]} 04:31:05 INFO - https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:07 INFO - Downloaded 10840145 bytes. 04:31:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:31:08 INFO - Return code: 0 04:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:08 INFO - https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:09 INFO - Downloaded 58383589 bytes. 04:31:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:09 INFO - mkdir: /builds/slave/test/properties 04:31:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:09 INFO - Contents: 04:31:09 INFO - build_url:https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:10 INFO - Running post-action listener: _resource_record_post_action 04:31:10 INFO - Running post-action listener: set_extra_try_arguments 04:31:10 INFO - ##### 04:31:10 INFO - ##### Running populate-webroot step. 04:31:10 INFO - ##### 04:31:10 INFO - Running pre-action listener: _resource_record_pre_action 04:31:10 INFO - Running main action method: populate_webroot 04:31:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:10 INFO - '--tppagecycles', 04:31:10 INFO - '7'], 04:31:10 INFO - 'tests': ['tsvgm']}}, 04:31:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['damp', 'tps']}, 04:31:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'tests': ['damp', 'tps']}, 04:31:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['dromaeo_dom']}, 04:31:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['a11yr', 04:31:10 INFO - 'ts_paint', 04:31:10 INFO - 'tpaint', 04:31:10 INFO - 'sessionrestore', 04:31:10 INFO - 'sessionrestore_no_auto_restore', 04:31:10 INFO - 'tabpaint']}, 04:31:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['tsvgx', 04:31:10 INFO - 'tsvgr_opacity', 04:31:10 INFO - 'tart', 04:31:10 INFO - 'tscrollx', 04:31:10 INFO - 'cart']}, 04:31:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:10 INFO - 'tsvgr_opacity', 04:31:10 INFO - 'tart', 04:31:10 INFO - 'tscrollx', 04:31:10 INFO - 'cart']}, 04:31:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'talos_options': ['--disable-e10s'], 04:31:10 INFO - 'tests': ['tp5o']}, 04:31:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'tests': ['tp5o']}, 04:31:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'talos_options': ['--disable-e10s', 04:31:10 INFO - '--xperf_path', 04:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:10 INFO - 'tests': ['tp5n']}, 04:31:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:10 INFO - 'talos_options': ['--xperf_path', 04:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:10 INFO - 'tests': ['tp5n']}}, 04:31:10 INFO - 'talos.zip': {'path': '', 04:31:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:10 INFO - Running post-action listener: _resource_record_post_action 04:31:10 INFO - ##### 04:31:10 INFO - ##### Running create-virtualenv step. 04:31:10 INFO - ##### 04:31:10 INFO - Running pre-action listener: _resource_record_pre_action 04:31:10 INFO - Running main action method: create_virtualenv 04:31:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:10 INFO - Using real prefix '/usr' 04:31:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:12 INFO - Installing pip.................done. 04:31:12 INFO - Return code: 0 04:31:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:12 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:12 INFO - Using env: {'DISPLAY': ':0', 04:31:12 INFO - 'HOME': '/home/cltbld', 04:31:12 INFO - 'LANG': 'en_US.UTF-8', 04:31:12 INFO - 'LANGUAGE': 'en_US:en', 04:31:12 INFO - 'LOGNAME': 'cltbld', 04:31:12 INFO - 'MAIL': '/var/mail/cltbld', 04:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:12 INFO - 'MOZ_NO_REMOTE': '1', 04:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:12 INFO - 'NO_EM_RESTART': '1', 04:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:12 INFO - 'PWD': '/builds/slave/test', 04:31:12 INFO - 'SHELL': '/bin/bash', 04:31:12 INFO - 'SHLVL': '1', 04:31:12 INFO - 'TERM': 'linux', 04:31:12 INFO - 'TMOUT': '86400', 04:31:12 INFO - 'USER': 'cltbld', 04:31:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:12 INFO - '_': '/tools/buildbot/bin/python'} 04:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:12 INFO - Cleaning up... 04:31:12 INFO - Return code: 0 04:31:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:12 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:31:12 INFO - Using env: {'DISPLAY': ':0', 04:31:12 INFO - 'HOME': '/home/cltbld', 04:31:12 INFO - 'LANG': 'en_US.UTF-8', 04:31:12 INFO - 'LANGUAGE': 'en_US:en', 04:31:12 INFO - 'LOGNAME': 'cltbld', 04:31:12 INFO - 'MAIL': '/var/mail/cltbld', 04:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:12 INFO - 'MOZ_NO_REMOTE': '1', 04:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:12 INFO - 'NO_EM_RESTART': '1', 04:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:12 INFO - 'PWD': '/builds/slave/test', 04:31:12 INFO - 'SHELL': '/bin/bash', 04:31:12 INFO - 'SHLVL': '1', 04:31:12 INFO - 'TERM': 'linux', 04:31:12 INFO - 'TMOUT': '86400', 04:31:12 INFO - 'USER': 'cltbld', 04:31:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:12 INFO - '_': '/tools/buildbot/bin/python'} 04:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:13 INFO - Downloading/unpacking psutil>=0.7.1 04:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:15 INFO - Installing collected packages: psutil 04:31:15 INFO - Running setup.py install for psutil 04:31:15 INFO - building 'psutil._psutil_linux' extension 04:31:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:15 INFO - building 'psutil._psutil_posix' extension 04:31:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:15 INFO - Successfully installed psutil 04:31:15 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:31:15 INFO - Using env: {'DISPLAY': ':0', 04:31:15 INFO - 'HOME': '/home/cltbld', 04:31:15 INFO - 'LANG': 'en_US.UTF-8', 04:31:15 INFO - 'LANGUAGE': 'en_US:en', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MAIL': '/var/mail/cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SHLVL': '1', 04:31:15 INFO - 'TERM': 'linux', 04:31:15 INFO - 'TMOUT': '86400', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - '_': '/tools/buildbot/bin/python'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:31:17 INFO - Installing collected packages: mozsystemmonitor 04:31:17 INFO - Running setup.py install for mozsystemmonitor 04:31:17 INFO - Successfully installed mozsystemmonitor 04:31:17 INFO - Cleaning up... 04:31:17 INFO - Return code: 0 04:31:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:17 INFO - Using env: {'DISPLAY': ':0', 04:31:17 INFO - 'HOME': '/home/cltbld', 04:31:17 INFO - 'LANG': 'en_US.UTF-8', 04:31:17 INFO - 'LANGUAGE': 'en_US:en', 04:31:17 INFO - 'LOGNAME': 'cltbld', 04:31:17 INFO - 'MAIL': '/var/mail/cltbld', 04:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:17 INFO - 'MOZ_NO_REMOTE': '1', 04:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:17 INFO - 'NO_EM_RESTART': '1', 04:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:17 INFO - 'PWD': '/builds/slave/test', 04:31:17 INFO - 'SHELL': '/bin/bash', 04:31:17 INFO - 'SHLVL': '1', 04:31:17 INFO - 'TERM': 'linux', 04:31:17 INFO - 'TMOUT': '86400', 04:31:17 INFO - 'USER': 'cltbld', 04:31:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:17 INFO - '_': '/tools/buildbot/bin/python'} 04:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - Downloading docopt-0.6.1.tar.gz 04:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:20 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:20 INFO - Running setup.py install for blobuploader 04:31:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:20 INFO - Running setup.py install for requests 04:31:21 INFO - Running setup.py install for docopt 04:31:21 INFO - Successfully installed blobuploader requests docopt 04:31:21 INFO - Cleaning up... 04:31:21 INFO - Return code: 0 04:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:21 INFO - Using env: {'DISPLAY': ':0', 04:31:21 INFO - 'HOME': '/home/cltbld', 04:31:21 INFO - 'LANG': 'en_US.UTF-8', 04:31:21 INFO - 'LANGUAGE': 'en_US:en', 04:31:21 INFO - 'LOGNAME': 'cltbld', 04:31:21 INFO - 'MAIL': '/var/mail/cltbld', 04:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:21 INFO - 'MOZ_NO_REMOTE': '1', 04:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:21 INFO - 'NO_EM_RESTART': '1', 04:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:21 INFO - 'PWD': '/builds/slave/test', 04:31:21 INFO - 'SHELL': '/bin/bash', 04:31:21 INFO - 'SHLVL': '1', 04:31:21 INFO - 'TERM': 'linux', 04:31:21 INFO - 'TMOUT': '86400', 04:31:21 INFO - 'USER': 'cltbld', 04:31:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:21 INFO - '_': '/tools/buildbot/bin/python'} 04:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:21 INFO - Running setup.py (path:/tmp/pip-IQSChC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:21 INFO - Running setup.py (path:/tmp/pip-igoS9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:21 INFO - Running setup.py (path:/tmp/pip-qVUG3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:21 INFO - Running setup.py (path:/tmp/pip-3OThyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:21 INFO - Running setup.py (path:/tmp/pip-v72aqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:21 INFO - Running setup.py (path:/tmp/pip-jAQ77n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:22 INFO - Running setup.py (path:/tmp/pip-zsHcg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:22 INFO - Running setup.py (path:/tmp/pip-W8ZdDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:22 INFO - Running setup.py (path:/tmp/pip-EgQOu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:22 INFO - Running setup.py (path:/tmp/pip-RTVzrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:22 INFO - Running setup.py (path:/tmp/pip-6aIURH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:22 INFO - Running setup.py (path:/tmp/pip-yYw9Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:22 INFO - Running setup.py (path:/tmp/pip-39Yl8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:22 INFO - Running setup.py (path:/tmp/pip-RGH2lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:22 INFO - Running setup.py (path:/tmp/pip-WZetgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:22 INFO - Running setup.py (path:/tmp/pip-U21WfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:22 INFO - Running setup.py (path:/tmp/pip-uscvj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:22 INFO - Running setup.py install for manifestparser 04:31:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:22 INFO - Running setup.py install for mozcrash 04:31:23 INFO - Running setup.py install for mozdebug 04:31:23 INFO - Running setup.py install for mozdevice 04:31:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for mozfile 04:31:23 INFO - Running setup.py install for mozhttpd 04:31:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for mozinfo 04:31:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for mozInstall 04:31:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for mozleak 04:31:23 INFO - Running setup.py install for mozlog 04:31:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for moznetwork 04:31:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:23 INFO - Running setup.py install for mozprocess 04:31:24 INFO - Running setup.py install for mozprofile 04:31:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:24 INFO - Running setup.py install for mozrunner 04:31:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:24 INFO - Running setup.py install for mozscreenshot 04:31:24 INFO - Running setup.py install for moztest 04:31:24 INFO - Running setup.py install for mozversion 04:31:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:24 INFO - Cleaning up... 04:31:24 INFO - Return code: 0 04:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:24 INFO - Using env: {'DISPLAY': ':0', 04:31:24 INFO - 'HOME': '/home/cltbld', 04:31:24 INFO - 'LANG': 'en_US.UTF-8', 04:31:24 INFO - 'LANGUAGE': 'en_US:en', 04:31:24 INFO - 'LOGNAME': 'cltbld', 04:31:24 INFO - 'MAIL': '/var/mail/cltbld', 04:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:24 INFO - 'MOZ_NO_REMOTE': '1', 04:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:24 INFO - 'NO_EM_RESTART': '1', 04:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:24 INFO - 'PWD': '/builds/slave/test', 04:31:24 INFO - 'SHELL': '/bin/bash', 04:31:24 INFO - 'SHLVL': '1', 04:31:24 INFO - 'TERM': 'linux', 04:31:24 INFO - 'TMOUT': '86400', 04:31:24 INFO - 'USER': 'cltbld', 04:31:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:24 INFO - '_': '/tools/buildbot/bin/python'} 04:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:24 INFO - Running setup.py (path:/tmp/pip-K6ZB9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:24 INFO - Running setup.py (path:/tmp/pip-ldfEH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:24 INFO - Running setup.py (path:/tmp/pip-d0w08t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:25 INFO - Running setup.py (path:/tmp/pip-m1fynV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:25 INFO - Running setup.py (path:/tmp/pip-Ny7hSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:25 INFO - Running setup.py (path:/tmp/pip-yc6tto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:25 INFO - Running setup.py (path:/tmp/pip-9Tt4AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:25 INFO - Running setup.py (path:/tmp/pip-1Kkmx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:25 INFO - Running setup.py (path:/tmp/pip-spouit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:25 INFO - Running setup.py (path:/tmp/pip-xBHL8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:25 INFO - Running setup.py (path:/tmp/pip-Sv2bb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:25 INFO - Running setup.py (path:/tmp/pip-gLvK1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:25 INFO - Running setup.py (path:/tmp/pip-wN_Yen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:25 INFO - Running setup.py (path:/tmp/pip-BMq6q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:25 INFO - Running setup.py (path:/tmp/pip-16Sk_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:25 INFO - Running setup.py (path:/tmp/pip-sAmzoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:25 INFO - Running setup.py (path:/tmp/pip-lVBm1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:27 INFO - Downloading blessings-1.6.tar.gz 04:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:27 INFO - Installing collected packages: blessings 04:31:27 INFO - Running setup.py install for blessings 04:31:28 INFO - Successfully installed blessings 04:31:28 INFO - Cleaning up... 04:31:28 INFO - Return code: 0 04:31:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:28 INFO - Reading from file tmpfile_stdout 04:31:28 INFO - Current package versions: 04:31:28 INFO - argparse == 1.2.1 04:31:28 INFO - blessings == 1.6 04:31:28 INFO - blobuploader == 1.2.4 04:31:28 INFO - docopt == 0.6.1 04:31:28 INFO - manifestparser == 1.1 04:31:28 INFO - mozInstall == 1.12 04:31:28 INFO - mozcrash == 0.17 04:31:28 INFO - mozdebug == 0.1 04:31:28 INFO - mozdevice == 0.48 04:31:28 INFO - mozfile == 1.2 04:31:28 INFO - mozhttpd == 0.7 04:31:28 INFO - mozinfo == 0.9 04:31:28 INFO - mozleak == 0.1 04:31:28 INFO - mozlog == 3.1 04:31:28 INFO - moznetwork == 0.27 04:31:28 INFO - mozprocess == 0.22 04:31:28 INFO - mozprofile == 0.28 04:31:28 INFO - mozrunner == 6.11 04:31:28 INFO - mozscreenshot == 0.1 04:31:28 INFO - mozsystemmonitor == 0.0 04:31:28 INFO - moztest == 0.7 04:31:28 INFO - mozversion == 1.4 04:31:28 INFO - psutil == 3.1.1 04:31:28 INFO - requests == 1.2.3 04:31:28 INFO - wsgiref == 0.1.2 04:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:28 INFO - Using env: {'DISPLAY': ':0', 04:31:28 INFO - 'HOME': '/home/cltbld', 04:31:28 INFO - 'LANG': 'en_US.UTF-8', 04:31:28 INFO - 'LANGUAGE': 'en_US:en', 04:31:28 INFO - 'LOGNAME': 'cltbld', 04:31:28 INFO - 'MAIL': '/var/mail/cltbld', 04:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:28 INFO - 'MOZ_NO_REMOTE': '1', 04:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:28 INFO - 'NO_EM_RESTART': '1', 04:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:28 INFO - 'PWD': '/builds/slave/test', 04:31:28 INFO - 'SHELL': '/bin/bash', 04:31:28 INFO - 'SHLVL': '1', 04:31:28 INFO - 'TERM': 'linux', 04:31:28 INFO - 'TMOUT': '86400', 04:31:28 INFO - 'USER': 'cltbld', 04:31:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:28 INFO - '_': '/tools/buildbot/bin/python'} 04:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:28 INFO - Cleaning up... 04:31:28 INFO - Return code: 0 04:31:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:28 INFO - Using env: {'DISPLAY': ':0', 04:31:28 INFO - 'HOME': '/home/cltbld', 04:31:28 INFO - 'LANG': 'en_US.UTF-8', 04:31:28 INFO - 'LANGUAGE': 'en_US:en', 04:31:28 INFO - 'LOGNAME': 'cltbld', 04:31:28 INFO - 'MAIL': '/var/mail/cltbld', 04:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:28 INFO - 'MOZ_NO_REMOTE': '1', 04:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:28 INFO - 'NO_EM_RESTART': '1', 04:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:28 INFO - 'PWD': '/builds/slave/test', 04:31:28 INFO - 'SHELL': '/bin/bash', 04:31:28 INFO - 'SHLVL': '1', 04:31:28 INFO - 'TERM': 'linux', 04:31:28 INFO - 'TMOUT': '86400', 04:31:28 INFO - 'USER': 'cltbld', 04:31:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:28 INFO - '_': '/tools/buildbot/bin/python'} 04:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:28 INFO - Downloading/unpacking jsonschema 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:30 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:30 INFO - warning: no files found matching '*.txt' 04:31:30 INFO - no previously-included directories found matching 'build' 04:31:30 INFO - no previously-included directories found matching 'dist' 04:31:30 INFO - no previously-included directories found matching '.git*' 04:31:30 INFO - Installing collected packages: jsonschema, functools32 04:31:30 INFO - Running setup.py install for functools32 04:31:31 INFO - warning: no files found matching '*.txt' 04:31:31 INFO - no previously-included directories found matching 'build' 04:31:31 INFO - no previously-included directories found matching 'dist' 04:31:31 INFO - no previously-included directories found matching '.git*' 04:31:31 INFO - Successfully installed jsonschema functools32 04:31:31 INFO - Cleaning up... 04:31:31 INFO - Return code: 0 04:31:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 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 0x7f357c0f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Downloading/unpacking flake8 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:33 INFO - no previously-included directories found matching 'docs/_build' 04:31:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:34 INFO - Running setup.py install for pep8 04:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:34 INFO - no previously-included directories found matching 'docs/_build' 04:31:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:34 INFO - Cleaning up... 04:31:34 INFO - Return code: 0 04:31:34 INFO - Running post-action listener: _resource_record_post_action 04:31:34 INFO - Running post-action listener: _start_resource_monitoring 04:31:34 INFO - Starting resource monitoring. 04:31:34 INFO - ##### 04:31:34 INFO - ##### Running install step. 04:31:34 INFO - ##### 04:31:34 INFO - Running pre-action listener: _resource_record_pre_action 04:31:34 INFO - Running main action method: install 04:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:34 INFO - Reading from file tmpfile_stdout 04:31:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:34 INFO - Reading from file tmpfile_stdout 04:31:34 INFO - Output received: 04:31:34 INFO - Usage: mozinstall [options] installer 04:31:34 INFO - Options: 04:31:34 INFO - -h, --help show this help message and exit 04:31:34 INFO - -d DEST, --destination=DEST 04:31:34 INFO - Directory to install application into. [default: 04:31:34 INFO - "/builds/slave/test"] 04:31:34 INFO - --app=APP Application being installed. [default: firefox] 04:31:34 INFO - mkdir: /builds/slave/test/build/application 04:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Output received: 04:31:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:51 INFO - Running post-action listener: _resource_record_post_action 04:31:51 INFO - ##### 04:31:51 INFO - ##### Running run-tests step. 04:31:51 INFO - ##### 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: run_tests 04:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:51 INFO - Python 2.7.3 04:31:51 INFO - Return code: 0 04:31:51 INFO - grabbing minidump binary from tooltool 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:51 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 0x1f53410>, '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 0x1f54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f547a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:31:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:31:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:51 INFO - Return code: 0 04:31:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:52 INFO - Return code: 0 04:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:31:52 INFO - Using env: {'DISPLAY': ':0', 04:31:52 INFO - 'HOME': '/home/cltbld', 04:31:52 INFO - 'LANG': 'en_US.UTF-8', 04:31:52 INFO - 'LANGUAGE': 'en_US:en', 04:31:52 INFO - 'LOGNAME': 'cltbld', 04:31:52 INFO - 'MAIL': '/var/mail/cltbld', 04:31:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:52 INFO - 'MOZ_NO_REMOTE': '1', 04:31:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:52 INFO - 'NO_EM_RESTART': '1', 04:31:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:52 INFO - 'PWD': '/builds/slave/test', 04:31:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:52 INFO - 'SHELL': '/bin/bash', 04:31:52 INFO - 'SHLVL': '1', 04:31:52 INFO - 'TERM': 'linux', 04:31:52 INFO - 'TMOUT': '86400', 04:31:52 INFO - 'USER': 'cltbld', 04:31:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086', 04:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:52 INFO - '_': '/tools/buildbot/bin/python'} 04:31:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:31:52 INFO - mozversion application_buildid: 20160426013139 04:31:52 INFO - mozversion application_changeset: 5b7777972750aa3c57e6f6f6d4e4621072741617 04:31:52 INFO - mozversion application_display_name: Nightly 04:31:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:52 INFO - mozversion application_name: Firefox 04:31:52 INFO - mozversion application_remotingname: firefox 04:31:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:31:52 INFO - mozversion application_vendor: Mozilla 04:31:52 INFO - mozversion application_version: 49.0a1 04:31:52 INFO - mozversion platform_buildid: 20160426013139 04:31:52 INFO - mozversion platform_changeset: 5b7777972750aa3c57e6f6f6d4e4621072741617 04:31:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:31:52 INFO - mozversion platform_version: 49.0a1 04:31:52 INFO - using testdate: 1461670312 04:31:52 INFO - actual date: 1461670312 04:31:52 INFO - starting webserver on 'localhost:52011' 04:31:52 INFO - SUITE-START | Running 2 tests 04:31:52 INFO - TEST-START | dromaeo_css 04:31:52 INFO - operating with platform_type : linux_ 04:31:52 INFO - Initialising browser for dromaeo_css test... 04:31:52 INFO - TEST-INFO | started process 27288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphs2tfi/profile http://localhost:52011/getInfo.html) 04:31:55 INFO - PROCESS | 27288 | 04:31:55 INFO - PROCESS | 27288 | (process:27357): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:56 INFO - PROCESS | 27288 | __metrics Screen width/height:1600/1200 04:31:56 INFO - PROCESS | 27288 | colorDepth:24 04:31:56 INFO - PROCESS | 27288 | Browser inner width/height: 1024/697 04:31:56 INFO - PROCESS | 27288 | __metrics 04:31:56 ERROR - PROCESS | 27288 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:31:57 INFO - TEST-INFO | 27288: exit 0 04:31:57 INFO - Browser initialized. 04:31:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:57 INFO - TEST-INFO | started process 27408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphs2tfi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:59 INFO - PROCESS | 27408 | 04:31:59 INFO - PROCESS | 27408 | (process:27468): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:09 INFO - PROCESS | 27408 | RSS: Main: 164851712 04:32:09 INFO - PROCESS | 27408 | 04:32:59 INFO - PROCESS | 27408 | 1461670379067 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:06 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52011/tests/dromaeo/cssquery-ext.html) 04:35:07 INFO - PROCESS | 27408 | RSS: Main: 169517056 04:35:07 INFO - PROCESS | 27408 | 04:38:09 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-ext.html (next: http://localhost:52011/tests/dromaeo/cssquery-jquery.html) 04:38:10 INFO - PROCESS | 27408 | RSS: Main: 168513536 04:38:10 INFO - PROCESS | 27408 | 04:41:11 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52011/tests/dromaeo/cssquery-mootools.html) 04:41:12 INFO - PROCESS | 27408 | RSS: Main: 167714816 04:41:12 INFO - PROCESS | 27408 | 04:44:14 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52011/tests/dromaeo/cssquery-prototype.html) 04:44:14 INFO - PROCESS | 27408 | RSS: Main: 165535744 04:44:14 INFO - PROCESS | 27408 | 04:47:17 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52011/tests/dromaeo/cssquery-yui.html) 04:47:17 INFO - PROCESS | 27408 | RSS: Main: 166666240 04:47:17 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-yui.html (next: http://localhost:52011/tests/dromaeo/cssquery-dojo.html) 04:50:20 INFO - PROCESS | 27408 | RSS: Main: 168480768 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | __start_tp_report 04:50:20 INFO - PROCESS | 27408 | _x_x_mozilla_page_load 04:50:20 INFO - PROCESS | 27408 | _x_x_mozilla_page_load_details 04:50:20 INFO - PROCESS | 27408 | |i|pagename|runs| 04:50:20 INFO - PROCESS | 27408 | |0;dojo.html;3102.9689703102968;3143.827089510077;3155;3188.76084293678;3191.8084914905094;5239.187925871486;5248;5259.710715910633;5283.154695248766;5336.332958380202;5212.400573933999;5274.683518988863;5289.047971365153;5309.707966061865;5431.565474762019;4856.4900685427965;4879.072976134541;4915.434725006617;4960;5004.949950500485;771.9453841208654;4793.856184314476;4928.088303663816;4939.382577177853;4967.428745694256;4892.290617860426;4893.657443978923;4916.655834091615;4921.040397122545;4961.131801934647;4787.281907713836;4922.114019476493;4978.128827455217;4979.8008079676765;5029.119904016819;4775.5463230993;4796.544328288807;4805.423349198084;4830.033993201374;4879.707217566957;5140.331756871583;5151.072806894757;5182.974085129588;5183.974080129613;5252.212168174766;5582.720863956826;5596.0206963781175;5613.4386561343945;5630.634008789416;5679.801206957736;5694.2312787773535;5695.515881150107;5700.230468886689;5720.456556627114;5722.54219662426;5247.790088396459;5295.0468915595175;5304.761285742151;5310.070737620901;5366.382865970385;5652.63257888236;5821.970890145522;5835.299764028344;5903.3801450847905;5905.202797622352;5602;5632.352279487829;5635.0702134147405;5644.8871022579315;5651.2935883014625;5687.459691329317;5708.229389032511;5712.714364281769;5719.4852463277675;5737.168110623936;5603.915941260884;5650.3219613646625;5688.345840228344;5700.287464066992;5702.45826646468;5541.806036788693;5603.327600687862;5612.382637909826;5614.9719251403485;5625.240592519957;4272.380504826845;4273.508546517128;4311.288637374798;4319.963208829859;4344.695871288979;3784.924301513954;3896.493455850721;3918.1380096378753;3924.5290565131795;3951.3480275754755;5381.3811411687375;5445.319335083114;5447.700376479332;5482.862928426821;5494.340679118452;5637.46444087811;5666.4900158985065;5722.113072473773;5727.39862314451;5730.455606717439;5340.305760251143;5414.269073675082;5433.918491222635;5443.101888188405;5516.117421212587;4750;4756.809727610926;4786.401699787527;4806.327114204014;4821.421429428421;5761.5102716269585;5772.5670574707065;5781.219535362757;5789.594728368974;5789.8263052108505;5628.465295796893;5640.887182256414;5668.26312579362;5701.458361455655;5712.37163911961;5843;5856.238688970407;5859.414058594107;5867.20792692981;5919.644821310735;5574.804881829116;5586.329640443173;5599.356074051536;5601.495865372136;5607.943920560742;5540.695261760642;5625.578081643811;5689.573282003949;5702.6863522506665;5736.082226843685;5484.808031718871;5489.176623506506;5497.505224529811;5499.477549632778;5564.276644036249;5452.863678408072;5463.235147079333;5472.671639701631;5475.890482190413;5495.368032676293;5383.08487557124;5396.379416367168;5470.8905821882545;5547.251121098761;5597.272354593877;5489.1217405214975;5501.614886958035;5511.255980442589;5574.303212098488;5586.636868603528;5447.455254474521;5487.945120548903;5553.16702494629;5587.944120558743;5601.747921343468 04:50:20 INFO - PROCESS | 27408 | |1;ext.html;573.1574585359523;637.2034956304618;647.245958458396;651.8826611209984;681.529744476311;35365.82317088414;36888.26223475529;36929.44605830915;36951.26097478049;37042.07394815124;35699.64300356996;36434.27131457369;36479.45280820783;36490.817545912236;36516.26967460649;8385.916140838604;8435.746927592152;8517.616707248158;8561.0582835888;8562.871556926651;8328.625211865481;8555.614997325105;8623.913760862373;8634.438761480484;8648.264897483721;8729.214370706635;8766.912330876674;8793.472391656489;8808.471491710518;8817;8602.569871506432;8642.351823613255;8705.216530512283;8712.172343627346;8714.302855771522;8646.697365592174;8748.30013598917;8791.252743516745;8793.824123517494;8805.779855503664;28406.431871362456;36870;37400.25199496022;37484.81257593722;37490;3266.4447044002577;3303.8477011637156;3343.765936384454;3420.1791570023265;3530.011596752913;28591.714082859115;29003.564946525818;29269.414611707645;29422.558661620093;29585.408291834257;4036.253293140778;4049.4533238012787;4090.2228576570355;4164;4177.937330940038;219970;221798.4550386237;222657;222775;224027;33422.33155336879;33593.496097558556;33745.83127084349;33810.661893380755;34109.31781364359;34854.12864678403;34910.301793964485;53299.467005330225;55248.447515525135;55270;15105.848941510445;15293.15887626169;15300.311485983157;15312.617184570476;15318.387264509518;11704.531818727155;11757.353345565905;11761.470733817;11775.646730598095;11781.823272650918;17834.5541361467;17845;17880.374186903657;17956.730649040273;18002.819971800378;6947.24113981924;6995.230524642286;7165.319294666998;7216.025836512109;7261.38278246355;1046;1058.3755584205355;1142.657202839145;1173.4836671864352;1185.1230089733535;26312.342191444983;26605;26867.596986045224;26940.32649183786;27102.051428199917;1155.133649762678;1160.3849959521467;1163.598558497317;1200.9639710808515;1241.8385609870659;14718.779218311734;14850.331735071948;14949.327280272413;15082.321295541728;15231.314590843438;361513;371118;371623;371823;372615;52068;53812.461875380744;54012.18981715277;54065.459345406045;54108.917821644136;1398.9160650361011;1426.1158081989233;1435.5191011011427;1436.7629341158802;1442.0698649371307;28701.85649071741;29194.854025729735;29287.414251715272;29560.260993475335;29573.852130739207;46575.06849863051;46594.76702616465;46790.532094678616;46937;47009.52990470052;295741;300050;300858;300937;300979;26711.465770684088;27203.59194612122;27307;27334.5899811499;27669.58495622527;43611.56388436075;44343.556564433944;44456.33315500335;44731;45584.54415455803;37820;38060.619393805704;38095.428568572046;39205.41191882181;39267.018324542114;37172.44241336328;37823;38296.2340753189;38638.2272354557;38771.6122838768;30997.535036974914;35705.81198532725;35769.642303576635;38705.225895482494;39070.21859562736;30475.390492190476;31885.20286992751;32112.197195070312;33696.83151584226;34249.31501369909;27102.864485677444;27188.728112718618;27260.591091134047;27406.5889011661;27433.725662743916 04:50:20 INFO - PROCESS | 27408 | |2;jquery.html;390.114440220699;399.4667119395607;399.55050568110875;400.43738547340996;409.2429006338273;13690.52083177089;16752.91623541882;16872.156392180405;17485.388011419604;17582.56043598909;16808.831911680878;17185.312587496486;17323.82676173238;17326.82673173268;17676;5470.617056806035;5518.724063796814;5525.226468294442;5638.830835074954;5658.773649054033;5508.724563771815;5546.417626149257;5551.694656793875;5574.470425309589;5595.7481913313995;5311.814086506973;5480.068388373986;5515.227868098469;5542.307211598551;5553.055980483307;5482.39693633702;5503.11950087988;5526.253955715967;5551.278333816598;5572.3870374258795;4756.500567440438;4854.2233242681;4975.328330675385;5010.574101201402;5019.447860735316;20220.292289769935;20767.480812979644;20853.478663033395;21180;21184;2407.8916448759674;2433.270018994295;2433.549793288247;2476.6780318558654;2505.7243703192635;13618.455261789517;13654.317284135754;13711.794323085162;13756.724865502634;13769.31153442324;1928.797476264986;2012.6377252094617;2022.9898850505801;2031.1266155553105;2091.874487530753;67155.3284467154;67512.3248767511;67904.6604766978;68057;68315.97526037114;10056.748581285527;10114.089731924161;10337.483125843677;10427.94786026065;10481.475926203659;12489.437975291134;13075.084744067824;14326.283685815668;14364.640883977983;14369.78445323321;7318.817029574303;7350.916005866372;7733;7894.644740986554;8091.39314551411;7494.962525187339;7534.434917381218;7556.206598307209;7605.505642133244;7709.6530656119485;6116;6534.4445722113205;6546.414166404339;6571.901421478682;6620.271770105284;1883.387898932825;1944.3680803738841;1955.6479833630083;1973.9309124180584;1974.496503391626;958.6021800952526;1091.8908109189176;1120.1822669451183;1125.729824842032;1126.718320419895;17069.146542672817;17522.649547008987;17568;17896.194671239824;18217.45347639573;1055.456439933435;1065.1106326217541;1073.5222825842425;1126.3354620773782;1145.7422080032093;10285.691429257135;10616.203784716177;10680.62617808373;10709.839352409721;10886;455040;469741;489616;497929;500176;66996.33003669999;67122.66438667776;68401.65799171072;69054.65472672605;69562.65218673975;1042.3641578637025;1057.1278695076592;1065.4992153687754;1067.1569460126414;1074.1514203779084;16094.436694715629;16132.435364762177;16164.676706465569;16175.110368929822;16346.346146154021;28429.573556397085;33424;33521;35278.94163175109;35787.28425431425;43036;43045.3543196846;43265.3510197341;43904.56095439005;45019.84861059694;8215.958920205361;8236.299914507334;8465.195806398382;8587.398882078194;8695.608697608497;12677.55628553033;12724.618261452171;12806.039547033823;12826.294553799631;13092.80360794608;11298.661040168809;11641.88358116408;11708.180427370002;11742;11890.821637675268;11247.887521124683;11300;11327.830082548933;11346.205765596329;11377.715557111138;11649.941750291195;11694.122940779305;11870.347130907538;11966.64100076999;12038.578649747216;7483.214262502576;7601.467897247139;8356.665733370597;8702.956485217534;8767.824643506967;10699.572017119228;11187.888121119011;11231.66305010851;11302.830457543309;11377.54489820398 04:50:20 INFO - PROCESS | 27408 | |3;mootools.html;1518.6507103366225;1528.1747856157672;1693.187270110347;1807.35838777234;1810.7464954906307;7159.928400715991;7787.844243115142;8050.4364694471415;8074.031116266049;8160.510369377842;8109.310708589762;8124.756257312275;8128.105908350091;8220.588970551478;8236.794080148;2200.6698995150737;2247.0786977339294;2247.1910112359537;2248.685184074223;2255.7180352455944;2198.835087368446;2203.03066650674;2237.9328620141423;2239.32820153954;2241.1595651630637;2214.0700905619597;2235.2958817972367;2255.154317131076;2257.954840903181;2261.954760904781;2167.8590891592;2168.186929901287;2172.261431113421;2179.9346019619516;2183.192218879025;2167.9566408671894;2170.121100954116;2170.2078741259324;2172.73927128744;2173.8695678259355;8280.917190828075;8306.460080094836;8311.002679678417;8338.583070846495;8343.207395297437;4853.296272040534;5112.974435127838;5114.872128196787;5124.205748109049;5138.665986710852;3061.5713800068006;3151.434236352569;3277.2462333663393;3309.834508274577;3312.6190488093935;1092.546593163836;1093.2729734726397;1099.060303440555;1103.6799328194813;1124.876263611002;11337.489812958354;11485.885141148648;11487.540498380054;11489.712757181138;11599.768004639944;4342.761148136819;4475;4489.551044895549;4536.56902594253;4543;9633.133018028411;9666.178374838077;9680.75798105053;9683.273754468442;9746.220302375934;5029.119904016782;5047.798088076509;5075.644704870623;5091.694498330112;5092.363454568179;4192.937105943413;4497.955020449819;4562.1560011398;4568.360429539867;4678.7660616969015;3763.473113764075;3811.676007539335;3892.630200130983;3902.239063382613;3919.1377896862646;1240.4108048676987;1252.661781319057;1276.8850803427736;1312.140547941081;1319.0898280186832;935.373299889076;978.4618459847198;987.2595553334999;1002.9348092373972;1007.1036777268237;5589.776408943678;5702.971485142631;5732.656040637575;5738.282714660668;5819.272590926134;1055.9630412935664;1066.461436974323;1079.6545105566302;1080.2924084724518;1090.54197237159;3764.3036038333;3885.7279990400966;3934.7835869027476;3943.8028098594955;3959.7228194026716;9885.604575817031;10111.544980475895;10156.187504999582;10162.949185254174;10217.13154381871;9614.95192524033;10041.849372259421;10042.49787510636;10098.697039088838;10110.837253715918;7603.201663825219;7697.923020769833;7759;7786.104597971193;7816.179301173295;5623.690697011703;5630.85922851932;5703.258576385043;5833.329167145833;5897.085951677325;9062.63749450041;9216;9341.34610577253;9346.11211934865;9468.14786669203;9428.717138485856;9838.409695418297;9882.160016398686;10014.849777253492;10030.949845250727;6842.623655698785;7067.5052746307265;7347.632618369167;7492.662830172546;7628.466007379652;7348.559086454829;7384.187739348775;7390.9260907390235;7397.4082073435075;7454.739084132029;7147.356737893615;7318.96340518294;7338.119425668954;7404.777856664308;7473.028506294364;7222.9277707224355;7240.855182896418;7293.270672932877;7383.852322953619;7406.814829629302;6430.1319321892815;6503.317151699003;6559.508036897157;6571.868562628625;6574.04676321921;4724.1732696777235;4827.010462855036;4829.299751536078;4856.975715121402;5044.949550504448;4881.29221262922;4899.216125419915;4903.975480122576;4939.555440010273;4976.527229913152 04:50:20 INFO - PROCESS | 27408 | |4;prototype.html;317.6378928022055;320.29854618385735;326.6048081820996;329.03756512201807;329.33638717983285;5491.835244942653;5505.972470137649;5600.831975040755;5638.520725738312;5641.153826925964;5506.513241424813;5522.144067669507;5531.2532808071;5534.861628459291;5537.861553461155;4081.102157525347;4105.9178816423655;4268.253055715253;4273.230818452677;4284.186004659105;4251.277282861905;4251.4898212214575;4254.638355739766;4264.402983582301;4283.293256612671;4218.767967761772;4229.604230603909;4232.428622136018;4237.576242375769;4260.510041345238;3960.188161426915;4162.687798415131;4193.706440549163;4213.599708027732;4271.145770845843;3636.654517820803;3645.872394466181;3661.8535258589623;3666.046827824785;3684.9631503684886;5330.92003619946;5343.973280133574;5347.887584404139;5368.194770784375;5379.542738867201;4587.541245875419;4836.395450568679;4848.927266090976;4862.735688720958;4888.217885138396;5637.971810140964;5743.282089738783;5760.769569217268;5769.855753606152;5775;4005.0988527581353;4021.5978402159844;4025.9798701006603;4026.2148880968225;4028.6302657096726;5895.322037965603;5907.6160049597065;5986.161937328778;6041.818745437644;6059.45464908156;4069.9446779376226;4070.61329173728;4104;4114.814833332507;4128.690348223895;4147.294959856831;4149.9832541027645;4168.645665118499;4184.100418410057;4188.581141885848;4657.720536767804;4785.736784476887;4787.529041444925;4808.990112076433;4819.927701084486;5681.687507187145;5753.050746626844;5818.77805660816;5829.271341082364;5830.737616807254;1469.4122351059448;1473.977890331646;1484.3765618440282;1488.679933814235;1506.058713304185;949.126803340928;961.3654987708079;1004.8944860789512;1010.4897027001317;1024.416082832778;5898.233229680114;5940.910886336708;5959.702014899238;5964.135200395918;5971.880562388815;6280.340564240781;6301.180846489927;6328.373724904205;6338.397852204033;6344.619322840645;5811.854703632443;5914.260717410324;5980.55145864062;6019.939800602026;6024.1566180734735;3340.599128104643;3385.712214461749;3411.829408529564;3412.522246885438;3417.470292104728;5986.2217911671205;6243.313235544087;6263.154474145932;6548.803535893836;6559.8032059038305;6140.478059365004;6192.721327540272;6195.729875375538;6210.161628180138;6222.844428889223;6116.544152553793;6205.03821907605;6217.626942383562;6246.906296405557;6267;6056.848578785565;6059.454649081427;6059.454649081604;6075.422834830684;6075.513958883191;5908.5568582357355;5996.730147143302;6010.87978240424;6017.247844019497;6063.696815159313;6149.631022138686;6173.197484327009;6275.780347687809;6283.214598175228;6284.24589049317;4143.81352839117;4160.1679664067915;4209.17921005401;4226.5773422657485;4240.321548552217;5787.508061814625;6082.225453019359;6112.746886888266;6115.1438798569125;6128.816135515942;5785.508231800344;5823.854403639773;5850.210221620197;5875.441833026027;5926.762929482772;5859.589828711949;5890.558208134493;5899.4985426239255;5910.497607703393;5947.553933454921;5595.63628364155;5749.942500575108;5803.709814509173;5809.76760929575;5817.505512031525;5970.58205925581;5975.40245975399;5979.551533634908;5986.640801551921;5988.940110598838;5463.262459568066;5786.942130578809;5791.739371728198;5832.62087964281;5850.063989761617 04:50:20 INFO - PROCESS | 27408 | |5;yui.html;784.4704824243635;823.1398188892603;829.3779665251062;850.8638617821142;870.0603348383744;13643.522476713317;13645.590632281022;13751;13827.446902123915;14044;12671.873281267184;12702.110852240325;12726.36368181592;12745.553905613306;12763.744725105516;760.6767123972318;819.7049062337554;823.5923218007094;824.7773101262655;826.3802148388709;827.8634025385804;828.056016141599;829.8464784014947;830.1822704635929;836.297510091523;863.8531449653542;864.6109250837148;864.8010957479784;865.6883521932131;867.8611422172454;855.5893171277821;859.4113032572708;862.3144600042981;863.5380071661663;866.6620018192909;624.6064979063161;624.9875202172465;625.2746813696091;626.5488848029412;627.2504357293037;13886.305684715824;13951.860481395259;13981.161130332111;13993.16041037541;14134.293285335692;13058.216507009514;13109.868901311056;13409;13409.329533523285;13431.261280629562;11172.162087843444;11190.272632278877;11376.715582110432;11448.370339631318;11457.770844583061;3760.774353538769;3773.754705944132;3810.161764411853;3825.101101241206;3878.5927477614728;46776;47479.52520474786;47765.761171193924;47845.52154478445;47878.28182577264;10839.83740243897;10850;10882.075023623082;10962.671119866416;11208.439578021067;18171;19440.416787496397;19445.22219111248;19447.61104777925;19483.415497535098;8281.917180828235;8313.12712165214;8329.208725171098;8400.369972251983;8572.314214862796;4686.625069994392;4704.529547045268;4725.196716558194;4809.759512024385;4914.483979182206;3295.2750394913082;3411.982940085333;3414.5048967899515;3420.486926960976;3424.3493736190044;627.883841489326;631.1952260867339;634.9587276826992;642.3768944124192;648.0538413915735;713.0908092182509;748.27043632459;760.6919197724931;763.2253262938123;787.6849260295813;8640.783980400414;9161;9264.583093760797;9325.440473571607;9349.859752103725;636.2206297285788;767.6929228308721;769.4498433619989;780.2782426255691;785.3991696352296;4413.911721765547;4441.933370999438;4479.148961697267;4485.9220511601625;4558.997020655451;61072.38927610667;65657;66416;66433;66519.33480665131;57747.13379299314;57913;58701.70649146727;58749;60587.69706151441;51965.70085747811;52536;52544.847309161574;53229.73385133049;53794.46205537973;8477.194666506672;8611.65553377858;8644.265237454887;8745.693900713444;8857.468551886908;34319.656803431644;34424.82787586046;34787;34929.47605785864;35390.46914296236;44881.32678009767;47936.5206347932;48007;48158.277625836345;49117.75441122914;11417.31496110236;11423.257488263236;11599;11614.535418583162;11874.109441791727;12147.635570932885;12838.16551924122;13244.933775331061;13359.933200333937;13409.66475838112;12476.812847807472;12769.808452873029;12786.168899021533;12866.485340586272;13045;12247.203931744409;12381.380930953597;12486.937565312115;12693.8095928563;12744.61766147017;12161.513539458323;12717.8092328617;12789.680257993625;12874.227546347249;12945.611631651065;11072;11199.888001119885;11378.772424551627;11427.200095993201;11536.538538458368;10931.508082136164;11278.887211127783;11403.771924561297;11575.536978521102;11615.012723918562 04:50:20 INFO - PROCESS | 27408 | __end_tp_report 04:50:20 INFO - PROCESS | 27408 | __start_cc_report 04:50:20 INFO - PROCESS | 27408 | _x_x_mozilla_cycle_collect,346 04:50:20 INFO - PROCESS | 27408 | __end_cc_report 04:50:20 INFO - PROCESS | 27408 | __startTimestamp1461671420277__endTimestamp 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | ------- Summary: start ------- 04:50:20 INFO - PROCESS | 27408 | Number of tests: 6 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#0] dojo.html Cycles:165 Average:5252.14 Median:5489.12 stddev:677.97 (12.4%) stddev-sans-first:658.75 04:50:20 INFO - PROCESS | 27408 | Values: 3103.0 3143.8 3155.0 3188.8 3191.8 5239.2 5248.0 5259.7 5283.2 5336.3 5212.4 5274.7 5289.0 5309.7 5431.6 4856.5 4879.1 4915.4 4960.0 5004.9 771.9 4793.9 4928.1 4939.4 4967.4 4892.3 4893.7 4916.7 4921.0 4961.1 4787.3 4922.1 4978.1 4979.8 5029.1 4775.5 4796.5 4805.4 4830.0 4879.7 5140.3 5151.1 5183.0 5184.0 5252.2 5582.7 5596.0 5613.4 5630.6 5679.8 5694.2 5695.5 5700.2 5720.5 5722.5 5247.8 5295.0 5304.8 5310.1 5366.4 5652.6 5822.0 5835.3 5903.4 5905.2 5602.0 5632.4 5635.1 5644.9 5651.3 5687.5 5708.2 5712.7 5719.5 5737.2 5603.9 5650.3 5688.3 5700.3 5702.5 5541.8 5603.3 5612.4 5615.0 5625.2 4272.4 4273.5 4311.3 4320.0 4344.7 3784.9 3896.5 3918.1 3924.5 3951.3 5381.4 5445.3 5447.7 5482.9 5494.3 5637.5 5666.5 5722.1 5727.4 5730.5 5340.3 5414.3 5433.9 5443.1 5516.1 4750.0 4756.8 4786.4 4806.3 4821.4 5761.5 5772.6 5781.2 5789.6 5789.8 5628.5 5640.9 5668.3 5701.5 5712.4 5843.0 5856.2 5859.4 5867.2 5919.6 5574.8 5586.3 5599.4 5601.5 5607.9 5540.7 5625.6 5689.6 5702.7 5736.1 5484.8 5489.2 5497.5 5499.5 5564.3 5452.9 5463.2 5472.7 5475.9 5495.4 5383.1 5396.4 5470.9 5547.3 5597.3 5489.1 5501.6 5511.3 5574.3 5586.6 5447.5 5487.9 5553.2 5587.9 5601.7 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#1] ext.html Cycles:180 Average:45349.84 Median:35702.73 stddev:79611.38 (223.0%) stddev-sans-first:79763.73 04:50:20 INFO - PROCESS | 27408 | Values: 573.2 637.2 647.2 651.9 681.5 35365.8 36888.3 36929.4 36951.3 37042.1 35699.6 36434.3 36479.5 36490.8 36516.3 8385.9 8435.7 8517.6 8561.1 8562.9 8328.6 8555.6 8623.9 8634.4 8648.3 8729.2 8766.9 8793.5 8808.5 8817.0 8602.6 8642.4 8705.2 8712.2 8714.3 8646.7 8748.3 8791.3 8793.8 8805.8 28406.4 36870.0 37400.3 37484.8 37490.0 3266.4 3303.8 3343.8 3420.2 3530.0 28591.7 29003.6 29269.4 29422.6 29585.4 4036.3 4049.5 4090.2 4164.0 4177.9 219970.0 221798.5 222657.0 222775.0 224027.0 33422.3 33593.5 33745.8 33810.7 34109.3 34854.1 34910.3 53299.5 55248.4 55270.0 15105.8 15293.2 15300.3 15312.6 15318.4 11704.5 11757.4 11761.5 11775.6 11781.8 17834.6 17845.0 17880.4 17956.7 18002.8 6947.2 6995.2 7165.3 7216.0 7261.4 1046.0 1058.4 1142.7 1173.5 1185.1 26312.3 26605.0 26867.6 26940.3 27102.1 1155.1 1160.4 1163.6 1201.0 1241.8 14718.8 14850.3 14949.3 15082.3 15231.3 361513.0 371118.0 371623.0 371823.0 372615.0 52068.0 53812.5 54012.2 54065.5 54108.9 1398.9 1426.1 1435.5 1436.8 1442.1 28701.9 29194.9 29287.4 29560.3 29573.9 46575.1 46594.8 46790.5 46937.0 47009.5 295741.0 300050.0 300858.0 300937.0 300979.0 26711.5 27203.6 27307.0 27334.6 27669.6 43611.6 44343.6 44456.3 44731.0 45584.5 37820.0 38060.6 38095.4 39205.4 39267.0 37172.4 37823.0 38296.2 38638.2 38771.6 30997.5 35705.8 35769.6 38705.2 39070.2 30475.4 31885.2 32112.2 33696.8 34249.3 27102.9 27188.7 27260.6 27406.6 27433.7 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#2] jquery.html Cycles:180 Average:26846.99 Median:11472.68 stddev:78882.87 (687.6%) stddev-sans-first:79079.14 04:50:20 INFO - PROCESS | 27408 | Values: 390.1 399.5 399.6 400.4 409.2 13690.5 16752.9 16872.2 17485.4 17582.6 16808.8 17185.3 17323.8 17326.8 17676.0 5470.6 5518.7 5525.2 5638.8 5658.8 5508.7 5546.4 5551.7 5574.5 5595.7 5311.8 5480.1 5515.2 5542.3 5553.1 5482.4 5503.1 5526.3 5551.3 5572.4 4756.5 4854.2 4975.3 5010.6 5019.4 20220.3 20767.5 20853.5 21180.0 21184.0 2407.9 2433.3 2433.5 2476.7 2505.7 13618.5 13654.3 13711.8 13756.7 13769.3 1928.8 2012.6 2023.0 2031.1 2091.9 67155.3 67512.3 67904.7 68057.0 68316.0 10056.7 10114.1 10337.5 10427.9 10481.5 12489.4 13075.1 14326.3 14364.6 14369.8 7318.8 7350.9 7733.0 7894.6 8091.4 7495.0 7534.4 7556.2 7605.5 7709.7 6116.0 6534.4 6546.4 6571.9 6620.3 1883.4 1944.4 1955.6 1973.9 1974.5 958.6 1091.9 1120.2 1125.7 1126.7 17069.1 17522.6 17568.0 17896.2 18217.5 1055.5 1065.1 1073.5 1126.3 1145.7 10285.7 10616.2 10680.6 10709.8 10886.0 455040.0 469741.0 489616.0 497929.0 500176.0 66996.3 67122.7 68401.7 69054.7 69562.7 1042.4 1057.1 1065.5 1067.2 1074.2 16094.4 16132.4 16164.7 16175.1 16346.3 28429.6 33424.0 33521.0 35278.9 35787.3 43036.0 43045.4 43265.4 43904.6 45019.8 8216.0 8236.3 8465.2 8587.4 8695.6 12677.6 12724.6 12806.0 12826.3 13092.8 11298.7 11641.9 11708.2 11742.0 11890.8 11247.9 11300.0 11327.8 11346.2 11377.7 11649.9 11694.1 11870.3 11966.6 12038.6 7483.2 7601.5 8356.7 8703.0 8767.8 10699.6 11187.9 11231.7 11302.8 11377.5 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#3] mootools.html Cycles:180 Average:5465.77 Median:4855.14 stddev:3025.70 (62.3%) stddev-sans-first:3019.65 04:50:20 INFO - PROCESS | 27408 | Values: 1518.7 1528.2 1693.2 1807.4 1810.7 7159.9 7787.8 8050.4 8074.0 8160.5 8109.3 8124.8 8128.1 8220.6 8236.8 2200.7 2247.1 2247.2 2248.7 2255.7 2198.8 2203.0 2237.9 2239.3 2241.2 2214.1 2235.3 2255.2 2258.0 2262.0 2167.9 2168.2 2172.3 2179.9 2183.2 2168.0 2170.1 2170.2 2172.7 2173.9 8280.9 8306.5 8311.0 8338.6 8343.2 4853.3 5113.0 5114.9 5124.2 5138.7 3061.6 3151.4 3277.2 3309.8 3312.6 1092.5 1093.3 1099.1 1103.7 1124.9 11337.5 11485.9 11487.5 11489.7 11599.8 4342.8 4475.0 4489.6 4536.6 4543.0 9633.1 9666.2 9680.8 9683.3 9746.2 5029.1 5047.8 5075.6 5091.7 5092.4 4192.9 4498.0 4562.2 4568.4 4678.8 3763.5 3811.7 3892.6 3902.2 3919.1 1240.4 1252.7 1276.9 1312.1 1319.1 935.4 978.5 987.3 1002.9 1007.1 5589.8 5703.0 5732.7 5738.3 5819.3 1056.0 1066.5 1079.7 1080.3 1090.5 3764.3 3885.7 3934.8 3943.8 3959.7 9885.6 10111.5 10156.2 10162.9 10217.1 9615.0 10041.8 10042.5 10098.7 10110.8 7603.2 7697.9 7759.0 7786.1 7816.2 5623.7 5630.9 5703.3 5833.3 5897.1 9062.6 9216.0 9341.3 9346.1 9468.1 9428.7 9838.4 9882.2 10014.8 10030.9 6842.6 7067.5 7347.6 7492.7 7628.5 7348.6 7384.2 7390.9 7397.4 7454.7 7147.4 7319.0 7338.1 7404.8 7473.0 7222.9 7240.9 7293.3 7383.9 7406.8 6430.1 6503.3 6559.5 6571.9 6574.0 4724.2 4827.0 4829.3 4857.0 5044.9 4881.3 4899.2 4904.0 4939.6 4976.5 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#4] prototype.html Cycles:180 Average:4923.39 Median:5661.42 stddev:1491.98 (26.4%) stddev-sans-first:1455.57 04:50:20 INFO - PROCESS | 27408 | Values: 317.6 320.3 326.6 329.0 329.3 5491.8 5506.0 5600.8 5638.5 5641.2 5506.5 5522.1 5531.3 5534.9 5537.9 4081.1 4105.9 4268.3 4273.2 4284.2 4251.3 4251.5 4254.6 4264.4 4283.3 4218.8 4229.6 4232.4 4237.6 4260.5 3960.2 4162.7 4193.7 4213.6 4271.1 3636.7 3645.9 3661.9 3666.0 3685.0 5330.9 5344.0 5347.9 5368.2 5379.5 4587.5 4836.4 4848.9 4862.7 4888.2 5638.0 5743.3 5760.8 5769.9 5775.0 4005.1 4021.6 4026.0 4026.2 4028.6 5895.3 5907.6 5986.2 6041.8 6059.5 4069.9 4070.6 4104.0 4114.8 4128.7 4147.3 4150.0 4168.6 4184.1 4188.6 4657.7 4785.7 4787.5 4809.0 4819.9 5681.7 5753.1 5818.8 5829.3 5830.7 1469.4 1474.0 1484.4 1488.7 1506.1 949.1 961.4 1004.9 1010.5 1024.4 5898.2 5940.9 5959.7 5964.1 5971.9 6280.3 6301.2 6328.4 6338.4 6344.6 5811.9 5914.3 5980.6 6019.9 6024.2 3340.6 3385.7 3411.8 3412.5 3417.5 5986.2 6243.3 6263.2 6548.8 6559.8 6140.5 6192.7 6195.7 6210.2 6222.8 6116.5 6205.0 6217.6 6246.9 6267.0 6056.8 6059.5 6059.5 6075.4 6075.5 5908.6 5996.7 6010.9 6017.2 6063.7 6149.6 6173.2 6275.8 6283.2 6284.2 4143.8 4160.2 4209.2 4226.6 4240.3 5787.5 6082.2 6112.7 6115.1 6128.8 5785.5 5823.9 5850.2 5875.4 5926.8 5859.6 5890.6 5899.5 5910.5 5947.6 5595.6 5749.9 5803.7 5809.8 5817.5 5970.6 5975.4 5979.6 5986.6 5988.9 5463.3 5786.9 5791.7 5832.6 5850.1 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - PROCESS | 27408 | [#5] yui.html Cycles:180 Average:14912.20 Median:25667.50 stddev:17465.32 (68.0%) stddev-sans-first:17482.09 04:50:20 INFO - PROCESS | 27408 | Values: 784.5 823.1 829.4 850.9 870.1 13643.5 13645.6 13751.0 13827.4 14044.0 12671.9 12702.1 12726.4 12745.6 12763.7 760.7 819.7 823.6 824.8 826.4 827.9 828.1 829.8 830.2 836.3 863.9 864.6 864.8 865.7 867.9 855.6 859.4 862.3 863.5 866.7 624.6 625.0 625.3 626.5 627.3 13886.3 13951.9 13981.2 13993.2 14134.3 13058.2 13109.9 13409.0 13409.3 13431.3 11172.2 11190.3 11376.7 11448.4 11457.8 3760.8 3773.8 3810.2 3825.1 3878.6 46776.0 47479.5 47765.8 47845.5 47878.3 10839.8 10850.0 10882.1 10962.7 11208.4 18171.0 19440.4 19445.2 19447.6 19483.4 8281.9 8313.1 8329.2 8400.4 8572.3 4686.6 4704.5 4725.2 4809.8 4914.5 3295.3 3412.0 3414.5 3420.5 3424.3 627.9 631.2 635.0 642.4 648.1 713.1 748.3 760.7 763.2 787.7 8640.8 9161.0 9264.6 9325.4 9349.9 636.2 767.7 769.4 780.3 785.4 4413.9 4441.9 4479.1 4485.9 4559.0 61072.4 65657.0 66416.0 66433.0 66519.3 57747.1 57913.0 58701.7 58749.0 60587.7 51965.7 52536.0 52544.8 53229.7 53794.5 8477.2 8611.7 8644.3 8745.7 8857.5 34319.7 34424.8 34787.0 34929.5 35390.5 44881.3 47936.5 48007.0 48158.3 49117.8 11417.3 11423.3 11599.0 11614.5 11874.1 12147.6 12838.2 13244.9 13359.9 13409.7 12476.8 12769.8 12786.2 12866.5 13045.0 12247.2 12381.4 12486.9 12693.8 12744.6 12161.5 12717.8 12789.7 12874.2 12945.6 11072.0 11199.9 11378.8 11427.2 11536.5 10931.5 11278.9 11403.8 11575.5 11615.0 04:50:20 INFO - PROCESS | 27408 | -------- Summary: end -------- 04:50:20 INFO - PROCESS | 27408 | 04:50:20 INFO - TEST-INFO | 27408: exit 0 04:50:21 INFO - TEST-OK | dromaeo_css | took 1108748ms 04:50:21 INFO - TEST-START | kraken 04:50:21 INFO - operating with platform_type : linux_ 04:50:21 INFO - Initialising browser for kraken test... 04:50:21 INFO - TEST-INFO | started process 27641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sMnnG/profile http://localhost:52011/getInfo.html) 04:50:24 INFO - PROCESS | 27641 | 04:50:24 INFO - PROCESS | 27641 | (process:27707): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:50:24 INFO - PROCESS | 27641 | __metrics Screen width/height:1600/1200 04:50:24 INFO - PROCESS | 27641 | colorDepth:24 04:50:24 INFO - PROCESS | 27641 | Browser inner width/height: 1024/697 04:50:24 INFO - PROCESS | 27641 | __metrics 04:50:25 ERROR - PROCESS | 27641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:50:26 INFO - TEST-INFO | 27641: exit 0 04:50:26 INFO - Browser initialized. 04:50:26 INFO - Running cycle 1/1 for kraken test... 04:50:26 INFO - TEST-INFO | started process 27758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sMnnG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:28 INFO - PROCESS | 27758 | 04:50:28 INFO - PROCESS | 27758 | (process:27820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:50:38 INFO - PROCESS | 27758 | RSS: Main: 165351424 04:50:38 INFO - PROCESS | 27758 | 04:50:40 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:41 INFO - PROCESS | 27758 | RSS: Main: 169971712 04:50:41 INFO - PROCESS | 27758 | 04:50:44 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-dft) 04:50:44 INFO - PROCESS | 27758 | RSS: Main: 173113344 04:50:44 INFO - PROCESS | 27758 | 04:50:47 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-fft) 04:50:48 INFO - PROCESS | 27758 | RSS: Main: 164106240 04:50:48 INFO - PROCESS | 27758 | 04:50:50 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-oscillator) 04:50:51 INFO - PROCESS | 27758 | RSS: Main: 164163584 04:50:51 INFO - PROCESS | 27758 | 04:50:53 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:54 INFO - PROCESS | 27758 | RSS: Main: 165003264 04:50:54 INFO - PROCESS | 27758 | 04:50:57 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:57 INFO - PROCESS | 27758 | RSS: Main: 165212160 04:50:57 INFO - PROCESS | 27758 | 04:51:01 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:01 INFO - PROCESS | 27758 | RSS: Main: 167260160 04:51:01 INFO - PROCESS | 27758 | 04:51:04 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52011/tests/kraken/driver.html?testName=json-parse-financial) 04:51:05 INFO - PROCESS | 27758 | RSS: Main: 167739392 04:51:05 INFO - PROCESS | 27758 | 04:51:06 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52011/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:07 INFO - PROCESS | 27758 | RSS: Main: 168009728 04:51:07 INFO - PROCESS | 27758 | 04:51:09 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:09 INFO - PROCESS | 27758 | RSS: Main: 168128512 04:51:09 INFO - PROCESS | 27758 | 04:51:11 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:12 INFO - PROCESS | 27758 | RSS: Main: 168194048 04:51:12 INFO - PROCESS | 27758 | 04:51:15 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:15 INFO - PROCESS | 27758 | RSS: Main: 168615936 04:51:15 INFO - PROCESS | 27758 | 04:51:19 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:19 INFO - PROCESS | 27758 | RSS: Main: 168493056 04:51:19 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52011/tests/kraken/driver.html?testName=ai-astar) 04:51:21 INFO - PROCESS | 27758 | RSS: Main: 170057728 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | __start_tp_report 04:51:21 INFO - PROCESS | 27758 | _x_x_mozilla_page_load 04:51:21 INFO - PROCESS | 27758 | _x_x_mozilla_page_load_details 04:51:21 INFO - PROCESS | 27758 | |i|pagename|runs| 04:51:21 INFO - PROCESS | 27758 | |0;ai-astar;114;107;113;113;116;126;114;114;112;113 04:51:21 INFO - PROCESS | 27758 | |1;audio-beat-detection;161;127;163;187;130;170;155;129;184;136 04:51:21 INFO - PROCESS | 27758 | |2;audio-dft;161;163;163;161;162;164;173;162;165;163 04:51:21 INFO - PROCESS | 27758 | |3;audio-fft;77;76;76;156;77;75;76;76;169;78 04:51:21 INFO - PROCESS | 27758 | |4;audio-oscillator;92;94;149;92;93;94;147;92;92;158 04:51:21 INFO - PROCESS | 27758 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;121;118;117 04:51:21 INFO - PROCESS | 27758 | |6;imaging-darkroom;147;147;147;146;146;147;147;147;146;146 04:51:21 INFO - PROCESS | 27758 | |7;imaging-desaturate;95;95;97;100;98;95;95;95;95;96 04:51:21 INFO - PROCESS | 27758 | |8;json-parse-financial;59;61;61;66;60;58;61;76;59;56 04:51:21 INFO - PROCESS | 27758 | |9;json-stringify-tinderbox;60;60;61;60;62;61;61;61;63;60 04:51:21 INFO - PROCESS | 27758 | |10;stanford-crypto-aes;76;78;77;75;77;78;79;76;78;77 04:51:21 INFO - PROCESS | 27758 | |11;stanford-crypto-ccm;134;138;128;134;134;124;125;129;158;141 04:51:21 INFO - PROCESS | 27758 | |12;stanford-crypto-pbkdf2;215;205;201;211;205;206;202;204;203;202 04:51:21 INFO - PROCESS | 27758 | |13;stanford-crypto-sha256-iterative;74;71;78;79;72;71;77;72;72;72 04:51:21 INFO - PROCESS | 27758 | __end_tp_report 04:51:21 INFO - PROCESS | 27758 | __start_cc_report 04:51:21 INFO - PROCESS | 27758 | _x_x_mozilla_cycle_collect,855 04:51:21 INFO - PROCESS | 27758 | __end_cc_report 04:51:21 INFO - PROCESS | 27758 | __startTimestamp1461671481748__endTimestamp 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | ------- Summary: start ------- 04:51:21 INFO - PROCESS | 27758 | Number of tests: 14 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.76 (4.2%) stddev-sans-first:5.04 04:51:21 INFO - PROCESS | 27758 | Values: 114.0 107.0 113.0 113.0 116.0 126.0 114.0 114.0 112.0 113.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:162.00 stddev:22.68 (14.0%) stddev-sans-first:23.92 04:51:21 INFO - PROCESS | 27758 | Values: 161.0 127.0 163.0 187.0 130.0 170.0 155.0 129.0 184.0 136.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.50 (2.1%) stddev-sans-first:3.57 04:51:21 INFO - PROCESS | 27758 | Values: 161.0 163.0 163.0 161.0 162.0 164.0 173.0 162.0 165.0 163.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:36.45 (48.0%) stddev-sans-first:38.16 04:51:21 INFO - PROCESS | 27758 | Values: 77.0 76.0 76.0 156.0 77.0 75.0 76.0 76.0 169.0 78.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.00 stddev:28.46 (30.9%) stddev-sans-first:29.41 04:51:21 INFO - PROCESS | 27758 | Values: 92.0 94.0 149.0 92.0 93.0 94.0 147.0 92.0 92.0 158.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 04:51:21 INFO - PROCESS | 27758 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 121.0 118.0 117.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:51:21 INFO - PROCESS | 27758 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.73 (1.8%) stddev-sans-first:1.79 04:51:21 INFO - PROCESS | 27758 | Values: 95.0 95.0 97.0 100.0 98.0 95.0 95.0 95.0 95.0 96.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:5.66 (9.3%) stddev-sans-first:5.92 04:51:21 INFO - PROCESS | 27758 | Values: 59.0 61.0 61.0 66.0 60.0 58.0 61.0 76.0 59.0 56.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 04:51:21 INFO - PROCESS | 27758 | Values: 60.0 60.0 61.0 60.0 62.0 61.0 61.0 61.0 63.0 60.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.50 stddev:1.20 (1.5%) stddev-sans-first:1.20 04:51:21 INFO - PROCESS | 27758 | Values: 76.0 78.0 77.0 75.0 77.0 78.0 79.0 76.0 78.0 77.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:134.00 stddev:9.89 (7.4%) stddev-sans-first:10.49 04:51:21 INFO - PROCESS | 27758 | Values: 134.0 138.0 128.0 134.0 134.0 124.0 125.0 129.0 158.0 141.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.40 Median:205.00 stddev:4.40 (2.1%) stddev-sans-first:3.00 04:51:21 INFO - PROCESS | 27758 | Values: 215.0 205.0 201.0 211.0 205.0 206.0 202.0 204.0 203.0 202.0 04:51:21 INFO - PROCESS | 27758 | 04:51:21 INFO - PROCESS | 27758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:73.00 stddev:3.05 (4.2%) stddev-sans-first:3.23 04:51:21 INFO - PROCESS | 27758 | Values: 74.0 71.0 78.0 79.0 72.0 71.0 77.0 72.0 72.0 72.0 04:51:21 INFO - PROCESS | 27758 | -------- Summary: end -------- 04:51:21 INFO - PROCESS | 27758 | 04:51:22 INFO - TEST-INFO | 27758: exit 0 04:51:22 INFO - TEST-OK | kraken | took 61686ms 04:51:22 INFO - SUITE-END | took 1170s 04:51:22 INFO - Completed test suite (00:19:30) 04:51:22 INFO - javascript benchmark 04:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.9689703102968, 3143.827089510077, 3155.0, 3188.76084293678, 3191.8084914905094, 5239.187925871486, 5248.0, 5259.710715910633, 5283.154695248766, 5336.332958380202, 5212.400573933999, 5274.683518988863, 5289.047971365153, 5309.707966061865, 5431.565474762019, 4856.4900685427965, 4879.072976134541, 4915.434725006617, 4960.0, 5004.949950500485, 771.9453841208654, 4793.856184314476, 4928.088303663816, 4939.382577177853, 4967.428745694256, 4892.290617860426, 4893.657443978923, 4916.655834091615, 4921.040397122545, 4961.131801934647, 4787.281907713836, 4922.114019476493, 4978.128827455217, 4979.8008079676765, 5029.119904016819, 4775.5463230993, 4796.544328288807, 4805.423349198084, 4830.033993201374, 4879.707217566957, 5140.331756871583, 5151.072806894757, 5182.974085129588, 5183.974080129613, 5252.212168174766, 5582.720863956826, 5596.0206963781175, 5613.4386561343945, 5630.634008789416, 5679.801206957736, 5694.2312787773535, 5695.515881150107, 5700.230468886689, 5720.456556627114, 5722.54219662426, 5247.790088396459, 5295.0468915595175, 5304.761285742151, 5310.070737620901, 5366.382865970385, 5652.63257888236, 5821.970890145522, 5835.299764028344, 5903.3801450847905, 5905.202797622352, 5602.0, 5632.352279487829, 5635.0702134147405, 5644.8871022579315, 5651.2935883014625, 5687.459691329317, 5708.229389032511, 5712.714364281769, 5719.4852463277675, 5737.168110623936, 5603.915941260884, 5650.3219613646625, 5688.345840228344, 5700.287464066992, 5702.45826646468, 5541.806036788693, 5603.327600687862, 5612.382637909826, 5614.9719251403485, 5625.240592519957, 4272.380504826845, 4273.508546517128, 4311.288637374798, 4319.963208829859, 4344.695871288979, 3784.924301513954, 3896.493455850721, 3918.1380096378753, 3924.5290565131795, 3951.3480275754755, 5381.3811411687375, 5445.319335083114, 5447.700376479332, 5482.862928426821, 5494.340679118452, 5637.46444087811, 5666.4900158985065, 5722.113072473773, 5727.39862314451, 5730.455606717439, 5340.305760251143, 5414.269073675082, 5433.918491222635, 5443.101888188405, 5516.117421212587, 4750.0, 4756.809727610926, 4786.401699787527, 4806.327114204014, 4821.421429428421, 5761.5102716269585, 5772.5670574707065, 5781.219535362757, 5789.594728368974, 5789.8263052108505, 5628.465295796893, 5640.887182256414, 5668.26312579362, 5701.458361455655, 5712.37163911961, 5843.0, 5856.238688970407, 5859.414058594107, 5867.20792692981, 5919.644821310735, 5574.804881829116, 5586.329640443173, 5599.356074051536, 5601.495865372136, 5607.943920560742, 5540.695261760642, 5625.578081643811, 5689.573282003949, 5702.6863522506665, 5736.082226843685, 5484.808031718871, 5489.176623506506, 5497.505224529811, 5499.477549632778, 5564.276644036249, 5452.863678408072, 5463.235147079333, 5472.671639701631, 5475.890482190413, 5495.368032676293, 5383.08487557124, 5396.379416367168, 5470.8905821882545, 5547.251121098761, 5597.272354593877, 5489.1217405214975, 5501.614886958035, 5511.255980442589, 5574.303212098488, 5586.636868603528, 5447.455254474521, 5487.945120548903, 5553.16702494629, 5587.944120558743, 5601.747921343468], "value": 5210.190999221959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1574585359523, 637.2034956304618, 647.245958458396, 651.8826611209984, 681.529744476311, 35365.82317088414, 36888.26223475529, 36929.44605830915, 36951.26097478049, 37042.07394815124, 35699.64300356996, 36434.27131457369, 36479.45280820783, 36490.817545912236, 36516.26967460649, 8385.916140838604, 8435.746927592152, 8517.616707248158, 8561.0582835888, 8562.871556926651, 8328.625211865481, 8555.614997325105, 8623.913760862373, 8634.438761480484, 8648.264897483721, 8729.214370706635, 8766.912330876674, 8793.472391656489, 8808.471491710518, 8817.0, 8602.569871506432, 8642.351823613255, 8705.216530512283, 8712.172343627346, 8714.302855771522, 8646.697365592174, 8748.30013598917, 8791.252743516745, 8793.824123517494, 8805.779855503664, 28406.431871362456, 36870.0, 37400.25199496022, 37484.81257593722, 37490.0, 3266.4447044002577, 3303.8477011637156, 3343.765936384454, 3420.1791570023265, 3530.011596752913, 28591.714082859115, 29003.564946525818, 29269.414611707645, 29422.558661620093, 29585.408291834257, 4036.253293140778, 4049.4533238012787, 4090.2228576570355, 4164.0, 4177.937330940038, 219970.0, 221798.4550386237, 222657.0, 222775.0, 224027.0, 33422.33155336879, 33593.496097558556, 33745.83127084349, 33810.661893380755, 34109.31781364359, 34854.12864678403, 34910.301793964485, 53299.467005330225, 55248.447515525135, 55270.0, 15105.848941510445, 15293.15887626169, 15300.311485983157, 15312.617184570476, 15318.387264509518, 11704.531818727155, 11757.353345565905, 11761.470733817, 11775.646730598095, 11781.823272650918, 17834.5541361467, 17845.0, 17880.374186903657, 17956.730649040273, 18002.819971800378, 6947.24113981924, 6995.230524642286, 7165.319294666998, 7216.025836512109, 7261.38278246355, 1046.0, 1058.3755584205355, 1142.657202839145, 1173.4836671864352, 1185.1230089733535, 26312.342191444983, 26605.0, 26867.596986045224, 26940.32649183786, 27102.051428199917, 1155.133649762678, 1160.3849959521467, 1163.598558497317, 1200.9639710808515, 1241.8385609870659, 14718.779218311734, 14850.331735071948, 14949.327280272413, 15082.321295541728, 15231.314590843438, 361513.0, 371118.0, 371623.0, 371823.0, 372615.0, 52068.0, 53812.461875380744, 54012.18981715277, 54065.459345406045, 54108.917821644136, 1398.9160650361011, 1426.1158081989233, 1435.5191011011427, 1436.7629341158802, 1442.0698649371307, 28701.85649071741, 29194.854025729735, 29287.414251715272, 29560.260993475335, 29573.852130739207, 46575.06849863051, 46594.76702616465, 46790.532094678616, 46937.0, 47009.52990470052, 295741.0, 300050.0, 300858.0, 300937.0, 300979.0, 26711.465770684088, 27203.59194612122, 27307.0, 27334.5899811499, 27669.58495622527, 43611.56388436075, 44343.556564433944, 44456.33315500335, 44731.0, 45584.54415455803, 37820.0, 38060.619393805704, 38095.428568572046, 39205.41191882181, 39267.018324542114, 37172.44241336328, 37823.0, 38296.2340753189, 38638.2272354557, 38771.6122838768, 30997.535036974914, 35705.81198532725, 35769.642303576635, 38705.225895482494, 39070.21859562736, 30475.390492190476, 31885.20286992751, 32112.197195070312, 33696.83151584226, 34249.31501369909, 27102.864485677444, 27188.728112718618, 27260.591091134047, 27406.5889011661, 27433.725662743916], "value": 18038.18596433827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.114440220699, 399.4667119395607, 399.55050568110875, 400.43738547340996, 409.2429006338273, 13690.52083177089, 16752.91623541882, 16872.156392180405, 17485.388011419604, 17582.56043598909, 16808.831911680878, 17185.312587496486, 17323.82676173238, 17326.82673173268, 17676.0, 5470.617056806035, 5518.724063796814, 5525.226468294442, 5638.830835074954, 5658.773649054033, 5508.724563771815, 5546.417626149257, 5551.694656793875, 5574.470425309589, 5595.7481913313995, 5311.814086506973, 5480.068388373986, 5515.227868098469, 5542.307211598551, 5553.055980483307, 5482.39693633702, 5503.11950087988, 5526.253955715967, 5551.278333816598, 5572.3870374258795, 4756.500567440438, 4854.2233242681, 4975.328330675385, 5010.574101201402, 5019.447860735316, 20220.292289769935, 20767.480812979644, 20853.478663033395, 21180.0, 21184.0, 2407.8916448759674, 2433.270018994295, 2433.549793288247, 2476.6780318558654, 2505.7243703192635, 13618.455261789517, 13654.317284135754, 13711.794323085162, 13756.724865502634, 13769.31153442324, 1928.797476264986, 2012.6377252094617, 2022.9898850505801, 2031.1266155553105, 2091.874487530753, 67155.3284467154, 67512.3248767511, 67904.6604766978, 68057.0, 68315.97526037114, 10056.748581285527, 10114.089731924161, 10337.483125843677, 10427.94786026065, 10481.475926203659, 12489.437975291134, 13075.084744067824, 14326.283685815668, 14364.640883977983, 14369.78445323321, 7318.817029574303, 7350.916005866372, 7733.0, 7894.644740986554, 8091.39314551411, 7494.962525187339, 7534.434917381218, 7556.206598307209, 7605.505642133244, 7709.6530656119485, 6116.0, 6534.4445722113205, 6546.414166404339, 6571.901421478682, 6620.271770105284, 1883.387898932825, 1944.3680803738841, 1955.6479833630083, 1973.9309124180584, 1974.496503391626, 958.6021800952526, 1091.8908109189176, 1120.1822669451183, 1125.729824842032, 1126.718320419895, 17069.146542672817, 17522.649547008987, 17568.0, 17896.194671239824, 18217.45347639573, 1055.456439933435, 1065.1106326217541, 1073.5222825842425, 1126.3354620773782, 1145.7422080032093, 10285.691429257135, 10616.203784716177, 10680.62617808373, 10709.839352409721, 10886.0, 455040.0, 469741.0, 489616.0, 497929.0, 500176.0, 66996.33003669999, 67122.66438667776, 68401.65799171072, 69054.65472672605, 69562.65218673975, 1042.3641578637025, 1057.1278695076592, 1065.4992153687754, 1067.1569460126414, 1074.1514203779084, 16094.436694715629, 16132.435364762177, 16164.676706465569, 16175.110368929822, 16346.346146154021, 28429.573556397085, 33424.0, 33521.0, 35278.94163175109, 35787.28425431425, 43036.0, 43045.3543196846, 43265.3510197341, 43904.56095439005, 45019.84861059694, 8215.958920205361, 8236.299914507334, 8465.195806398382, 8587.398882078194, 8695.608697608497, 12677.55628553033, 12724.618261452171, 12806.039547033823, 12826.294553799631, 13092.80360794608, 11298.661040168809, 11641.88358116408, 11708.180427370002, 11742.0, 11890.821637675268, 11247.887521124683, 11300.0, 11327.830082548933, 11346.205765596329, 11377.715557111138, 11649.941750291195, 11694.122940779305, 11870.347130907538, 11966.64100076999, 12038.578649747216, 7483.214262502576, 7601.467897247139, 8356.665733370597, 8702.956485217534, 8767.824643506967, 10699.572017119228, 11187.888121119011, 11231.66305010851, 11302.830457543309, 11377.54489820398], "value": 8894.93151216284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.6507103366225, 1528.1747856157672, 1693.187270110347, 1807.35838777234, 1810.7464954906307, 7159.928400715991, 7787.844243115142, 8050.4364694471415, 8074.031116266049, 8160.510369377842, 8109.310708589762, 8124.756257312275, 8128.105908350091, 8220.588970551478, 8236.794080148, 2200.6698995150737, 2247.0786977339294, 2247.1910112359537, 2248.685184074223, 2255.7180352455944, 2198.835087368446, 2203.03066650674, 2237.9328620141423, 2239.32820153954, 2241.1595651630637, 2214.0700905619597, 2235.2958817972367, 2255.154317131076, 2257.954840903181, 2261.954760904781, 2167.8590891592, 2168.186929901287, 2172.261431113421, 2179.9346019619516, 2183.192218879025, 2167.9566408671894, 2170.121100954116, 2170.2078741259324, 2172.73927128744, 2173.8695678259355, 8280.917190828075, 8306.460080094836, 8311.002679678417, 8338.583070846495, 8343.207395297437, 4853.296272040534, 5112.974435127838, 5114.872128196787, 5124.205748109049, 5138.665986710852, 3061.5713800068006, 3151.434236352569, 3277.2462333663393, 3309.834508274577, 3312.6190488093935, 1092.546593163836, 1093.2729734726397, 1099.060303440555, 1103.6799328194813, 1124.876263611002, 11337.489812958354, 11485.885141148648, 11487.540498380054, 11489.712757181138, 11599.768004639944, 4342.761148136819, 4475.0, 4489.551044895549, 4536.56902594253, 4543.0, 9633.133018028411, 9666.178374838077, 9680.75798105053, 9683.273754468442, 9746.220302375934, 5029.119904016782, 5047.798088076509, 5075.644704870623, 5091.694498330112, 5092.363454568179, 4192.937105943413, 4497.955020449819, 4562.1560011398, 4568.360429539867, 4678.7660616969015, 3763.473113764075, 3811.676007539335, 3892.630200130983, 3902.239063382613, 3919.1377896862646, 1240.4108048676987, 1252.661781319057, 1276.8850803427736, 1312.140547941081, 1319.0898280186832, 935.373299889076, 978.4618459847198, 987.2595553334999, 1002.9348092373972, 1007.1036777268237, 5589.776408943678, 5702.971485142631, 5732.656040637575, 5738.282714660668, 5819.272590926134, 1055.9630412935664, 1066.461436974323, 1079.6545105566302, 1080.2924084724518, 1090.54197237159, 3764.3036038333, 3885.7279990400966, 3934.7835869027476, 3943.8028098594955, 3959.7228194026716, 9885.604575817031, 10111.544980475895, 10156.187504999582, 10162.949185254174, 10217.13154381871, 9614.95192524033, 10041.849372259421, 10042.49787510636, 10098.697039088838, 10110.837253715918, 7603.201663825219, 7697.923020769833, 7759.0, 7786.104597971193, 7816.179301173295, 5623.690697011703, 5630.85922851932, 5703.258576385043, 5833.329167145833, 5897.085951677325, 9062.63749450041, 9216.0, 9341.34610577253, 9346.11211934865, 9468.14786669203, 9428.717138485856, 9838.409695418297, 9882.160016398686, 10014.849777253492, 10030.949845250727, 6842.623655698785, 7067.5052746307265, 7347.632618369167, 7492.662830172546, 7628.466007379652, 7348.559086454829, 7384.187739348775, 7390.9260907390235, 7397.4082073435075, 7454.739084132029, 7147.356737893615, 7318.96340518294, 7338.119425668954, 7404.777856664308, 7473.028506294364, 7222.9277707224355, 7240.855182896418, 7293.270672932877, 7383.852322953619, 7406.814829629302, 6430.1319321892815, 6503.317151699003, 6559.508036897157, 6571.868562628625, 6574.04676321921, 4724.1732696777235, 4827.010462855036, 4829.299751536078, 4856.975715121402, 5044.949550504448, 4881.29221262922, 4899.216125419915, 4903.975480122576, 4939.555440010273, 4976.527229913152], "value": 4442.2659171895875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.6378928022055, 320.29854618385735, 326.6048081820996, 329.03756512201807, 329.33638717983285, 5491.835244942653, 5505.972470137649, 5600.831975040755, 5638.520725738312, 5641.153826925964, 5506.513241424813, 5522.144067669507, 5531.2532808071, 5534.861628459291, 5537.861553461155, 4081.102157525347, 4105.9178816423655, 4268.253055715253, 4273.230818452677, 4284.186004659105, 4251.277282861905, 4251.4898212214575, 4254.638355739766, 4264.402983582301, 4283.293256612671, 4218.767967761772, 4229.604230603909, 4232.428622136018, 4237.576242375769, 4260.510041345238, 3960.188161426915, 4162.687798415131, 4193.706440549163, 4213.599708027732, 4271.145770845843, 3636.654517820803, 3645.872394466181, 3661.8535258589623, 3666.046827824785, 3684.9631503684886, 5330.92003619946, 5343.973280133574, 5347.887584404139, 5368.194770784375, 5379.542738867201, 4587.541245875419, 4836.395450568679, 4848.927266090976, 4862.735688720958, 4888.217885138396, 5637.971810140964, 5743.282089738783, 5760.769569217268, 5769.855753606152, 5775.0, 4005.0988527581353, 4021.5978402159844, 4025.9798701006603, 4026.2148880968225, 4028.6302657096726, 5895.322037965603, 5907.6160049597065, 5986.161937328778, 6041.818745437644, 6059.45464908156, 4069.9446779376226, 4070.61329173728, 4104.0, 4114.814833332507, 4128.690348223895, 4147.294959856831, 4149.9832541027645, 4168.645665118499, 4184.100418410057, 4188.581141885848, 4657.720536767804, 4785.736784476887, 4787.529041444925, 4808.990112076433, 4819.927701084486, 5681.687507187145, 5753.050746626844, 5818.77805660816, 5829.271341082364, 5830.737616807254, 1469.4122351059448, 1473.977890331646, 1484.3765618440282, 1488.679933814235, 1506.058713304185, 949.126803340928, 961.3654987708079, 1004.8944860789512, 1010.4897027001317, 1024.416082832778, 5898.233229680114, 5940.910886336708, 5959.702014899238, 5964.135200395918, 5971.880562388815, 6280.340564240781, 6301.180846489927, 6328.373724904205, 6338.397852204033, 6344.619322840645, 5811.854703632443, 5914.260717410324, 5980.55145864062, 6019.939800602026, 6024.1566180734735, 3340.599128104643, 3385.712214461749, 3411.829408529564, 3412.522246885438, 3417.470292104728, 5986.2217911671205, 6243.313235544087, 6263.154474145932, 6548.803535893836, 6559.8032059038305, 6140.478059365004, 6192.721327540272, 6195.729875375538, 6210.161628180138, 6222.844428889223, 6116.544152553793, 6205.03821907605, 6217.626942383562, 6246.906296405557, 6267.0, 6056.848578785565, 6059.454649081427, 6059.454649081604, 6075.422834830684, 6075.513958883191, 5908.5568582357355, 5996.730147143302, 6010.87978240424, 6017.247844019497, 6063.696815159313, 6149.631022138686, 6173.197484327009, 6275.780347687809, 6283.214598175228, 6284.24589049317, 4143.81352839117, 4160.1679664067915, 4209.17921005401, 4226.5773422657485, 4240.321548552217, 5787.508061814625, 6082.225453019359, 6112.746886888266, 6115.1438798569125, 6128.816135515942, 5785.508231800344, 5823.854403639773, 5850.210221620197, 5875.441833026027, 5926.762929482772, 5859.589828711949, 5890.558208134493, 5899.4985426239255, 5910.497607703393, 5947.553933454921, 5595.63628364155, 5749.942500575108, 5803.709814509173, 5809.76760929575, 5817.505512031525, 5970.58205925581, 5975.40245975399, 5979.551533634908, 5986.640801551921, 5988.940110598838, 5463.262459568066, 5786.942130578809, 5791.739371728198, 5832.62087964281, 5850.063989761617], "value": 4442.484271056719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4704824243635, 823.1398188892603, 829.3779665251062, 850.8638617821142, 870.0603348383744, 13643.522476713317, 13645.590632281022, 13751.0, 13827.446902123915, 14044.0, 12671.873281267184, 12702.110852240325, 12726.36368181592, 12745.553905613306, 12763.744725105516, 760.6767123972318, 819.7049062337554, 823.5923218007094, 824.7773101262655, 826.3802148388709, 827.8634025385804, 828.056016141599, 829.8464784014947, 830.1822704635929, 836.297510091523, 863.8531449653542, 864.6109250837148, 864.8010957479784, 865.6883521932131, 867.8611422172454, 855.5893171277821, 859.4113032572708, 862.3144600042981, 863.5380071661663, 866.6620018192909, 624.6064979063161, 624.9875202172465, 625.2746813696091, 626.5488848029412, 627.2504357293037, 13886.305684715824, 13951.860481395259, 13981.161130332111, 13993.16041037541, 14134.293285335692, 13058.216507009514, 13109.868901311056, 13409.0, 13409.329533523285, 13431.261280629562, 11172.162087843444, 11190.272632278877, 11376.715582110432, 11448.370339631318, 11457.770844583061, 3760.774353538769, 3773.754705944132, 3810.161764411853, 3825.101101241206, 3878.5927477614728, 46776.0, 47479.52520474786, 47765.761171193924, 47845.52154478445, 47878.28182577264, 10839.83740243897, 10850.0, 10882.075023623082, 10962.671119866416, 11208.439578021067, 18171.0, 19440.416787496397, 19445.22219111248, 19447.61104777925, 19483.415497535098, 8281.917180828235, 8313.12712165214, 8329.208725171098, 8400.369972251983, 8572.314214862796, 4686.625069994392, 4704.529547045268, 4725.196716558194, 4809.759512024385, 4914.483979182206, 3295.2750394913082, 3411.982940085333, 3414.5048967899515, 3420.486926960976, 3424.3493736190044, 627.883841489326, 631.1952260867339, 634.9587276826992, 642.3768944124192, 648.0538413915735, 713.0908092182509, 748.27043632459, 760.6919197724931, 763.2253262938123, 787.6849260295813, 8640.783980400414, 9161.0, 9264.583093760797, 9325.440473571607, 9349.859752103725, 636.2206297285788, 767.6929228308721, 769.4498433619989, 780.2782426255691, 785.3991696352296, 4413.911721765547, 4441.933370999438, 4479.148961697267, 4485.9220511601625, 4558.997020655451, 61072.38927610667, 65657.0, 66416.0, 66433.0, 66519.33480665131, 57747.13379299314, 57913.0, 58701.70649146727, 58749.0, 60587.69706151441, 51965.70085747811, 52536.0, 52544.847309161574, 53229.73385133049, 53794.46205537973, 8477.194666506672, 8611.65553377858, 8644.265237454887, 8745.693900713444, 8857.468551886908, 34319.656803431644, 34424.82787586046, 34787.0, 34929.47605785864, 35390.46914296236, 44881.32678009767, 47936.5206347932, 48007.0, 48158.277625836345, 49117.75441122914, 11417.31496110236, 11423.257488263236, 11599.0, 11614.535418583162, 11874.109441791727, 12147.635570932885, 12838.16551924122, 13244.933775331061, 13359.933200333937, 13409.66475838112, 12476.812847807472, 12769.808452873029, 12786.168899021533, 12866.485340586272, 13045.0, 12247.203931744409, 12381.380930953597, 12486.937565312115, 12693.8095928563, 12744.61766147017, 12161.513539458323, 12717.8092328617, 12789.680257993625, 12874.227546347249, 12945.611631651065, 11072.0, 11199.888001119885, 11378.772424551627, 11427.200095993201, 11536.538538458368, 10931.508082136164, 11278.887211127783, 11403.771924561297, 11575.536978521102, 11615.012723918562], "value": 6781.115337763676, "unit": "score"}], "name": "dromaeo_css", "value": 6941.60963799473, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 113.0, 113.0, 116.0, 126.0, 114.0, 114.0, 112.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 163.0, 187.0, 130.0, 170.0, 155.0, 129.0, 184.0, 136.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 162.0, 164.0, 173.0, 162.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 156.0, 77.0, 75.0, 76.0, 76.0, 169.0, 78.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 149.0, 92.0, 93.0, 94.0, 147.0, 92.0, 92.0, 158.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 121.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 100.0, 98.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 66.0, 60.0, 58.0, 61.0, 76.0, 59.0, 56.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 63.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 75.0, 77.0, 78.0, 79.0, 76.0, 78.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 128.0, 134.0, 134.0, 124.0, 125.0, 129.0, 158.0, 141.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 205.0, 201.0, 211.0, 205.0, 206.0, 202.0, 204.0, 203.0, 202.0], "value": 205.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 78.0, 79.0, 72.0, 71.0, 77.0, 72.0, 72.0, 72.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1609.8999999999999, "alertThreshold": 2.0}]} 04:51:23 INFO - Return code: 0 04:51:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:23 ERROR - # TBPL SUCCESS # 04:51:23 INFO - Running post-action listener: _resource_record_post_action 04:51:23 INFO - Running post-run listener: _resource_record_post_run 04:51:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538877952; Read time: 24; Write time: 473072 04:51:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251138048; Read time: 0; Write time: 247876 04:51:24 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287739904; Read time: 24; Write time: 225196 04:51:24 INFO - Running post-run listener: _upload_blobber_files 04:51:24 INFO - Blob upload gear active. 04:51:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:51:24 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:24 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:25 INFO - (blobuploader) - INFO - Done attempting. 04:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:26 INFO - (blobuploader) - INFO - Done attempting. 04:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:26 INFO - Return code: 0 04:51:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05a407609869a8876b06860e6f0984976fb3f70d5b68b869c10a1e9612e2fb2dc6f9d74878c15437e7e1b9e5b559cbe25d87ba91496461a537b63d2056ae473c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/649f4c752e1324b6611a2082ed4c7c61110f901f6f2eda3a8ec0c903c3daf22d5dd9b8203732d14bfb5d2a11af01b5c25b5431a23fbcf7874e6bab09a46b2639"} 04:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:26 INFO - Contents: 04:51:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05a407609869a8876b06860e6f0984976fb3f70d5b68b869c10a1e9612e2fb2dc6f9d74878c15437e7e1b9e5b559cbe25d87ba91496461a537b63d2056ae473c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/649f4c752e1324b6611a2082ed4c7c61110f901f6f2eda3a8ec0c903c3daf22d5dd9b8203732d14bfb5d2a11af01b5c25b5431a23fbcf7874e6bab09a46b2639"} 04:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:26 INFO - Copying logs to upload dir... 04:51:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.264616 ========= master_lag: 107.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-04-26 04:53:13.730086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 04:53:13.733362) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05a407609869a8876b06860e6f0984976fb3f70d5b68b869c10a1e9612e2fb2dc6f9d74878c15437e7e1b9e5b559cbe25d87ba91496461a537b63d2056ae473c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/649f4c752e1324b6611a2082ed4c7c61110f901f6f2eda3a8ec0c903c3daf22d5dd9b8203732d14bfb5d2a11af01b5c25b5431a23fbcf7874e6bab09a46b2639"} build_url:https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/FJcvlfcGQBubr8p_0wq9LA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05a407609869a8876b06860e6f0984976fb3f70d5b68b869c10a1e9612e2fb2dc6f9d74878c15437e7e1b9e5b559cbe25d87ba91496461a537b63d2056ae473c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/649f4c752e1324b6611a2082ed4c7c61110f901f6f2eda3a8ec0c903c3daf22d5dd9b8203732d14bfb5d2a11af01b5c25b5431a23fbcf7874e6bab09a46b2639"}' ========= master_lag: 0.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 04:53:14.114544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:53:14.114881) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461668523.103465-268119086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 04:53:15.004488) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-26 04:53:15.004811) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-26 04:53:16.263810) ========= ========= Total master_lag: 109.07 =========