builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1460826433.22 results: success (0) buildid: 20160416073335 builduid: c5ea970218e54896a87139a1620fbfd5 revision: 037893f93079315cf4dfaac7e6ae6691876abcc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.220784) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.221249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.222023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.303439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.304209) ========= 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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 10:07:13-- 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% 29.4M=0s 2016-04-16 10:07:13 (29.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150654 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.484532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.484830) ========= 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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.283495 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.780789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.781194) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 037893f93079315cf4dfaac7e6ae6691876abcc6 --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 037893f93079315cf4dfaac7e6ae6691876abcc6 --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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 10:07:13,893 truncating revision to first 12 chars 2016-04-16 10:07:13,893 Setting DEBUG logging. 2016-04-16 10:07:13,893 attempt 1/10 2016-04-16 10:07:13,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/037893f93079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 10:07:14,147 unpacking tar archive at: mozilla-inbound-037893f93079/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.334260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.334573) ========= script_repo_revision: 037893f93079315cf4dfaac7e6ae6691876abcc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.334992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.335283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.344230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-16 10:07:14.344577) ========= /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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:14 INFO - MultiFileLogger online at 20160416 10:07:14 in /builds/slave/test 10:07:14 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 10:07:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:14 INFO - {'append_to_log': False, 10:07:14 INFO - 'base_work_dir': '/builds/slave/test', 10:07:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:07:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:14 INFO - 'branch': 'Mozilla-Inbound', 10:07:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:14 INFO - 'config_files': ('talos/linux_config.py',), 10:07:14 INFO - 'default_actions': ('clobber', 10:07:14 INFO - 'read-buildbot-config', 10:07:14 INFO - 'download-and-extract', 10:07:14 INFO - 'populate-webroot', 10:07:14 INFO - 'create-virtualenv', 10:07:14 INFO - 'install', 10:07:14 INFO - 'run-tests'), 10:07:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:14 INFO - 'download_minidump_stackwalk': True, 10:07:14 INFO - 'download_symbols': 'ondemand', 10:07:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:14 INFO - 'installer_path': 'installer.exe', 10:07:14 INFO - 'log_level': 'info', 10:07:14 INFO - 'log_name': 'talos', 10:07:14 INFO - 'log_to_console': True, 10:07:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:14 INFO - 'opt_config_files': (), 10:07:14 INFO - 'pip_index': False, 10:07:14 INFO - 'sps_profile': False, 10:07:14 INFO - 'sps_profile_interval': 0, 10:07:14 INFO - 'suite': 'dromaeojs-e10s', 10:07:14 INFO - 'system_bits': '32', 10:07:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:14 INFO - 'title': 'talos-linux64-ix-009', 10:07:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:14 INFO - 'use_talos_json': True, 10:07:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:14 INFO - 'work_dir': 'build'} 10:07:14 INFO - ##### 10:07:14 INFO - ##### Running clobber step. 10:07:14 INFO - ##### 10:07:14 INFO - Running pre-action listener: _resource_record_pre_action 10:07:14 INFO - Running main action method: clobber 10:07:14 INFO - rmtree: /builds/slave/test/build 10:07:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:17 INFO - Running post-action listener: _resource_record_post_action 10:07:17 INFO - ##### 10:07:17 INFO - ##### Running read-buildbot-config step. 10:07:17 INFO - ##### 10:07:17 INFO - Running pre-action listener: _resource_record_pre_action 10:07:17 INFO - Running main action method: read_buildbot_config 10:07:17 INFO - Using buildbot properties: 10:07:17 INFO - { 10:07:17 INFO - "project": "", 10:07:17 INFO - "product": "firefox", 10:07:17 INFO - "script_repo_revision": "production", 10:07:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:07:17 INFO - "repository": "", 10:07:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:07:17 INFO - "buildid": "20160416073335", 10:07:17 INFO - "pgo_build": "True", 10:07:17 INFO - "basedir": "/builds/slave/test", 10:07:17 INFO - "buildnumber": 944, 10:07:17 INFO - "slavename": "talos-linux64-ix-009", 10:07:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:07:17 INFO - "platform": "ubuntu64_hw", 10:07:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:07:17 INFO - "branch": "mozilla-inbound", 10:07:17 INFO - "repo_path": "integration/mozilla-inbound", 10:07:17 INFO - "revision": "037893f93079315cf4dfaac7e6ae6691876abcc6", 10:07:17 INFO - "stage_platform": "linux64-pgo", 10:07:17 INFO - "builduid": "c5ea970218e54896a87139a1620fbfd5", 10:07:17 INFO - "slavebuilddir": "test" 10:07:17 INFO - } 10:07:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:07:17 INFO - Running post-action listener: _resource_record_post_action 10:07:17 INFO - ##### 10:07:17 INFO - ##### Running download-and-extract step. 10:07:17 INFO - ##### 10:07:17 INFO - Running pre-action listener: _resource_record_pre_action 10:07:17 INFO - Running main action method: download_and_extract 10:07:17 INFO - mkdir: /builds/slave/test/build/tests 10:07: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')]} 10:07:17 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:07:25 INFO - Downloaded 1361 bytes. 10:07:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:25 INFO - Using the following test package requirements: 10:07:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'jsshell-linux-x86_64.zip'], 10:07:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:25 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')]} 10:07:25 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:33 INFO - Downloaded 23777241 bytes. 10:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:35 INFO - Return code: 0 10:07:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:40 INFO - Downloaded 23777241 bytes. 10:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:41 INFO - Return code: 0 10:07:41 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')]} 10:07:41 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:07:43 INFO - Downloaded 10845952 bytes. 10:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:07:44 INFO - Return code: 0 10:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:44 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:07:47 INFO - Downloaded 58240113 bytes. 10:07:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:47 INFO - mkdir: /builds/slave/test/properties 10:07:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:47 INFO - Contents: 10:07:47 INFO - build_url:https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:48 INFO - Running post-action listener: _resource_record_post_action 10:07:48 INFO - Running post-action listener: set_extra_try_arguments 10:07:48 INFO - ##### 10:07:48 INFO - ##### Running populate-webroot step. 10:07:48 INFO - ##### 10:07:48 INFO - Running pre-action listener: _resource_record_pre_action 10:07:48 INFO - Running main action method: populate_webroot 10:07:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:48 INFO - '--tppagecycles', 10:07:48 INFO - '7'], 10:07:48 INFO - 'tests': ['tsvgm']}}, 10:07:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['damp', 'tps']}, 10:07:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'tests': ['damp', 'tps']}, 10:07:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['dromaeo_dom']}, 10:07:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['a11yr', 10:07:48 INFO - 'ts_paint', 10:07:48 INFO - 'tpaint', 10:07:48 INFO - 'sessionrestore', 10:07:48 INFO - 'sessionrestore_no_auto_restore', 10:07:48 INFO - 'tabpaint']}, 10:07:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['tsvgx', 10:07:48 INFO - 'tsvgr_opacity', 10:07:48 INFO - 'tart', 10:07:48 INFO - 'tscrollx', 10:07:48 INFO - 'cart']}, 10:07:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:48 INFO - 'tsvgr_opacity', 10:07:48 INFO - 'tart', 10:07:48 INFO - 'tscrollx', 10:07:48 INFO - 'cart']}, 10:07:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'talos_options': ['--disable-e10s'], 10:07:48 INFO - 'tests': ['tp5o']}, 10:07:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'tests': ['tp5o']}, 10:07:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'talos_options': ['--disable-e10s', 10:07:48 INFO - '--xperf_path', 10:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:48 INFO - 'tests': ['tp5n']}, 10:07:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:48 INFO - 'talos_options': ['--xperf_path', 10:07:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:48 INFO - 'tests': ['tp5n']}}, 10:07:48 INFO - 'talos.zip': {'path': '', 10:07:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:48 INFO - Running post-action listener: _resource_record_post_action 10:07:48 INFO - ##### 10:07:48 INFO - ##### Running create-virtualenv step. 10:07:48 INFO - ##### 10:07:48 INFO - Running pre-action listener: _resource_record_pre_action 10:07:48 INFO - Running main action method: create_virtualenv 10:07:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:07:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:48 INFO - Using real prefix '/usr' 10:07:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:51 INFO - Installing pip.................done. 10:07:51 INFO - Return code: 0 10:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:51 INFO - Using env: {'DISPLAY': ':0', 10:07:51 INFO - 'HOME': '/home/cltbld', 10:07:51 INFO - 'LANG': 'en_US.UTF-8', 10:07:51 INFO - 'LANGUAGE': 'en_US:en', 10:07:51 INFO - 'LOGNAME': 'cltbld', 10:07:51 INFO - 'MAIL': '/var/mail/cltbld', 10:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:51 INFO - 'MOZ_NO_REMOTE': '1', 10:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:51 INFO - 'NO_EM_RESTART': '1', 10:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:51 INFO - 'PWD': '/builds/slave/test', 10:07:51 INFO - 'SHELL': '/bin/bash', 10:07:51 INFO - 'SHLVL': '1', 10:07:51 INFO - 'TERM': 'linux', 10:07:51 INFO - 'TMOUT': '86400', 10:07:51 INFO - 'USER': 'cltbld', 10:07:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:51 INFO - '_': '/tools/buildbot/bin/python'} 10:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:07:51 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:07:52 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')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 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')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:07:52 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 10:07:52 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 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Downloading/unpacking psutil>=0.7.1 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:54 INFO - Installing collected packages: psutil 10:07:54 INFO - Running setup.py install for psutil 10:07:54 INFO - building 'psutil._psutil_linux' extension 10:07:54 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 10:07:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:07:55 INFO - building 'psutil._psutil_posix' extension 10:07:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:07:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:07:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:55 INFO - Successfully installed psutil 10:07:55 INFO - Cleaning up... 10:07:55 INFO - Return code: 0 10:07:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:07:55 INFO - Using env: {'DISPLAY': ':0', 10:07:55 INFO - 'HOME': '/home/cltbld', 10:07:55 INFO - 'LANG': 'en_US.UTF-8', 10:07:55 INFO - 'LANGUAGE': 'en_US:en', 10:07:55 INFO - 'LOGNAME': 'cltbld', 10:07:55 INFO - 'MAIL': '/var/mail/cltbld', 10:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:55 INFO - 'MOZ_NO_REMOTE': '1', 10:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:55 INFO - 'NO_EM_RESTART': '1', 10:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:55 INFO - 'PWD': '/builds/slave/test', 10:07:55 INFO - 'SHELL': '/bin/bash', 10:07:55 INFO - 'SHLVL': '1', 10:07:55 INFO - 'TERM': 'linux', 10:07:55 INFO - 'TMOUT': '86400', 10:07:55 INFO - 'USER': 'cltbld', 10:07:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:55 INFO - '_': '/tools/buildbot/bin/python'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:58 INFO - Installing collected packages: mozsystemmonitor 10:07:58 INFO - Running setup.py install for mozsystemmonitor 10:07:58 INFO - Successfully installed mozsystemmonitor 10:07:58 INFO - Cleaning up... 10:07:58 INFO - Return code: 0 10:07:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:58 INFO - Using env: {'DISPLAY': ':0', 10:07:58 INFO - 'HOME': '/home/cltbld', 10:07:58 INFO - 'LANG': 'en_US.UTF-8', 10:07:58 INFO - 'LANGUAGE': 'en_US:en', 10:07:58 INFO - 'LOGNAME': 'cltbld', 10:07:58 INFO - 'MAIL': '/var/mail/cltbld', 10:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:58 INFO - 'MOZ_NO_REMOTE': '1', 10:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:58 INFO - 'NO_EM_RESTART': '1', 10:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:58 INFO - 'PWD': '/builds/slave/test', 10:07:58 INFO - 'SHELL': '/bin/bash', 10:07:58 INFO - 'SHLVL': '1', 10:07:58 INFO - 'TERM': 'linux', 10:07:58 INFO - 'TMOUT': '86400', 10:07:58 INFO - 'USER': 'cltbld', 10:07:58 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:58 INFO - '_': '/tools/buildbot/bin/python'} 10:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading docopt-0.6.1.tar.gz 10:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:01 INFO - Running setup.py install for blobuploader 10:08:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:01 INFO - Running setup.py install for requests 10:08:01 INFO - Running setup.py install for docopt 10:08:01 INFO - Successfully installed blobuploader requests docopt 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:08:01 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 10:08:01 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 10:08:01 INFO - Using env: {'DISPLAY': ':0', 10:08:01 INFO - 'HOME': '/home/cltbld', 10:08:01 INFO - 'LANG': 'en_US.UTF-8', 10:08:01 INFO - 'LANGUAGE': 'en_US:en', 10:08:01 INFO - 'LOGNAME': 'cltbld', 10:08:01 INFO - 'MAIL': '/var/mail/cltbld', 10:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:01 INFO - 'MOZ_NO_REMOTE': '1', 10:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:01 INFO - 'NO_EM_RESTART': '1', 10:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:01 INFO - 'PWD': '/builds/slave/test', 10:08:01 INFO - 'SHELL': '/bin/bash', 10:08:01 INFO - 'SHLVL': '1', 10:08:01 INFO - 'TERM': 'linux', 10:08:01 INFO - 'TMOUT': '86400', 10:08:01 INFO - 'USER': 'cltbld', 10:08:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:01 INFO - '_': '/tools/buildbot/bin/python'} 10:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 INFO - Running setup.py (path:/tmp/pip-VY3Qmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 INFO - Running setup.py (path:/tmp/pip-Nr3_4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:01 INFO - Running setup.py (path:/tmp/pip-KQmXrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 INFO - Running setup.py (path:/tmp/pip-SB3_wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:02 INFO - Running setup.py (path:/tmp/pip-2J4NMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:02 INFO - Running setup.py (path:/tmp/pip-o3jecb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:02 INFO - Running setup.py (path:/tmp/pip-XIuDSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:02 INFO - Running setup.py (path:/tmp/pip-Qe3JAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:02 INFO - Running setup.py (path:/tmp/pip-IxyHNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:02 INFO - Running setup.py (path:/tmp/pip-4ZWFuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 INFO - Running setup.py (path:/tmp/pip-XXa_IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 INFO - Running setup.py (path:/tmp/pip-HTy6V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 INFO - Running setup.py (path:/tmp/pip-3UPOp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 INFO - Running setup.py (path:/tmp/pip-m8e1r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 INFO - Running setup.py (path:/tmp/pip-wGMCCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:02 INFO - Running setup.py (path:/tmp/pip-kNH0R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:02 INFO - Running setup.py (path:/tmp/pip-9XfY6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:03 INFO - Running setup.py install for manifestparser 10:08:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Running setup.py install for mozcrash 10:08:03 INFO - Running setup.py install for mozdebug 10:08:03 INFO - Running setup.py install for mozdevice 10:08:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Running setup.py install for mozfile 10:08:03 INFO - Running setup.py install for mozhttpd 10:08:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Running setup.py install for mozinfo 10:08:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Running setup.py install for mozInstall 10:08:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:03 INFO - Running setup.py install for mozleak 10:08:03 INFO - Running setup.py install for mozlog 10:08:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Running setup.py install for moznetwork 10:08:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Running setup.py install for mozprocess 10:08:04 INFO - Running setup.py install for mozprofile 10:08:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Running setup.py install for mozrunner 10:08:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Running setup.py install for mozscreenshot 10:08:04 INFO - Running setup.py install for moztest 10:08:04 INFO - Running setup.py install for mozversion 10:08:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:04 INFO - Cleaning up... 10:08:04 INFO - Return code: 0 10:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:04 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')]} 10:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 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')]} 10:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:08:04 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 10:08:04 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 10:08:04 INFO - Using env: {'DISPLAY': ':0', 10:08:04 INFO - 'HOME': '/home/cltbld', 10:08:04 INFO - 'LANG': 'en_US.UTF-8', 10:08:04 INFO - 'LANGUAGE': 'en_US:en', 10:08:04 INFO - 'LOGNAME': 'cltbld', 10:08:04 INFO - 'MAIL': '/var/mail/cltbld', 10:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:04 INFO - 'MOZ_NO_REMOTE': '1', 10:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:04 INFO - 'NO_EM_RESTART': '1', 10:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:04 INFO - 'PWD': '/builds/slave/test', 10:08:04 INFO - 'SHELL': '/bin/bash', 10:08:04 INFO - 'SHLVL': '1', 10:08:04 INFO - 'TERM': 'linux', 10:08:04 INFO - 'TMOUT': '86400', 10:08:04 INFO - 'USER': 'cltbld', 10:08:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:04 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:05 INFO - Running setup.py (path:/tmp/pip-VhnTEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:05 INFO - Running setup.py (path:/tmp/pip-HaaRHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:05 INFO - Running setup.py (path:/tmp/pip-JQY_ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:05 INFO - Running setup.py (path:/tmp/pip-FAm3dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:05 INFO - Running setup.py (path:/tmp/pip-g9UKmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:05 INFO - Running setup.py (path:/tmp/pip-N3wYKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:05 INFO - Running setup.py (path:/tmp/pip-KdnJ_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:05 INFO - Running setup.py (path:/tmp/pip-ZenU1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:05 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)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:05 INFO - Running setup.py (path:/tmp/pip-x1hS5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:05 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)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:05 INFO - Running setup.py (path:/tmp/pip-8aS2vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:05 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)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:05 INFO - Running setup.py (path:/tmp/pip-BUjaf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:05 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)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:05 INFO - Running setup.py (path:/tmp/pip-vXJbZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:05 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)) 10:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:05 INFO - Running setup.py (path:/tmp/pip-jjsUu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:06 INFO - Running setup.py (path:/tmp/pip-BnGcFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:06 INFO - Running setup.py (path:/tmp/pip-iMxYGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:06 INFO - Running setup.py (path:/tmp/pip-44_La2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:06 INFO - Running setup.py (path:/tmp/pip-i6TemE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:08:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:08 INFO - Downloading blessings-1.6.tar.gz 10:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:08 INFO - Installing collected packages: blessings 10:08:08 INFO - Running setup.py install for blessings 10:08:08 INFO - Successfully installed blessings 10:08:08 INFO - Cleaning up... 10:08:08 INFO - Return code: 0 10:08:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:08 INFO - Reading from file tmpfile_stdout 10:08:08 INFO - Current package versions: 10:08:08 INFO - argparse == 1.2.1 10:08:08 INFO - blessings == 1.6 10:08:08 INFO - blobuploader == 1.2.4 10:08:08 INFO - docopt == 0.6.1 10:08:08 INFO - manifestparser == 1.1 10:08:08 INFO - mozInstall == 1.12 10:08:08 INFO - mozcrash == 0.17 10:08:08 INFO - mozdebug == 0.1 10:08:08 INFO - mozdevice == 0.48 10:08:08 INFO - mozfile == 1.2 10:08:08 INFO - mozhttpd == 0.7 10:08:08 INFO - mozinfo == 0.9 10:08:08 INFO - mozleak == 0.1 10:08:08 INFO - mozlog == 3.1 10:08:08 INFO - moznetwork == 0.27 10:08:08 INFO - mozprocess == 0.22 10:08:08 INFO - mozprofile == 0.28 10:08:08 INFO - mozrunner == 6.11 10:08:08 INFO - mozscreenshot == 0.1 10:08:08 INFO - mozsystemmonitor == 0.0 10:08:08 INFO - moztest == 0.7 10:08:08 INFO - mozversion == 1.4 10:08:08 INFO - psutil == 3.1.1 10:08:08 INFO - requests == 1.2.3 10:08:08 INFO - wsgiref == 0.1.2 10:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:08:08 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 10:08:08 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 10:08:08 INFO - Using env: {'DISPLAY': ':0', 10:08:08 INFO - 'HOME': '/home/cltbld', 10:08:08 INFO - 'LANG': 'en_US.UTF-8', 10:08:08 INFO - 'LANGUAGE': 'en_US:en', 10:08:08 INFO - 'LOGNAME': 'cltbld', 10:08:08 INFO - 'MAIL': '/var/mail/cltbld', 10:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:08 INFO - 'MOZ_NO_REMOTE': '1', 10:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:08 INFO - 'NO_EM_RESTART': '1', 10:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:08 INFO - 'PWD': '/builds/slave/test', 10:08:08 INFO - 'SHELL': '/bin/bash', 10:08:08 INFO - 'SHLVL': '1', 10:08:08 INFO - 'TERM': 'linux', 10:08:08 INFO - 'TMOUT': '86400', 10:08:08 INFO - 'USER': 'cltbld', 10:08:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:08 INFO - '_': '/tools/buildbot/bin/python'} 10:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 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)) 10:08:08 INFO - Cleaning up... 10:08:08 INFO - Return code: 0 10:08:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 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 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:08:08 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 10:08:08 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 10:08:08 INFO - Using env: {'DISPLAY': ':0', 10:08:08 INFO - 'HOME': '/home/cltbld', 10:08:08 INFO - 'LANG': 'en_US.UTF-8', 10:08:08 INFO - 'LANGUAGE': 'en_US:en', 10:08:08 INFO - 'LOGNAME': 'cltbld', 10:08:08 INFO - 'MAIL': '/var/mail/cltbld', 10:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:08 INFO - 'MOZ_NO_REMOTE': '1', 10:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:08 INFO - 'NO_EM_RESTART': '1', 10:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:08 INFO - 'PWD': '/builds/slave/test', 10:08:08 INFO - 'SHELL': '/bin/bash', 10:08:08 INFO - 'SHLVL': '1', 10:08:08 INFO - 'TERM': 'linux', 10:08:08 INFO - 'TMOUT': '86400', 10:08:08 INFO - 'USER': 'cltbld', 10:08:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:08 INFO - '_': '/tools/buildbot/bin/python'} 10:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:09 INFO - Downloading/unpacking jsonschema 10:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:11 INFO - warning: no files found matching '*.txt' 10:08:11 INFO - no previously-included directories found matching 'build' 10:08:11 INFO - no previously-included directories found matching 'dist' 10:08:11 INFO - no previously-included directories found matching '.git*' 10:08:11 INFO - Installing collected packages: jsonschema, functools32 10:08:11 INFO - Running setup.py install for functools32 10:08:11 INFO - warning: no files found matching '*.txt' 10:08:11 INFO - no previously-included directories found matching 'build' 10:08:11 INFO - no previously-included directories found matching 'dist' 10:08:11 INFO - no previously-included directories found matching '.git*' 10:08:11 INFO - Successfully installed jsonschema functools32 10:08:11 INFO - Cleaning up... 10:08:11 INFO - Return code: 0 10:08:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc905a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', '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 10:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:08:11 INFO - Using env: {'DISPLAY': ':0', 10:08:11 INFO - 'HOME': '/home/cltbld', 10:08:11 INFO - 'LANG': 'en_US.UTF-8', 10:08:11 INFO - 'LANGUAGE': 'en_US:en', 10:08:11 INFO - 'LOGNAME': 'cltbld', 10:08:11 INFO - 'MAIL': '/var/mail/cltbld', 10:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:11 INFO - 'MOZ_NO_REMOTE': '1', 10:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:11 INFO - 'NO_EM_RESTART': '1', 10:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:11 INFO - 'PWD': '/builds/slave/test', 10:08:11 INFO - 'SHELL': '/bin/bash', 10:08:11 INFO - 'SHLVL': '1', 10:08:11 INFO - 'TERM': 'linux', 10:08:11 INFO - 'TMOUT': '86400', 10:08:11 INFO - 'USER': 'cltbld', 10:08:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:11 INFO - '_': '/tools/buildbot/bin/python'} 10:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:11 INFO - Downloading/unpacking flake8 10:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:08:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:08:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:14 INFO - no previously-included directories found matching 'docs/_build' 10:08:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:08:14 INFO - Running setup.py install for pep8 10:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:14 INFO - no previously-included directories found matching 'docs/_build' 10:08:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:08:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:08:14 INFO - Cleaning up... 10:08:14 INFO - Return code: 0 10:08:14 INFO - Running post-action listener: _resource_record_post_action 10:08:14 INFO - Running post-action listener: _start_resource_monitoring 10:08:14 INFO - Starting resource monitoring. 10:08:14 INFO - ##### 10:08:14 INFO - ##### Running install step. 10:08:14 INFO - ##### 10:08:14 INFO - Running pre-action listener: _resource_record_pre_action 10:08:14 INFO - Running main action method: install 10:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:14 INFO - Reading from file tmpfile_stdout 10:08:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:14 INFO - Reading from file tmpfile_stdout 10:08:14 INFO - Output received: 10:08:14 INFO - Usage: mozinstall [options] installer 10:08:14 INFO - Options: 10:08:14 INFO - -h, --help show this help message and exit 10:08:14 INFO - -d DEST, --destination=DEST 10:08:14 INFO - Directory to install application into. [default: 10:08:14 INFO - "/builds/slave/test"] 10:08:14 INFO - --app=APP Application being installed. [default: firefox] 10:08:14 INFO - mkdir: /builds/slave/test/build/application 10:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:08:31 INFO - Reading from file tmpfile_stdout 10:08:31 INFO - Output received: 10:08:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:31 INFO - Running post-action listener: _resource_record_post_action 10:08:31 INFO - ##### 10:08:31 INFO - ##### Running run-tests step. 10:08:31 INFO - ##### 10:08:31 INFO - Running pre-action listener: _resource_record_pre_action 10:08:31 INFO - Running main action method: run_tests 10:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:31 INFO - Python 2.7.3 10:08:31 INFO - Return code: 0 10:08:31 INFO - grabbing minidump binary from tooltool 10:08: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')]} 10:08:31 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 0xfcf410>, '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 0xfd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:31 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 10:08:31 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 10:08:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:31 INFO - Return code: 0 10:08:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:08:32 INFO - Return code: 0 10:08:32 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 10:08:32 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 10:08:32 INFO - Using env: {'DISPLAY': ':0', 10:08:32 INFO - 'HOME': '/home/cltbld', 10:08:32 INFO - 'LANG': 'en_US.UTF-8', 10:08:32 INFO - 'LANGUAGE': 'en_US:en', 10:08:32 INFO - 'LOGNAME': 'cltbld', 10:08:32 INFO - 'MAIL': '/var/mail/cltbld', 10:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:32 INFO - 'MOZ_NO_REMOTE': '1', 10:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:32 INFO - 'NO_EM_RESTART': '1', 10:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:32 INFO - 'PWD': '/builds/slave/test', 10:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:32 INFO - 'SHELL': '/bin/bash', 10:08:32 INFO - 'SHLVL': '1', 10:08:32 INFO - 'TERM': 'linux', 10:08:32 INFO - 'TMOUT': '86400', 10:08:32 INFO - 'USER': 'cltbld', 10:08:32 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570', 10:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:32 INFO - '_': '/tools/buildbot/bin/python'} 10:08:32 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 10:08:33 INFO - mozversion application_buildid: 20160416073335 10:08:33 INFO - mozversion application_changeset: 037893f93079315cf4dfaac7e6ae6691876abcc6 10:08:33 INFO - mozversion application_display_name: Nightly 10:08:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:33 INFO - mozversion application_name: Firefox 10:08:33 INFO - mozversion application_remotingname: firefox 10:08:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:33 INFO - mozversion application_vendor: Mozilla 10:08:33 INFO - mozversion application_version: 48.0a1 10:08:33 INFO - mozversion platform_buildid: 20160416073335 10:08:33 INFO - mozversion platform_changeset: 037893f93079315cf4dfaac7e6ae6691876abcc6 10:08:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:33 INFO - mozversion platform_version: 48.0a1 10:08:33 INFO - using testdate: 1460826513 10:08:33 INFO - actual date: 1460826513 10:08:33 INFO - starting webserver on 'localhost:51239' 10:08:33 INFO - SUITE-START | Running 2 tests 10:08:33 INFO - TEST-START | dromaeo_css 10:08:33 INFO - operating with platform_type : linux_ 10:08:33 INFO - Initialising browser for dromaeo_css test... 10:08:33 INFO - TEST-INFO | started process 3314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkg8E_/profile http://localhost:51239/getInfo.html) 10:08:38 INFO - PROCESS | 3314 | 10:08:38 INFO - PROCESS | 3314 | (process:3384): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:08:39 INFO - PROCESS | 3314 | __metrics Screen width/height:1600/1200 10:08:39 INFO - PROCESS | 3314 | colorDepth:24 10:08:39 INFO - PROCESS | 3314 | Browser inner width/height: 1024/697 10:08:39 INFO - PROCESS | 3314 | __metrics 10:08:40 ERROR - PROCESS | 3314 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:08:40 INFO - TEST-INFO | 3314: exit 0 10:08:40 INFO - Browser initialized. 10:08:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:40 INFO - TEST-INFO | started process 3435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkg8E_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:42 INFO - PROCESS | 3435 | 10:08:42 INFO - PROCESS | 3435 | (process:3494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:08:52 INFO - PROCESS | 3435 | RSS: Main: 163405824 10:08:52 INFO - PROCESS | 3435 | 10:09:42 INFO - PROCESS | 3435 | 1460826582369 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] 10:11:49 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51239/tests/dromaeo/cssquery-ext.html) 10:11:51 INFO - PROCESS | 3435 | RSS: Main: 167903232 10:11:51 INFO - PROCESS | 3435 | 10:14:53 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-ext.html (next: http://localhost:51239/tests/dromaeo/cssquery-jquery.html) 10:14:53 INFO - PROCESS | 3435 | RSS: Main: 165675008 10:14:53 INFO - PROCESS | 3435 | 10:17:55 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51239/tests/dromaeo/cssquery-mootools.html) 10:17:56 INFO - PROCESS | 3435 | RSS: Main: 166494208 10:17:56 INFO - PROCESS | 3435 | 10:20:57 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51239/tests/dromaeo/cssquery-prototype.html) 10:20:58 INFO - PROCESS | 3435 | RSS: Main: 164429824 10:20:58 INFO - PROCESS | 3435 | 10:24:00 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51239/tests/dromaeo/cssquery-yui.html) 10:24:01 INFO - PROCESS | 3435 | RSS: Main: 165740544 10:24:01 INFO - PROCESS | 3435 | 10:27:03 INFO - PROCESS | 3435 | Cycle 1(1): loaded http://localhost:51239/tests/dromaeo/cssquery-yui.html (next: http://localhost:51239/tests/dromaeo/cssquery-dojo.html) 10:27:04 INFO - PROCESS | 3435 | RSS: Main: 167800832 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | __start_tp_report 10:27:04 INFO - PROCESS | 3435 | _x_x_mozilla_page_load 10:27:04 INFO - PROCESS | 3435 | _x_x_mozilla_page_load_details 10:27:04 INFO - PROCESS | 3435 | |i|pagename|runs| 10:27:04 INFO - PROCESS | 3435 | |0;dojo.html;3076.200187951135;3079.799813012154;3111.4243864884997;3112.937741245175;3133.5769671094404;5278.419373868876;5310.814121505743;5320.813771517997;5327.360716713995;5331.2003199520095;5323.22813192087;5352.116900711378;5357.892842143155;5361.169018802082;5437.728113594324;4821.783019764111;4862.14912390332;4918.188498897677;4927.50724927508;4963;4704.294355846633;4816.686915350491;4842.394700662418;4856.611471082305;4864.46490886004;4819.734914579697;4824.5899098576665;4833.178359678863;4835.903281934359;4856.028794241148;4827.155247831651;4838.395200599925;4843.854684359475;4864.683795553277;4883.8779030524165;4699.7415142167165;4781.330613714083;4810.11012962603;4852.0295940811975;4898.8775280618265;5195.610329225323;5220.843374698765;5226.895462090775;5232.058229518685;5261.86845328866;5625;5630.0991841305195;5630.859228519279;5632.07070833312;5649.12438572022;5581.916271255935;5696;5730.283714535683;5802.65184088956;5825.9417405825825;5248.606354523426;5254.842354729364;5255.159174532095;5262.2632831403635;5267.341582302174;5743.511801496919;5746.195532625436;5757.050086735725;5775.27809023872;5803.9419605803405;5449.455054494598;5550.694711790809;5623.943760562423;5682.914756278659;5732;5675.77296908119;5691.060974939089;5692.943070569241;5703.40114288002;5703.800366987136;5567.053600887859;5624.690642014647;5661.405552417019;5666.036773748473;5681.920435117398;5548.667079975215;5648.068068768607;5736.942630573724;5739;5763.135529670583;4315.438992930899;4317.201317756225;4320.870373888788;4341.435613370305;4378.824847006084;3868.3810590305416;3876.3991581304945;3895.3962135868987;3898.1034362096875;3899.532056153223;5300.814471493479;5314.946850531445;5382.219578161144;5382.91925621116;5384.784608615611;5717.542596592262;5718.456746609066;5739.110437882135;5740.913886291709;5791.015527360359;5347.919781203285;5402.837914862561;5405.108157154104;5415.539679127318;5421.295231619864;4832.806687732451;4920.40955085392;4935.037667654845;4944.406671199407;4988.152014157602;5930.851728706817;5932.584719069624;5935.792247271324;5939.821805345847;5949.762009519657;5698.1452782083015;5736.053551164011;5745.999999999916;5753.1945527627;5761.193432919311;5777.306723193244;5878.617889837147;5914.526837853047;5953.3153687324775;5994.880102398015;5552.639078459887;5555.194496798023;5561.054620714407;5563.58273129525;5570.86072848182;5599.552035837205;5638.4925356718095;5644.294463192101;5647.632903861236;5660.915086273627;5477.04151773446;5610.4670056344585;5687.43125687428;5725.055365864586;5743.195952566728;5571.470710282517;5574.888502229852;5580.107182850725;5582.413846546055;5594.664320140804;5390.946090539044;5474.644148130359;5509.807156749494;5524.806631767869;5557.027520184032;5539.612227144061;5612.186232996111;5668.404817494104;5672.14917762339;5675.489205971482;5466.289382380265;5488.862778430571;5500.614956953135;5503.504684578407;5552.167174923794 10:27:04 INFO - PROCESS | 3435 | |1;ext.html;595.9225300710907;626.3923993726087;637.2957881540897;641.9775307864224;671.6809515480145;35334.11664708381;36340.99999999996;36405.90549803267;36419.27161456769;36494.8175259124;35670.10824729376;36464.08839779007;36561.45157822628;36591.26817463649;36726.26547469049;8501.532415717133;8713.085126061767;8737.301015918743;8739.213470787628;8740.956295218515;8626.35302352323;8709.172628600272;8713.172248636401;8713.695020674279;8714.607842647065;8659.307255419551;8700.390972631918;8710.128987101303;8764.29885609153;8777.561121943909;8606.354523410739;8691.304695624334;8696.043435222153;8706.825863482694;8713.085126061767;8560.229579337827;8598;8612.52631105289;8629.266512346396;8667.783305417352;33107.834460827784;36737.632623673686;37335.81332093349;37518;37595.62404375976;3254.7721659483846;3468.757186996911;3471.9652803472145;3513.472979053137;3799.9740070181174;26505.46989060227;26707;26868.462630747275;27110.5933410999;27229.727702722917;3869.941950870739;3872.148127411993;3933.3116704576582;4043.97978010111;4071.653909417703;178759;180834;181735;182018;183095.08452457786;34285.314293713986;34300.656993429744;34400.311993759984;34560.82719586386;34589.13527161841;66215;68295.65852170707;68388;68666.96999545011;68742.65628671825;16502.917485412738;16814.579635508966;16924.57688557796;17045.91477042607;17063.23215455283;12575.811362829565;12581.87418125807;12642.683932901751;12659.49362025527;12720.809187862189;19330.936798475937;19482.318118865773;19522;19580.314688985818;19698.31055913065;7161.4986950912935;7288.526245794006;7382.151052629017;7397.445191610651;7459.3286604204795;1025.3437799808128;1043.9530221140067;1105.8728246251624;1162.5466068233395;1168.5968340922368;31056;31332.843335783175;31446.842765786023;31561.684383156335;31626;1091.121647074113;1113.5768408005067;1133.2237417369129;1146.5814977533141;1156.7108222944264;16771.496855094367;16945.32218711238;16974.83025169757;17127.14364281781;17191.914040429718;428469;430872;432711;433526;435417;54310;55286.447135528935;55495.722521387135;55627.72186139043;55629;1227.147132742753;1341.8993575481877;1371.739369519788;1383.2392184298394;1392.6866455047534;30227.546586800774;30359.419449347053;30422.695773041985;30867.536986945663;31183;49044.50955490399;49406.50593494019;49557.256641151136;49566;49569.752151239016;382344;384337;385794;386308;386533;27627;28167;41580.58419415767;43736.34395484134;43842.780786095864;40689;41168.588314117675;41305.380419294335;42064;42245.577544224165;35212.47181292334;35273.647263528066;35522.289554208255;35620.46569301515;35668.64331356757;34372;35198.64801351954;35274.64725352714;35485;35769.82115089408;39473;40644.79677601593;41727.37408938929;42098.158036839704;42190.367144492244;29255;32339.16637926321;32513.67486325201;34050;34453.483197752554;26650.333741656614;27236.910523578834;27268.863655681595;27466.5880011796;27881.302967425978 10:27:04 INFO - PROCESS | 3435 | |2;jquery.html;381.61647544218056;387.780903789359;392.1182266009852;394.46746891696216;404.58125839755843;14524.854751452482;17463.650726985452;17614.47156585303;18188.272469101237;18315.816841831595;18046.458606241835;18242.5439364016;18447.169877355518;18991.33530326439;19104.044797760125;5665.660060396379;5744.942550574503;5877.764889404419;5891.970540147293;5902.085176797603;5709.371969083398;5818.301803783531;5842.970785146068;5846.619969701956;5854;5671.347795003586;5709.182884424473;5823.330317013555;5831.7958871439505;5851.5318774498155;5581.553475721932;5762.4525670061275;5787.681677507735;5813.563982701293;5814.622049566807;5187.403448603422;5202.037623039712;5225.581953443753;5229.2417599448245;5231.372235331746;22153.335399938027;22262.443438913993;22825;23579;23596.528069438515;2274.727032756063;2286.874221917794;2424.175780234711;2446.8287219894614;2815.5072862249026;13758.862411375858;14341.784873226805;14448;14787.704245915022;14924.179170145637;1909.3794516782102;1925.5763731978943;1942.77658069321;1979.237993372562;1987.6322880267196;77609.61195193988;77973.61013194955;78149.60925195394;78435;80107.59946200231;10068.986202759477;10074.597016119273;10247.436390998417;10290.588376465008;10383.325083869524;12563.937180314222;12835.45974483068;14050.648733781738;14054.297285135703;14160.433582656578;7427.591482468516;7486.663100160506;7964.20357964199;8109.5134291941495;8171.673133074611;8024.117347091816;8080.71717489885;8128.9593552031865;8170.060443049007;8298.917010829815;6158.920539730135;6260.558382230934;6340.587861789061;6343.333949935282;6364.172657554488;1824.744535764994;1835.733818596296;1837.3569250762125;1848.5471059590486;1872.7639757759814;971.358903123949;1000.314784372707;1029.5675816157081;1158.195054437158;1170.9180357375071;19230.23079076849;19340.903295483433;19520.90239548793;19610.607787844165;19614.70577941332;1001.7545701303081;1042.7862288231047;1074.4949873559415;1122.3882983773863;1142.4459137318395;10953.233273670767;10980.725481863017;11155.386453745123;11221.94389028066;11290.322580645188;360613;361258;361393;362359;490708;75866.24133758702;80370;84517.57741211378;96270;98250;1070.903618674323;1077.6874706335232;1095.2990086344905;1106.623747925709;1111.1333160135107;15688.294026768595;16504.33982640681;17105.74341384905;17208.05355705448;17307.56731081733;37213;38141;39433.80283098681;40601.390979135926;42108.36837447502;50774.74612626913;51200.48799511957;51447.48552514577;52270.47729522656;52525.68685782886;7969.163237859942;8290.917090829014;8594.441361311494;8633.611487482953;8744.300455963636;11940.701482463008;13609.659758506117;13693;13695.315234238447;13767;5933.465988060922;9061.77345566366;11809.350485723367;11909.285442873455;12058.879411205775;11516.437432914872;11644.475998579916;11846.585369512026;11919.046476281703;11998.220115692453;12060.216085954386;12125.27248365101;12203.328816915155;12265.938670306592;12357.93821030889;8103.25779957312;8432.325413966746;8626.137386261575;8678.262347700516;8688.131186881514;11000.669979900616;11641.476133574179;11736.882631173921;11783.528658853893;12112.273263604213 10:27:04 INFO - PROCESS | 3435 | |3;mootools.html;1505.0142156887239;1521.946731864385;1673.5899704572382;1783.4025601423523;1844.0963927675434;7422.035135432399;7946.801329966754;8176.38677099217;8288.834223315538;8308.127646597111;8071.757847264576;8097.838043239147;8150.307223885962;8207.05618853832;8252.91747082529;2270.5231901300704;2299.4596269876565;2303.1823702585593;2305.7578954209816;2313.8495997760174;2204.7464541577765;2211.1155537784853;2252.5157091225383;2253.2339004738387;2254.9436264093447;2268.625676763332;2276.738175109867;2291.255342013844;2291.8395712300144;2303.8272129590264;2207.4481379655085;2213;2214.3246309875562;2216.8891555422247;2222.5777102350503;2187.1907394264226;2189.4088596079127;2194.4075099722986;2200.19692812124;2209.359285807114;8287.62705678246;8350.540720260384;8357.540335281557;8379.078301386842;8381.161883811632;4966.850994470172;5081.364829396325;5098.184290513537;5104.846854594368;5112;2916.504194286976;2953.29121010958;2958.2160727407254;2969.510030844908;3060.4950183219744;1057.3497299161038;1093.8468614393992;1094.3816743539874;1113.7048682099169;1999.9000049997442;10735.194860385502;10779;10810.405427701473;10835.729106772395;10875.293105948167;4141.130362623822;4334.371516130206;4522.706024108488;4531.18438681034;4544.272916333371;9157.130072643089;9160.404573702688;9161.31290153228;9183.448993060438;9250;4967.279744437109;5005.949940500621;5024.120778863684;5036.521530454601;5062.7468626568525;4250;4686.976565117221;4712.505186955389;4716.693414928019;4751.596114330251;3655.5430571178604;3685.9262814744093;3734.402495600691;3739.5325584301963;3810.218905124498;1097.0948967102172;1145.6906635208447;1147.925384849982;1153.4463457540428;1160.3733983648735;988.8170688422665;993.895640957689;1020.1430798129459;1031.9793604127876;1036.8341065429495;5886.941130588725;5905.291365036223;5966.508372906774;6006.459418652343;6106.175666285084;935.7005758157325;938.6761567259284;943.580106852444;947.052947052947;963.5856581669949;3887.339152344052;4192.45498085247;4209.663226941837;4292.871213863589;4306.2894622387585;9483.193928516153;9883.406995580288;9952.651657191964;9975.152112070555;10203.693889183336;9933.453660048623;9965.25260605443;9973.252006099572;10045.799084018425;10119.595216191417;7514.511556748794;7751.534907905544;7756.612169391621;7788.610569471503;7894;5686.289213848269;5882.794102206402;5899.557533185114;5909.468147866713;6016.699165041818;9576.712698619052;9651.951740241253;9702.6118955241;9703.417794932328;9799;9350;9733.221342292742;9916.950415247878;9937.751556211153;10007.649732259337;7014.894776578253;7199.928000719926;7436.144843343085;7609.315161635479;7771.611419429119;7874.094479134973;7874.921250787419;7881.172476890073;7912.0901096374655;7978.521288722695;6978.930210697828;7264.854702906018;7275.708971641075;7287.635618219174;7347.118345798538;7158.821029474305;7164.856702866018;7187.676554554953;7220.205777364381;7224.494285399972;6525.967370163309;6606.075149478981;6612.669366531751;6621.106150669598;6627;4806.8798280043275;4876.073546026244;4894.877628059185;4920.704757714549;4928.088303663833;4891.070696567641;4905.926411103907;4927.260910863399;4944.728039957837;4950.133726597903 10:27:04 INFO - PROCESS | 3435 | |4;prototype.html;318.0728177362987;321.6365506977117;329.3314571420017;331.81750037479395;332.7304883044732;5958.553108516862;6009.429104235096;6049.969750151243;6075.392460753922;6081.908771368428;5914.2902851657755;5954.523638108952;5956.910646340309;5977.101105963604;5986.371430999748;4293.892652683677;4366.585174408426;4513.729176249435;4531.6601254905845;4558.088382323532;4518.344839998198;4523.683342166049;4551.180787458256;4559.156556037144;4565.794539245725;4502.459704835424;4520.570545798144;4526.773661316937;4533.116042371739;4550.590446859782;4227.429297044906;4430.49049359323;4442.489113751928;4445.622122119624;4450.844220452269;3863.652271295569;3868.226354729037;3880.961190388088;3885.8834234972996;3901.5708272090046;5708.971455142698;5730.971345143289;5746.942530574683;5774.538036957033;5783.566232532577;4930.827421040246;5105.744712764384;5130.281760553526;5167.4057483389515;5185.818496352647;6166.938330616681;6167.5682702210415;6188.164597779287;6234.937650623481;6243.313235544087;4197.307444271692;4261.893452663678;4278.978605106986;4279.7218180818145;4295.78521073945;6445.51658625605;6541.313162118005;6560.442362399202;6575.704093315764;6577.177852768404;4361.672874534423;4381.978090109593;4384.978075109604;4408.53710360414;4408.669349798778;4363.105563359503;4385.6710746694125;4451.530994771718;4475.753833539186;4476.239039363316;5106.208537676666;5167.873436570896;5197.194434862602;5205.219217117463;5222.399424066205;6268.937310626835;6273.780417685359;6317.652529110943;6321.273053598803;6325.873482530324;1482.9629259268604;1495.244901324824;1505.0969418348902;1515.5604874586468;1520.4602366159854;952.7284723853669;972.4019727867311;986.0977205856705;995.7560397702609;1004.2116938203475;5997.250343707036;6034.728437220336;6037.154798328237;6058.242719660043;6075.362086980804;6292.559520833498;6449.709763060673;6453.870572649767;6453.967730161319;6461.676916154173;5972.134040564094;5984.640921544721;6012.428819262163;6015.849603759941;6036;3420.640832712529;3436.536067630888;3463.688268055887;3465.965340346564;3475.6350583188905;6522.673866306665;6567.014947757874;6678.966605166943;6682.63245521501;6716.328367163343;6561.5734977227285;6574.671266436659;6577.80266592003;6595;6600.141981542465;6521.152250207443;6620.139381880324;6649.102371179829;6653.534252602271;6685.395505078844;6411.679416029273;6412.871742565029;6416.230052393743;6427.260865000398;6444.645544495098;6195;6282.246130464374;6305.621662700252;6354.777582784581;6364.713587888464;6593.241777195684;6641.667916604247;6666.100076489612;6667.8666426670225;6678.198616165897;4275.03811642378;4290.249206388932;4318.762468064287;4334.306510958231;4352.260115780388;6151.507879369729;6334.651594162366;6335.366463353628;6393.29673735898;6394.872102558016;6201.875962480815;6223.471004964447;6226.688665566794;6239.376062393724;6248.750049997949;5998.880582097372;6206.658633775186;6235.532335074979;6359.459445947146;6412.358764123737;6053.515718742402;6227;6256.155419018374;6270.498360131087;6275.3724627536885;6360.204974378203;6383.234011918599;6396.264429590657;6426.325235850169;6436.710348034256;6174.413430724074;6256.624602523863;6275.466585340298;6323.430891219812;6371.49028077762 10:27:04 INFO - PROCESS | 3435 | |5;yui.html;807.132332742302;839.6011894350181;859.6045818923293;860.5611138319455;869.8869147010888;14382.280885955699;14528.927355363221;14794.112353258812;14842.183679897615;14890.181040042793;14485.130892146479;15201.54395368138;15223.31495082721;15230.390784368612;15278.923605381957;812.8699408094706;829.3779665251062;834.0700119366923;838.2288294768797;838.6351936907465;838.5136620759976;838.77353114659;842.3008902610818;842.473454091193;843.6245870587591;862.3144600042949;869.2784988459595;869.5261082709907;870.3254977392509;870.525563567857;857.4555157474986;862;864.1747131489444;866.8136350684601;870.4124715816798;631.3749388105788;635.9618422894641;636.2047440699126;637.4199478474566;638.1703785079378;13822.37799299034;13844.30778461083;13867.4453021879;13893.235872027035;13944.02391832562;12997.285149316784;13401.530946416926;13870.098443601133;13976.440942362293;14034.36845341962;11680.299182049019;11697.824532632018;11717.414129293586;11863.347515886622;11915.821262681067;3839.3856982882603;3865.4781604483314;3878.437626544135;3882.1265215326607;4000.0999775050673;50878;51207.74396127996;51446.22830657506;51830.22254666183;58780.41219587792;11065.834012489819;11180.552777888794;11398.746137924822;11426.657200284004;11445.198836081561;18718.344857929907;19139.13873875679;19178.52053698641;19220.327288544835;19250.71123933142;8254.958725206336;8470.618822153017;8528.275096616857;8534.87197692035;8819.11808819113;4847.345608342899;4869.464358920516;4965.577925876269;5001.89996200074;5059.569936555434;3222.3555288942307;3268.2809781847955;3278.7540934429535;3279.3605246977086;3280.3439312137666;609.1806520230283;611.5902345428574;611.764470678783;620.5004970998299;620.959637623553;722.3787542713262;742.6546655805076;758.6396461680657;758.8444368904361;793.6111305460283;8827.337949653802;8867.955660221787;8939.865902011476;9059.275257979345;9374.95312523433;561.486240090321;644.635780783865;714.2892821642499;744.7244519527701;767.2404319723433;4170.793495951162;4237.5762423758;4298.41971333866;4329.891752706208;4385.978070109629;57167.142492862644;57598.42401575931;57647.42352576421;57653.71173144107;57958.7102064487;50401;51112.48887511077;51265.48734512607;51415.74292128516;52139;45286;45717.314240286425;45741.771291143334;45973.77013114913;47058.76470617625;8047.678092876219;8130.918690813016;8266.751997440086;8273.793155171168;8373.03710073325;29825.105246842628;30795.846020769754;30869;30877.8456107718;32152.839235804608;40250;41861.79069104635;42399.36400953926;42443.36334954917;42474.36288455738;10437.582496700046;10456.424896630759;10800.567977280822;10821.783564328827;11004.614838480615;11861.347625880315;11942.820857687315;11987.520499180284;12132.696682583006;12217.144799863925;11491.54033838637;11604.187706860439;11625.244359116969;11628.418579071182;11904.404779760804;11233.831492527455;11716.88283117192;11842;11873;11902.345371004678;11487.827682584935;11585.420728963349;11818.586349477728;12013.879861201276;12120.636380908587;9274.721758347261;9337.346385752931;9512.667056652985;9734.561944712363;9861.063198996084;9114.498702571156;9225.215856651992;9236;9240.491772952551;9527.618895244113 10:27:04 INFO - PROCESS | 3435 | __end_tp_report 10:27:04 INFO - PROCESS | 3435 | __start_cc_report 10:27:04 INFO - PROCESS | 3435 | _x_x_mozilla_cycle_collect,338 10:27:04 INFO - PROCESS | 3435 | __end_cc_report 10:27:04 INFO - PROCESS | 3435 | __startTimestamp1460827624067__endTimestamp 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | ------- Summary: start ------- 10:27:04 INFO - PROCESS | 3435 | Number of tests: 6 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#0] dojo.html Cycles:165 Average:5288.10 Median:5503.50 stddev:599.65 (10.9%) stddev-sans-first:575.84 10:27:04 INFO - PROCESS | 3435 | Values: 3076.2 3079.8 3111.4 3112.9 3133.6 5278.4 5310.8 5320.8 5327.4 5331.2 5323.2 5352.1 5357.9 5361.2 5437.7 4821.8 4862.1 4918.2 4927.5 4963.0 4704.3 4816.7 4842.4 4856.6 4864.5 4819.7 4824.6 4833.2 4835.9 4856.0 4827.2 4838.4 4843.9 4864.7 4883.9 4699.7 4781.3 4810.1 4852.0 4898.9 5195.6 5220.8 5226.9 5232.1 5261.9 5625.0 5630.1 5630.9 5632.1 5649.1 5581.9 5696.0 5730.3 5802.7 5825.9 5248.6 5254.8 5255.2 5262.3 5267.3 5743.5 5746.2 5757.1 5775.3 5803.9 5449.5 5550.7 5623.9 5682.9 5732.0 5675.8 5691.1 5692.9 5703.4 5703.8 5567.1 5624.7 5661.4 5666.0 5681.9 5548.7 5648.1 5736.9 5739.0 5763.1 4315.4 4317.2 4320.9 4341.4 4378.8 3868.4 3876.4 3895.4 3898.1 3899.5 5300.8 5314.9 5382.2 5382.9 5384.8 5717.5 5718.5 5739.1 5740.9 5791.0 5347.9 5402.8 5405.1 5415.5 5421.3 4832.8 4920.4 4935.0 4944.4 4988.2 5930.9 5932.6 5935.8 5939.8 5949.8 5698.1 5736.1 5746.0 5753.2 5761.2 5777.3 5878.6 5914.5 5953.3 5994.9 5552.6 5555.2 5561.1 5563.6 5570.9 5599.6 5638.5 5644.3 5647.6 5660.9 5477.0 5610.5 5687.4 5725.1 5743.2 5571.5 5574.9 5580.1 5582.4 5594.7 5390.9 5474.6 5509.8 5524.8 5557.0 5539.6 5612.2 5668.4 5672.1 5675.5 5466.3 5488.9 5500.6 5503.5 5552.2 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#1] ext.html Cycles:180 Average:49509.75 Median:36412.59 stddev:92808.75 (254.9%) stddev-sans-first:92996.44 10:27:04 INFO - PROCESS | 3435 | Values: 595.9 626.4 637.3 642.0 671.7 35334.1 36341.0 36405.9 36419.3 36494.8 35670.1 36464.1 36561.5 36591.3 36726.3 8501.5 8713.1 8737.3 8739.2 8741.0 8626.4 8709.2 8713.2 8713.7 8714.6 8659.3 8700.4 8710.1 8764.3 8777.6 8606.4 8691.3 8696.0 8706.8 8713.1 8560.2 8598.0 8612.5 8629.3 8667.8 33107.8 36737.6 37335.8 37518.0 37595.6 3254.8 3468.8 3472.0 3513.5 3800.0 26505.5 26707.0 26868.5 27110.6 27229.7 3869.9 3872.1 3933.3 4044.0 4071.7 178759.0 180834.0 181735.0 182018.0 183095.1 34285.3 34300.7 34400.3 34560.8 34589.1 66215.0 68295.7 68388.0 68667.0 68742.7 16502.9 16814.6 16924.6 17045.9 17063.2 12575.8 12581.9 12642.7 12659.5 12720.8 19330.9 19482.3 19522.0 19580.3 19698.3 7161.5 7288.5 7382.2 7397.4 7459.3 1025.3 1044.0 1105.9 1162.5 1168.6 31056.0 31332.8 31446.8 31561.7 31626.0 1091.1 1113.6 1133.2 1146.6 1156.7 16771.5 16945.3 16974.8 17127.1 17191.9 428469.0 430872.0 432711.0 433526.0 435417.0 54310.0 55286.4 55495.7 55627.7 55629.0 1227.1 1341.9 1371.7 1383.2 1392.7 30227.5 30359.4 30422.7 30867.5 31183.0 49044.5 49406.5 49557.3 49566.0 49569.8 382344.0 384337.0 385794.0 386308.0 386533.0 27627.0 28167.0 41580.6 43736.3 43842.8 40689.0 41168.6 41305.4 42064.0 42245.6 35212.5 35273.6 35522.3 35620.5 35668.6 34372.0 35198.6 35274.6 35485.0 35769.8 39473.0 40644.8 41727.4 42098.2 42190.4 29255.0 32339.2 32513.7 34050.0 34453.5 26650.3 27236.9 27268.9 27466.6 27881.3 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#2] jquery.html Cycles:180 Average:25687.12 Median:12555.94 stddev:64856.51 (516.5%) stddev-sans-first:65010.61 10:27:04 INFO - PROCESS | 3435 | Values: 381.6 387.8 392.1 394.5 404.6 14524.9 17463.7 17614.5 18188.3 18315.8 18046.5 18242.5 18447.2 18991.3 19104.0 5665.7 5744.9 5877.8 5892.0 5902.1 5709.4 5818.3 5843.0 5846.6 5854.0 5671.3 5709.2 5823.3 5831.8 5851.5 5581.6 5762.5 5787.7 5813.6 5814.6 5187.4 5202.0 5225.6 5229.2 5231.4 22153.3 22262.4 22825.0 23579.0 23596.5 2274.7 2286.9 2424.2 2446.8 2815.5 13758.9 14341.8 14448.0 14787.7 14924.2 1909.4 1925.6 1942.8 1979.2 1987.6 77609.6 77973.6 78149.6 78435.0 80107.6 10069.0 10074.6 10247.4 10290.6 10383.3 12563.9 12835.5 14050.6 14054.3 14160.4 7427.6 7486.7 7964.2 8109.5 8171.7 8024.1 8080.7 8129.0 8170.1 8298.9 6158.9 6260.6 6340.6 6343.3 6364.2 1824.7 1835.7 1837.4 1848.5 1872.8 971.4 1000.3 1029.6 1158.2 1170.9 19230.2 19340.9 19520.9 19610.6 19614.7 1001.8 1042.8 1074.5 1122.4 1142.4 10953.2 10980.7 11155.4 11221.9 11290.3 360613.0 361258.0 361393.0 362359.0 490708.0 75866.2 80370.0 84517.6 96270.0 98250.0 1070.9 1077.7 1095.3 1106.6 1111.1 15688.3 16504.3 17105.7 17208.1 17307.6 37213.0 38141.0 39433.8 40601.4 42108.4 50774.7 51200.5 51447.5 52270.5 52525.7 7969.2 8290.9 8594.4 8633.6 8744.3 11940.7 13609.7 13693.0 13695.3 13767.0 5933.5 9061.8 11809.4 11909.3 12058.9 11516.4 11644.5 11846.6 11919.0 11998.2 12060.2 12125.3 12203.3 12265.9 12357.9 8103.3 8432.3 8626.1 8678.3 8688.1 11000.7 11641.5 11736.9 11783.5 12112.3 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#3] mootools.html Cycles:180 Average:5469.92 Median:5030.32 stddev:2994.87 (59.5%) stddev-sans-first:2988.45 10:27:04 INFO - PROCESS | 3435 | Values: 1505.0 1521.9 1673.6 1783.4 1844.1 7422.0 7946.8 8176.4 8288.8 8308.1 8071.8 8097.8 8150.3 8207.1 8252.9 2270.5 2299.5 2303.2 2305.8 2313.8 2204.7 2211.1 2252.5 2253.2 2254.9 2268.6 2276.7 2291.3 2291.8 2303.8 2207.4 2213.0 2214.3 2216.9 2222.6 2187.2 2189.4 2194.4 2200.2 2209.4 8287.6 8350.5 8357.5 8379.1 8381.2 4966.9 5081.4 5098.2 5104.8 5112.0 2916.5 2953.3 2958.2 2969.5 3060.5 1057.3 1093.8 1094.4 1113.7 1999.9 10735.2 10779.0 10810.4 10835.7 10875.3 4141.1 4334.4 4522.7 4531.2 4544.3 9157.1 9160.4 9161.3 9183.4 9250.0 4967.3 5005.9 5024.1 5036.5 5062.7 4250.0 4687.0 4712.5 4716.7 4751.6 3655.5 3685.9 3734.4 3739.5 3810.2 1097.1 1145.7 1147.9 1153.4 1160.4 988.8 993.9 1020.1 1032.0 1036.8 5886.9 5905.3 5966.5 6006.5 6106.2 935.7 938.7 943.6 947.1 963.6 3887.3 4192.5 4209.7 4292.9 4306.3 9483.2 9883.4 9952.7 9975.2 10203.7 9933.5 9965.3 9973.3 10045.8 10119.6 7514.5 7751.5 7756.6 7788.6 7894.0 5686.3 5882.8 5899.6 5909.5 6016.7 9576.7 9652.0 9702.6 9703.4 9799.0 9350.0 9733.2 9917.0 9937.8 10007.6 7014.9 7199.9 7436.1 7609.3 7771.6 7874.1 7874.9 7881.2 7912.1 7978.5 6978.9 7264.9 7275.7 7287.6 7347.1 7158.8 7164.9 7187.7 7220.2 7224.5 6526.0 6606.1 6612.7 6621.1 6627.0 4806.9 4876.1 4894.9 4920.7 4928.1 4891.1 4905.9 4927.3 4944.7 4950.1 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#4] prototype.html Cycles:180 Average:5219.51 Median:6036.58 stddev:1597.56 (26.5%) stddev-sans-first:1559.10 10:27:04 INFO - PROCESS | 3435 | Values: 318.1 321.6 329.3 331.8 332.7 5958.6 6009.4 6050.0 6075.4 6081.9 5914.3 5954.5 5956.9 5977.1 5986.4 4293.9 4366.6 4513.7 4531.7 4558.1 4518.3 4523.7 4551.2 4559.2 4565.8 4502.5 4520.6 4526.8 4533.1 4550.6 4227.4 4430.5 4442.5 4445.6 4450.8 3863.7 3868.2 3881.0 3885.9 3901.6 5709.0 5731.0 5746.9 5774.5 5783.6 4930.8 5105.7 5130.3 5167.4 5185.8 6166.9 6167.6 6188.2 6234.9 6243.3 4197.3 4261.9 4279.0 4279.7 4295.8 6445.5 6541.3 6560.4 6575.7 6577.2 4361.7 4382.0 4385.0 4408.5 4408.7 4363.1 4385.7 4451.5 4475.8 4476.2 5106.2 5167.9 5197.2 5205.2 5222.4 6268.9 6273.8 6317.7 6321.3 6325.9 1483.0 1495.2 1505.1 1515.6 1520.5 952.7 972.4 986.1 995.8 1004.2 5997.3 6034.7 6037.2 6058.2 6075.4 6292.6 6449.7 6453.9 6454.0 6461.7 5972.1 5984.6 6012.4 6015.8 6036.0 3420.6 3436.5 3463.7 3466.0 3475.6 6522.7 6567.0 6679.0 6682.6 6716.3 6561.6 6574.7 6577.8 6595.0 6600.1 6521.2 6620.1 6649.1 6653.5 6685.4 6411.7 6412.9 6416.2 6427.3 6444.6 6195.0 6282.2 6305.6 6354.8 6364.7 6593.2 6641.7 6666.1 6667.9 6678.2 4275.0 4290.2 4318.8 4334.3 4352.3 6151.5 6334.7 6335.4 6393.3 6394.9 6201.9 6223.5 6226.7 6239.4 6248.8 5998.9 6206.7 6235.5 6359.5 6412.4 6053.5 6227.0 6256.2 6270.5 6275.4 6360.2 6383.2 6396.3 6426.3 6436.7 6174.4 6256.6 6275.5 6323.4 6371.5 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - PROCESS | 3435 | [#5] yui.html Cycles:180 Average:14048.12 Median:4858.40 stddev:15911.39 (327.5%) stddev-sans-first:15924.96 10:27:04 INFO - PROCESS | 3435 | Values: 807.1 839.6 859.6 860.6 869.9 14382.3 14528.9 14794.1 14842.2 14890.2 14485.1 15201.5 15223.3 15230.4 15278.9 812.9 829.4 834.1 838.2 838.6 838.5 838.8 842.3 842.5 843.6 862.3 869.3 869.5 870.3 870.5 857.5 862.0 864.2 866.8 870.4 631.4 636.0 636.2 637.4 638.2 13822.4 13844.3 13867.4 13893.2 13944.0 12997.3 13401.5 13870.1 13976.4 14034.4 11680.3 11697.8 11717.4 11863.3 11915.8 3839.4 3865.5 3878.4 3882.1 4000.1 50878.0 51207.7 51446.2 51830.2 58780.4 11065.8 11180.6 11398.7 11426.7 11445.2 18718.3 19139.1 19178.5 19220.3 19250.7 8255.0 8470.6 8528.3 8534.9 8819.1 4847.3 4869.5 4965.6 5001.9 5059.6 3222.4 3268.3 3278.8 3279.4 3280.3 609.2 611.6 611.8 620.5 621.0 722.4 742.7 758.6 758.8 793.6 8827.3 8868.0 8939.9 9059.3 9375.0 561.5 644.6 714.3 744.7 767.2 4170.8 4237.6 4298.4 4329.9 4386.0 57167.1 57598.4 57647.4 57653.7 57958.7 50401.0 51112.5 51265.5 51415.7 52139.0 45286.0 45717.3 45741.8 45973.8 47058.8 8047.7 8130.9 8266.8 8273.8 8373.0 29825.1 30795.8 30869.0 30877.8 32152.8 40250.0 41861.8 42399.4 42443.4 42474.4 10437.6 10456.4 10800.6 10821.8 11004.6 11861.3 11942.8 11987.5 12132.7 12217.1 11491.5 11604.2 11625.2 11628.4 11904.4 11233.8 11716.9 11842.0 11873.0 11902.3 11487.8 11585.4 11818.6 12013.9 12120.6 9274.7 9337.3 9512.7 9734.6 9861.1 9114.5 9225.2 9236.0 9240.5 9527.6 10:27:04 INFO - PROCESS | 3435 | -------- Summary: end -------- 10:27:04 INFO - PROCESS | 3435 | 10:27:04 INFO - TEST-INFO | 3435: exit 0 10:27:04 INFO - TEST-OK | dromaeo_css | took 1111726ms 10:27:04 INFO - TEST-START | kraken 10:27:04 INFO - operating with platform_type : linux_ 10:27:04 INFO - Initialising browser for kraken test... 10:27:04 INFO - TEST-INFO | started process 3676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4UXWTd/profile http://localhost:51239/getInfo.html) 10:27:08 INFO - PROCESS | 3676 | 10:27:08 INFO - PROCESS | 3676 | (process:3746): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:27:09 INFO - PROCESS | 3676 | __metrics Screen width/height:1600/1200 10:27:09 INFO - PROCESS | 3676 | colorDepth:24 10:27:09 INFO - PROCESS | 3676 | Browser inner width/height: 1024/697 10:27:09 INFO - PROCESS | 3676 | __metrics 10:27:10 ERROR - PROCESS | 3676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:27:11 INFO - TEST-INFO | 3676: exit 0 10:27:11 INFO - Browser initialized. 10:27:11 INFO - Running cycle 1/1 for kraken test... 10:27:11 INFO - TEST-INFO | started process 3797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4UXWTd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:12 INFO - PROCESS | 3797 | 10:27:12 INFO - PROCESS | 3797 | (process:3857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:27:22 INFO - PROCESS | 3797 | RSS: Main: 163790848 10:27:22 INFO - PROCESS | 3797 | 10:27:25 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51239/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:26 INFO - PROCESS | 3797 | RSS: Main: 168402944 10:27:26 INFO - PROCESS | 3797 | 10:27:29 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51239/tests/kraken/driver.html?testName=audio-dft) 10:27:29 INFO - PROCESS | 3797 | RSS: Main: 171556864 10:27:29 INFO - PROCESS | 3797 | 10:27:32 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51239/tests/kraken/driver.html?testName=audio-fft) 10:27:33 INFO - PROCESS | 3797 | RSS: Main: 162816000 10:27:33 INFO - PROCESS | 3797 | 10:27:35 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51239/tests/kraken/driver.html?testName=audio-oscillator) 10:27:36 INFO - PROCESS | 3797 | RSS: Main: 163377152 10:27:36 INFO - PROCESS | 3797 | 10:27:38 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:38 INFO - PROCESS | 3797 | RSS: Main: 163737600 10:27:38 INFO - PROCESS | 3797 | 10:27:41 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51239/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:42 INFO - PROCESS | 3797 | RSS: Main: 163991552 10:27:42 INFO - PROCESS | 3797 | 10:27:45 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51239/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:46 INFO - PROCESS | 3797 | RSS: Main: 166223872 10:27:46 INFO - PROCESS | 3797 | 10:27:49 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51239/tests/kraken/driver.html?testName=json-parse-financial) 10:27:49 INFO - PROCESS | 3797 | RSS: Main: 166633472 10:27:49 INFO - PROCESS | 3797 | 10:27:51 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:52 INFO - PROCESS | 3797 | RSS: Main: 166576128 10:27:52 INFO - PROCESS | 3797 | 10:27:53 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:54 INFO - PROCESS | 3797 | RSS: Main: 166526976 10:27:54 INFO - PROCESS | 3797 | 10:27:56 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:57 INFO - PROCESS | 3797 | RSS: Main: 166850560 10:27:57 INFO - PROCESS | 3797 | 10:28:00 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:00 INFO - PROCESS | 3797 | RSS: Main: 167333888 10:28:00 INFO - PROCESS | 3797 | 10:28:03 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:04 INFO - PROCESS | 3797 | RSS: Main: 167374848 10:28:04 INFO - PROCESS | 3797 | 10:28:05 INFO - PROCESS | 3797 | Cycle 1(1): loaded http://localhost:51239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51239/tests/kraken/driver.html?testName=ai-astar) 10:28:06 INFO - PROCESS | 3797 | RSS: Main: 168382464 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | __start_tp_report 10:28:06 INFO - PROCESS | 3797 | _x_x_mozilla_page_load 10:28:06 INFO - PROCESS | 3797 | _x_x_mozilla_page_load_details 10:28:06 INFO - PROCESS | 3797 | |i|pagename|runs| 10:28:06 INFO - PROCESS | 3797 | |0;ai-astar;115;106;114;110;119;122;111;110;111;111 10:28:06 INFO - PROCESS | 3797 | |1;audio-beat-detection;156;128;158;176;128;159;155;138;188;129 10:28:06 INFO - PROCESS | 3797 | |2;audio-dft;163;162;164;163;162;165;172;162;165;165 10:28:06 INFO - PROCESS | 3797 | |3;audio-fft;76;75;75;156;73;76;77;78;155;77 10:28:06 INFO - PROCESS | 3797 | |4;audio-oscillator;93;93;152;94;93;93;138;92;93;143 10:28:06 INFO - PROCESS | 3797 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;118;117;116 10:28:06 INFO - PROCESS | 3797 | |6;imaging-darkroom;146;148;146;146;148;147;147;146;147;147 10:28:06 INFO - PROCESS | 3797 | |7;imaging-desaturate;101;96;95;95;95;95;95;95;95;96 10:28:06 INFO - PROCESS | 3797 | |8;json-parse-financial;58;62;58;58;57;57;59;77;55;56 10:28:06 INFO - PROCESS | 3797 | |9;json-stringify-tinderbox;61;61;67;62;62;61;63;67;62;62 10:28:06 INFO - PROCESS | 3797 | |10;stanford-crypto-aes;76;85;77;78;77;77;78;79;77;77 10:28:06 INFO - PROCESS | 3797 | |11;stanford-crypto-ccm;138;125;129;128;126;129;125;131;158;128 10:28:06 INFO - PROCESS | 3797 | |12;stanford-crypto-pbkdf2;181;169;171;170;168;167;167;168;168;165 10:28:06 INFO - PROCESS | 3797 | |13;stanford-crypto-sha256-iterative;70;79;68;69;73;68;68;69;69;69 10:28:06 INFO - PROCESS | 3797 | __end_tp_report 10:28:06 INFO - PROCESS | 3797 | __start_cc_report 10:28:06 INFO - PROCESS | 3797 | _x_x_mozilla_cycle_collect,825 10:28:06 INFO - PROCESS | 3797 | __end_cc_report 10:28:06 INFO - PROCESS | 3797 | __startTimestamp1460827686193__endTimestamp 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | ------- Summary: start ------- 10:28:06 INFO - PROCESS | 3797 | Number of tests: 14 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.72 (4.2%) stddev-sans-first:4.95 10:28:06 INFO - PROCESS | 3797 | Values: 115.0 106.0 114.0 110.0 119.0 122.0 111.0 110.0 111.0 111.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.00 stddev:20.70 (13.2%) stddev-sans-first:21.89 10:28:06 INFO - PROCESS | 3797 | Values: 156.0 128.0 158.0 176.0 128.0 159.0 155.0 138.0 188.0 129.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.98 (1.8%) stddev-sans-first:3.13 10:28:06 INFO - PROCESS | 3797 | Values: 163.0 162.0 164.0 163.0 162.0 165.0 172.0 162.0 165.0 165.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:33.60 (44.2%) stddev-sans-first:35.15 10:28:06 INFO - PROCESS | 3797 | Values: 76.0 75.0 75.0 156.0 73.0 76.0 77.0 78.0 155.0 77.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:25.03 (26.9%) stddev-sans-first:25.92 10:28:06 INFO - PROCESS | 3797 | Values: 93.0 93.0 152.0 94.0 93.0 93.0 138.0 92.0 93.0 143.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:28:06 INFO - PROCESS | 3797 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 116.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:28:06 INFO - PROCESS | 3797 | Values: 146.0 148.0 146.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.87 (2.0%) stddev-sans-first:0.44 10:28:06 INFO - PROCESS | 3797 | Values: 101.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.00 stddev:6.36 (11.0%) stddev-sans-first:6.72 10:28:06 INFO - PROCESS | 3797 | Values: 58.0 62.0 58.0 58.0 57.0 57.0 59.0 77.0 55.0 56.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.00 stddev:2.30 (3.7%) stddev-sans-first:2.35 10:28:06 INFO - PROCESS | 3797 | Values: 61.0 61.0 67.0 62.0 62.0 61.0 63.0 67.0 62.0 62.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:2.56 (3.3%) stddev-sans-first:2.60 10:28:06 INFO - PROCESS | 3797 | Values: 76.0 85.0 77.0 78.0 77.0 77.0 78.0 79.0 77.0 77.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:129.00 stddev:9.98 (7.7%) stddev-sans-first:10.32 10:28:06 INFO - PROCESS | 3797 | Values: 138.0 125.0 129.0 128.0 126.0 129.0 125.0 131.0 158.0 128.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:168.50 stddev:4.40 (2.6%) stddev-sans-first:1.76 10:28:06 INFO - PROCESS | 3797 | Values: 181.0 169.0 171.0 170.0 168.0 167.0 167.0 168.0 168.0 165.0 10:28:06 INFO - PROCESS | 3797 | 10:28:06 INFO - PROCESS | 3797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.00 stddev:3.43 (5.0%) stddev-sans-first:3.63 10:28:06 INFO - PROCESS | 3797 | Values: 70.0 79.0 68.0 69.0 73.0 68.0 68.0 69.0 69.0 69.0 10:28:06 INFO - PROCESS | 3797 | -------- Summary: end -------- 10:28:06 INFO - PROCESS | 3797 | 10:28:07 INFO - TEST-INFO | 3797: exit 0 10:28:07 INFO - TEST-OK | kraken | took 62367ms 10:28:07 INFO - SUITE-END | took 1174s 10:28:07 INFO - Completed test suite (00:19:34) 10:28:07 INFO - javascript benchmark 10:28:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.200187951135, 3079.799813012154, 3111.4243864884997, 3112.937741245175, 3133.5769671094404, 5278.419373868876, 5310.814121505743, 5320.813771517997, 5327.360716713995, 5331.2003199520095, 5323.22813192087, 5352.116900711378, 5357.892842143155, 5361.169018802082, 5437.728113594324, 4821.783019764111, 4862.14912390332, 4918.188498897677, 4927.50724927508, 4963.0, 4704.294355846633, 4816.686915350491, 4842.394700662418, 4856.611471082305, 4864.46490886004, 4819.734914579697, 4824.5899098576665, 4833.178359678863, 4835.903281934359, 4856.028794241148, 4827.155247831651, 4838.395200599925, 4843.854684359475, 4864.683795553277, 4883.8779030524165, 4699.7415142167165, 4781.330613714083, 4810.11012962603, 4852.0295940811975, 4898.8775280618265, 5195.610329225323, 5220.843374698765, 5226.895462090775, 5232.058229518685, 5261.86845328866, 5625.0, 5630.0991841305195, 5630.859228519279, 5632.07070833312, 5649.12438572022, 5581.916271255935, 5696.0, 5730.283714535683, 5802.65184088956, 5825.9417405825825, 5248.606354523426, 5254.842354729364, 5255.159174532095, 5262.2632831403635, 5267.341582302174, 5743.511801496919, 5746.195532625436, 5757.050086735725, 5775.27809023872, 5803.9419605803405, 5449.455054494598, 5550.694711790809, 5623.943760562423, 5682.914756278659, 5732.0, 5675.77296908119, 5691.060974939089, 5692.943070569241, 5703.40114288002, 5703.800366987136, 5567.053600887859, 5624.690642014647, 5661.405552417019, 5666.036773748473, 5681.920435117398, 5548.667079975215, 5648.068068768607, 5736.942630573724, 5739.0, 5763.135529670583, 4315.438992930899, 4317.201317756225, 4320.870373888788, 4341.435613370305, 4378.824847006084, 3868.3810590305416, 3876.3991581304945, 3895.3962135868987, 3898.1034362096875, 3899.532056153223, 5300.814471493479, 5314.946850531445, 5382.219578161144, 5382.91925621116, 5384.784608615611, 5717.542596592262, 5718.456746609066, 5739.110437882135, 5740.913886291709, 5791.015527360359, 5347.919781203285, 5402.837914862561, 5405.108157154104, 5415.539679127318, 5421.295231619864, 4832.806687732451, 4920.40955085392, 4935.037667654845, 4944.406671199407, 4988.152014157602, 5930.851728706817, 5932.584719069624, 5935.792247271324, 5939.821805345847, 5949.762009519657, 5698.1452782083015, 5736.053551164011, 5745.999999999916, 5753.1945527627, 5761.193432919311, 5777.306723193244, 5878.617889837147, 5914.526837853047, 5953.3153687324775, 5994.880102398015, 5552.639078459887, 5555.194496798023, 5561.054620714407, 5563.58273129525, 5570.86072848182, 5599.552035837205, 5638.4925356718095, 5644.294463192101, 5647.632903861236, 5660.915086273627, 5477.04151773446, 5610.4670056344585, 5687.43125687428, 5725.055365864586, 5743.195952566728, 5571.470710282517, 5574.888502229852, 5580.107182850725, 5582.413846546055, 5594.664320140804, 5390.946090539044, 5474.644148130359, 5509.807156749494, 5524.806631767869, 5557.027520184032, 5539.612227144061, 5612.186232996111, 5668.404817494104, 5672.14917762339, 5675.489205971482, 5466.289382380265, 5488.862778430571, 5500.614956953135, 5503.504684578407, 5552.167174923794], "value": 5247.790655009052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9225300710907, 626.3923993726087, 637.2957881540897, 641.9775307864224, 671.6809515480145, 35334.11664708381, 36340.99999999996, 36405.90549803267, 36419.27161456769, 36494.8175259124, 35670.10824729376, 36464.08839779007, 36561.45157822628, 36591.26817463649, 36726.26547469049, 8501.532415717133, 8713.085126061767, 8737.301015918743, 8739.213470787628, 8740.956295218515, 8626.35302352323, 8709.172628600272, 8713.172248636401, 8713.695020674279, 8714.607842647065, 8659.307255419551, 8700.390972631918, 8710.128987101303, 8764.29885609153, 8777.561121943909, 8606.354523410739, 8691.304695624334, 8696.043435222153, 8706.825863482694, 8713.085126061767, 8560.229579337827, 8598.0, 8612.52631105289, 8629.266512346396, 8667.783305417352, 33107.834460827784, 36737.632623673686, 37335.81332093349, 37518.0, 37595.62404375976, 3254.7721659483846, 3468.757186996911, 3471.9652803472145, 3513.472979053137, 3799.9740070181174, 26505.46989060227, 26707.0, 26868.462630747275, 27110.5933410999, 27229.727702722917, 3869.941950870739, 3872.148127411993, 3933.3116704576582, 4043.97978010111, 4071.653909417703, 178759.0, 180834.0, 181735.0, 182018.0, 183095.08452457786, 34285.314293713986, 34300.656993429744, 34400.311993759984, 34560.82719586386, 34589.13527161841, 66215.0, 68295.65852170707, 68388.0, 68666.96999545011, 68742.65628671825, 16502.917485412738, 16814.579635508966, 16924.57688557796, 17045.91477042607, 17063.23215455283, 12575.811362829565, 12581.87418125807, 12642.683932901751, 12659.49362025527, 12720.809187862189, 19330.936798475937, 19482.318118865773, 19522.0, 19580.314688985818, 19698.31055913065, 7161.4986950912935, 7288.526245794006, 7382.151052629017, 7397.445191610651, 7459.3286604204795, 1025.3437799808128, 1043.9530221140067, 1105.8728246251624, 1162.5466068233395, 1168.5968340922368, 31056.0, 31332.843335783175, 31446.842765786023, 31561.684383156335, 31626.0, 1091.121647074113, 1113.5768408005067, 1133.2237417369129, 1146.5814977533141, 1156.7108222944264, 16771.496855094367, 16945.32218711238, 16974.83025169757, 17127.14364281781, 17191.914040429718, 428469.0, 430872.0, 432711.0, 433526.0, 435417.0, 54310.0, 55286.447135528935, 55495.722521387135, 55627.72186139043, 55629.0, 1227.147132742753, 1341.8993575481877, 1371.739369519788, 1383.2392184298394, 1392.6866455047534, 30227.546586800774, 30359.419449347053, 30422.695773041985, 30867.536986945663, 31183.0, 49044.50955490399, 49406.50593494019, 49557.256641151136, 49566.0, 49569.752151239016, 382344.0, 384337.0, 385794.0, 386308.0, 386533.0, 27627.0, 28167.0, 41580.58419415767, 43736.34395484134, 43842.780786095864, 40689.0, 41168.588314117675, 41305.380419294335, 42064.0, 42245.577544224165, 35212.47181292334, 35273.647263528066, 35522.289554208255, 35620.46569301515, 35668.64331356757, 34372.0, 35198.64801351954, 35274.64725352714, 35485.0, 35769.82115089408, 39473.0, 40644.79677601593, 41727.37408938929, 42098.158036839704, 42190.367144492244, 29255.0, 32339.16637926321, 32513.67486325201, 34050.0, 34453.483197752554, 26650.333741656614, 27236.910523578834, 27268.863655681595, 27466.5880011796, 27881.302967425978], "value": 18719.484272855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.61647544218056, 387.780903789359, 392.1182266009852, 394.46746891696216, 404.58125839755843, 14524.854751452482, 17463.650726985452, 17614.47156585303, 18188.272469101237, 18315.816841831595, 18046.458606241835, 18242.5439364016, 18447.169877355518, 18991.33530326439, 19104.044797760125, 5665.660060396379, 5744.942550574503, 5877.764889404419, 5891.970540147293, 5902.085176797603, 5709.371969083398, 5818.301803783531, 5842.970785146068, 5846.619969701956, 5854.0, 5671.347795003586, 5709.182884424473, 5823.330317013555, 5831.7958871439505, 5851.5318774498155, 5581.553475721932, 5762.4525670061275, 5787.681677507735, 5813.563982701293, 5814.622049566807, 5187.403448603422, 5202.037623039712, 5225.581953443753, 5229.2417599448245, 5231.372235331746, 22153.335399938027, 22262.443438913993, 22825.0, 23579.0, 23596.528069438515, 2274.727032756063, 2286.874221917794, 2424.175780234711, 2446.8287219894614, 2815.5072862249026, 13758.862411375858, 14341.784873226805, 14448.0, 14787.704245915022, 14924.179170145637, 1909.3794516782102, 1925.5763731978943, 1942.77658069321, 1979.237993372562, 1987.6322880267196, 77609.61195193988, 77973.61013194955, 78149.60925195394, 78435.0, 80107.59946200231, 10068.986202759477, 10074.597016119273, 10247.436390998417, 10290.588376465008, 10383.325083869524, 12563.937180314222, 12835.45974483068, 14050.648733781738, 14054.297285135703, 14160.433582656578, 7427.591482468516, 7486.663100160506, 7964.20357964199, 8109.5134291941495, 8171.673133074611, 8024.117347091816, 8080.71717489885, 8128.9593552031865, 8170.060443049007, 8298.917010829815, 6158.920539730135, 6260.558382230934, 6340.587861789061, 6343.333949935282, 6364.172657554488, 1824.744535764994, 1835.733818596296, 1837.3569250762125, 1848.5471059590486, 1872.7639757759814, 971.358903123949, 1000.314784372707, 1029.5675816157081, 1158.195054437158, 1170.9180357375071, 19230.23079076849, 19340.903295483433, 19520.90239548793, 19610.607787844165, 19614.70577941332, 1001.7545701303081, 1042.7862288231047, 1074.4949873559415, 1122.3882983773863, 1142.4459137318395, 10953.233273670767, 10980.725481863017, 11155.386453745123, 11221.94389028066, 11290.322580645188, 360613.0, 361258.0, 361393.0, 362359.0, 490708.0, 75866.24133758702, 80370.0, 84517.57741211378, 96270.0, 98250.0, 1070.903618674323, 1077.6874706335232, 1095.2990086344905, 1106.623747925709, 1111.1333160135107, 15688.294026768595, 16504.33982640681, 17105.74341384905, 17208.05355705448, 17307.56731081733, 37213.0, 38141.0, 39433.80283098681, 40601.390979135926, 42108.36837447502, 50774.74612626913, 51200.48799511957, 51447.48552514577, 52270.47729522656, 52525.68685782886, 7969.163237859942, 8290.917090829014, 8594.441361311494, 8633.611487482953, 8744.300455963636, 11940.701482463008, 13609.659758506117, 13693.0, 13695.315234238447, 13767.0, 5933.465988060922, 9061.77345566366, 11809.350485723367, 11909.285442873455, 12058.879411205775, 11516.437432914872, 11644.475998579916, 11846.585369512026, 11919.046476281703, 11998.220115692453, 12060.216085954386, 12125.27248365101, 12203.328816915155, 12265.938670306592, 12357.93821030889, 8103.25779957312, 8432.325413966746, 8626.137386261575, 8678.262347700516, 8688.131186881514, 11000.669979900616, 11641.476133574179, 11736.882631173921, 11783.528658853893, 12112.273263604213], "value": 9189.845296850188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.0142156887239, 1521.946731864385, 1673.5899704572382, 1783.4025601423523, 1844.0963927675434, 7422.035135432399, 7946.801329966754, 8176.38677099217, 8288.834223315538, 8308.127646597111, 8071.757847264576, 8097.838043239147, 8150.307223885962, 8207.05618853832, 8252.91747082529, 2270.5231901300704, 2299.4596269876565, 2303.1823702585593, 2305.7578954209816, 2313.8495997760174, 2204.7464541577765, 2211.1155537784853, 2252.5157091225383, 2253.2339004738387, 2254.9436264093447, 2268.625676763332, 2276.738175109867, 2291.255342013844, 2291.8395712300144, 2303.8272129590264, 2207.4481379655085, 2213.0, 2214.3246309875562, 2216.8891555422247, 2222.5777102350503, 2187.1907394264226, 2189.4088596079127, 2194.4075099722986, 2200.19692812124, 2209.359285807114, 8287.62705678246, 8350.540720260384, 8357.540335281557, 8379.078301386842, 8381.161883811632, 4966.850994470172, 5081.364829396325, 5098.184290513537, 5104.846854594368, 5112.0, 2916.504194286976, 2953.29121010958, 2958.2160727407254, 2969.510030844908, 3060.4950183219744, 1057.3497299161038, 1093.8468614393992, 1094.3816743539874, 1113.7048682099169, 1999.9000049997442, 10735.194860385502, 10779.0, 10810.405427701473, 10835.729106772395, 10875.293105948167, 4141.130362623822, 4334.371516130206, 4522.706024108488, 4531.18438681034, 4544.272916333371, 9157.130072643089, 9160.404573702688, 9161.31290153228, 9183.448993060438, 9250.0, 4967.279744437109, 5005.949940500621, 5024.120778863684, 5036.521530454601, 5062.7468626568525, 4250.0, 4686.976565117221, 4712.505186955389, 4716.693414928019, 4751.596114330251, 3655.5430571178604, 3685.9262814744093, 3734.402495600691, 3739.5325584301963, 3810.218905124498, 1097.0948967102172, 1145.6906635208447, 1147.925384849982, 1153.4463457540428, 1160.3733983648735, 988.8170688422665, 993.895640957689, 1020.1430798129459, 1031.9793604127876, 1036.8341065429495, 5886.941130588725, 5905.291365036223, 5966.508372906774, 6006.459418652343, 6106.175666285084, 935.7005758157325, 938.6761567259284, 943.580106852444, 947.052947052947, 963.5856581669949, 3887.339152344052, 4192.45498085247, 4209.663226941837, 4292.871213863589, 4306.2894622387585, 9483.193928516153, 9883.406995580288, 9952.651657191964, 9975.152112070555, 10203.693889183336, 9933.453660048623, 9965.25260605443, 9973.252006099572, 10045.799084018425, 10119.595216191417, 7514.511556748794, 7751.534907905544, 7756.612169391621, 7788.610569471503, 7894.0, 5686.289213848269, 5882.794102206402, 5899.557533185114, 5909.468147866713, 6016.699165041818, 9576.712698619052, 9651.951740241253, 9702.6118955241, 9703.417794932328, 9799.0, 9350.0, 9733.221342292742, 9916.950415247878, 9937.751556211153, 10007.649732259337, 7014.894776578253, 7199.928000719926, 7436.144843343085, 7609.315161635479, 7771.611419429119, 7874.094479134973, 7874.921250787419, 7881.172476890073, 7912.0901096374655, 7978.521288722695, 6978.930210697828, 7264.854702906018, 7275.708971641075, 7287.635618219174, 7347.118345798538, 7158.821029474305, 7164.856702866018, 7187.676554554953, 7220.205777364381, 7224.494285399972, 6525.967370163309, 6606.075149478981, 6612.669366531751, 6621.106150669598, 6627.0, 4806.8798280043275, 4876.073546026244, 4894.877628059185, 4920.704757714549, 4928.088303663833, 4891.070696567641, 4905.926411103907, 4927.260910863399, 4944.728039957837, 4950.133726597903], "value": 4446.88462237115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.0728177362987, 321.6365506977117, 329.3314571420017, 331.81750037479395, 332.7304883044732, 5958.553108516862, 6009.429104235096, 6049.969750151243, 6075.392460753922, 6081.908771368428, 5914.2902851657755, 5954.523638108952, 5956.910646340309, 5977.101105963604, 5986.371430999748, 4293.892652683677, 4366.585174408426, 4513.729176249435, 4531.6601254905845, 4558.088382323532, 4518.344839998198, 4523.683342166049, 4551.180787458256, 4559.156556037144, 4565.794539245725, 4502.459704835424, 4520.570545798144, 4526.773661316937, 4533.116042371739, 4550.590446859782, 4227.429297044906, 4430.49049359323, 4442.489113751928, 4445.622122119624, 4450.844220452269, 3863.652271295569, 3868.226354729037, 3880.961190388088, 3885.8834234972996, 3901.5708272090046, 5708.971455142698, 5730.971345143289, 5746.942530574683, 5774.538036957033, 5783.566232532577, 4930.827421040246, 5105.744712764384, 5130.281760553526, 5167.4057483389515, 5185.818496352647, 6166.938330616681, 6167.5682702210415, 6188.164597779287, 6234.937650623481, 6243.313235544087, 4197.307444271692, 4261.893452663678, 4278.978605106986, 4279.7218180818145, 4295.78521073945, 6445.51658625605, 6541.313162118005, 6560.442362399202, 6575.704093315764, 6577.177852768404, 4361.672874534423, 4381.978090109593, 4384.978075109604, 4408.53710360414, 4408.669349798778, 4363.105563359503, 4385.6710746694125, 4451.530994771718, 4475.753833539186, 4476.239039363316, 5106.208537676666, 5167.873436570896, 5197.194434862602, 5205.219217117463, 5222.399424066205, 6268.937310626835, 6273.780417685359, 6317.652529110943, 6321.273053598803, 6325.873482530324, 1482.9629259268604, 1495.244901324824, 1505.0969418348902, 1515.5604874586468, 1520.4602366159854, 952.7284723853669, 972.4019727867311, 986.0977205856705, 995.7560397702609, 1004.2116938203475, 5997.250343707036, 6034.728437220336, 6037.154798328237, 6058.242719660043, 6075.362086980804, 6292.559520833498, 6449.709763060673, 6453.870572649767, 6453.967730161319, 6461.676916154173, 5972.134040564094, 5984.640921544721, 6012.428819262163, 6015.849603759941, 6036.0, 3420.640832712529, 3436.536067630888, 3463.688268055887, 3465.965340346564, 3475.6350583188905, 6522.673866306665, 6567.014947757874, 6678.966605166943, 6682.63245521501, 6716.328367163343, 6561.5734977227285, 6574.671266436659, 6577.80266592003, 6595.0, 6600.141981542465, 6521.152250207443, 6620.139381880324, 6649.102371179829, 6653.534252602271, 6685.395505078844, 6411.679416029273, 6412.871742565029, 6416.230052393743, 6427.260865000398, 6444.645544495098, 6195.0, 6282.246130464374, 6305.621662700252, 6354.777582784581, 6364.713587888464, 6593.241777195684, 6641.667916604247, 6666.100076489612, 6667.8666426670225, 6678.198616165897, 4275.03811642378, 4290.249206388932, 4318.762468064287, 4334.306510958231, 4352.260115780388, 6151.507879369729, 6334.651594162366, 6335.366463353628, 6393.29673735898, 6394.872102558016, 6201.875962480815, 6223.471004964447, 6226.688665566794, 6239.376062393724, 6248.750049997949, 5998.880582097372, 6206.658633775186, 6235.532335074979, 6359.459445947146, 6412.358764123737, 6053.515718742402, 6227.0, 6256.155419018374, 6270.498360131087, 6275.3724627536885, 6360.204974378203, 6383.234011918599, 6396.264429590657, 6426.325235850169, 6436.710348034256, 6174.413430724074, 6256.624602523863, 6275.466585340298, 6323.430891219812, 6371.49028077762], "value": 4690.025029801806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.132332742302, 839.6011894350181, 859.6045818923293, 860.5611138319455, 869.8869147010888, 14382.280885955699, 14528.927355363221, 14794.112353258812, 14842.183679897615, 14890.181040042793, 14485.130892146479, 15201.54395368138, 15223.31495082721, 15230.390784368612, 15278.923605381957, 812.8699408094706, 829.3779665251062, 834.0700119366923, 838.2288294768797, 838.6351936907465, 838.5136620759976, 838.77353114659, 842.3008902610818, 842.473454091193, 843.6245870587591, 862.3144600042949, 869.2784988459595, 869.5261082709907, 870.3254977392509, 870.525563567857, 857.4555157474986, 862.0, 864.1747131489444, 866.8136350684601, 870.4124715816798, 631.3749388105788, 635.9618422894641, 636.2047440699126, 637.4199478474566, 638.1703785079378, 13822.37799299034, 13844.30778461083, 13867.4453021879, 13893.235872027035, 13944.02391832562, 12997.285149316784, 13401.530946416926, 13870.098443601133, 13976.440942362293, 14034.36845341962, 11680.299182049019, 11697.824532632018, 11717.414129293586, 11863.347515886622, 11915.821262681067, 3839.3856982882603, 3865.4781604483314, 3878.437626544135, 3882.1265215326607, 4000.0999775050673, 50878.0, 51207.74396127996, 51446.22830657506, 51830.22254666183, 58780.41219587792, 11065.834012489819, 11180.552777888794, 11398.746137924822, 11426.657200284004, 11445.198836081561, 18718.344857929907, 19139.13873875679, 19178.52053698641, 19220.327288544835, 19250.71123933142, 8254.958725206336, 8470.618822153017, 8528.275096616857, 8534.87197692035, 8819.11808819113, 4847.345608342899, 4869.464358920516, 4965.577925876269, 5001.89996200074, 5059.569936555434, 3222.3555288942307, 3268.2809781847955, 3278.7540934429535, 3279.3605246977086, 3280.3439312137666, 609.1806520230283, 611.5902345428574, 611.764470678783, 620.5004970998299, 620.959637623553, 722.3787542713262, 742.6546655805076, 758.6396461680657, 758.8444368904361, 793.6111305460283, 8827.337949653802, 8867.955660221787, 8939.865902011476, 9059.275257979345, 9374.95312523433, 561.486240090321, 644.635780783865, 714.2892821642499, 744.7244519527701, 767.2404319723433, 4170.793495951162, 4237.5762423758, 4298.41971333866, 4329.891752706208, 4385.978070109629, 57167.142492862644, 57598.42401575931, 57647.42352576421, 57653.71173144107, 57958.7102064487, 50401.0, 51112.48887511077, 51265.48734512607, 51415.74292128516, 52139.0, 45286.0, 45717.314240286425, 45741.771291143334, 45973.77013114913, 47058.76470617625, 8047.678092876219, 8130.918690813016, 8266.751997440086, 8273.793155171168, 8373.03710073325, 29825.105246842628, 30795.846020769754, 30869.0, 30877.8456107718, 32152.839235804608, 40250.0, 41861.79069104635, 42399.36400953926, 42443.36334954917, 42474.36288455738, 10437.582496700046, 10456.424896630759, 10800.567977280822, 10821.783564328827, 11004.614838480615, 11861.347625880315, 11942.820857687315, 11987.520499180284, 12132.696682583006, 12217.144799863925, 11491.54033838637, 11604.187706860439, 11625.244359116969, 11628.418579071182, 11904.404779760804, 11233.831492527455, 11716.88283117192, 11842.0, 11873.0, 11902.345371004678, 11487.827682584935, 11585.420728963349, 11818.586349477728, 12013.879861201276, 12120.636380908587, 9274.721758347261, 9337.346385752931, 9512.667056652985, 9734.561944712363, 9861.063198996084, 9114.498702571156, 9225.215856651992, 9236.0, 9240.491772952551, 9527.618895244113], "value": 6576.875278908996, "unit": "score"}], "name": "dromaeo_css", "value": 7060.112227629206, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 106.0, 114.0, 110.0, 119.0, 122.0, 111.0, 110.0, 111.0, 111.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 158.0, 176.0, 128.0, 159.0, 155.0, 138.0, 188.0, 129.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 162.0, 165.0, 172.0, 162.0, 165.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 156.0, 73.0, 76.0, 77.0, 78.0, 155.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 94.0, 93.0, 93.0, 138.0, 92.0, 93.0, 143.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 58.0, 58.0, 57.0, 57.0, 59.0, 77.0, 55.0, 56.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 67.0, 62.0, 62.0, 61.0, 63.0, 67.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 77.0, 78.0, 77.0, 77.0, 78.0, 79.0, 77.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 125.0, 129.0, 128.0, 126.0, 129.0, 125.0, 131.0, 158.0, 128.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 169.0, 171.0, 170.0, 168.0, 167.0, 167.0, 168.0, 168.0, 165.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 68.0, 69.0, 73.0, 68.0, 68.0, 69.0, 69.0, 69.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1560.6000000000001, "alertThreshold": 2.0}]} 10:28:07 INFO - Return code: 0 10:28:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:28:07 ERROR - # TBPL SUCCESS # 10:28:07 INFO - Running post-action listener: _resource_record_post_action 10:28:07 INFO - Running post-run listener: _resource_record_post_run 10:28:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7942144; Write bytes: 486866944; Read time: 2224; Write time: 529924 10:28:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78655488; Read time: 0; Write time: 85092 10:28:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 7942144; Write bytes: 398032896; Read time: 2224; Write time: 443956 10:28:08 INFO - Running post-run listener: _upload_blobber_files 10:28:08 INFO - Blob upload gear active. 10:28:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:08 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 10:28:08 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'] 10:28:08 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 10:28:08 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:09 INFO - (blobuploader) - INFO - Done attempting. 10:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:10 INFO - (blobuploader) - INFO - Done attempting. 10:28:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:10 INFO - Return code: 0 10:28:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46f81ddbdbc7741a4fa56d01d0cf40cc9e8661a68dea12839fb200c73176e773bf015fc9be634be4c2b4d19d2a46ed9bc30de7bad49c058526d6edb384de284f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/160945a17e8e6540a6ad3a68f78493f25fbc6bc73e5f1601b374e77f192547ac4d2a96015b1fd99f3e607066109d2db1aec7c9247fb0505deb675d6b75bfb359"} 10:28:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:10 INFO - Contents: 10:28:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/46f81ddbdbc7741a4fa56d01d0cf40cc9e8661a68dea12839fb200c73176e773bf015fc9be634be4c2b4d19d2a46ed9bc30de7bad49c058526d6edb384de284f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/160945a17e8e6540a6ad3a68f78493f25fbc6bc73e5f1601b374e77f192547ac4d2a96015b1fd99f3e607066109d2db1aec7c9247fb0505deb675d6b75bfb359"} 10:28:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:10 INFO - Copying logs to upload dir... 10:28:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.409062 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-16 10:28:10.774420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:28:10.778637) ========= 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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 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/46f81ddbdbc7741a4fa56d01d0cf40cc9e8661a68dea12839fb200c73176e773bf015fc9be634be4c2b4d19d2a46ed9bc30de7bad49c058526d6edb384de284f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/160945a17e8e6540a6ad3a68f78493f25fbc6bc73e5f1601b374e77f192547ac4d2a96015b1fd99f3e607066109d2db1aec7c9247fb0505deb675d6b75bfb359"} build_url:https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.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/46f81ddbdbc7741a4fa56d01d0cf40cc9e8661a68dea12839fb200c73176e773bf015fc9be634be4c2b4d19d2a46ed9bc30de7bad49c058526d6edb384de284f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/160945a17e8e6540a6ad3a68f78493f25fbc6bc73e5f1601b374e77f192547ac4d2a96015b1fd99f3e607066109d2db1aec7c9247fb0505deb675d6b75bfb359"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:28:10.804145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:28:10.804566) ========= 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=aa52b8aba932b19cc50b5275000001de-1460819690.446329-105025570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004356 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:28:10.889258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:28:10.889609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:28:10.889915) ========= ========= Total master_lag: 0.17 =========