builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1461419964.18 results: success (0) buildid: 20160423043011 builduid: afa2eaee260f40bcbbc656812b361155 revision: 2102e672350f76dc86fbfdcb14b2432578a52d27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.181360) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.181950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.182286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.223289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.223636) ========= 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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 06:59:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2016-04-23 06:59:24 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.345509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.345897) ========= 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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.395941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:24.396346) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2102e672350f76dc86fbfdcb14b2432578a52d27 --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 2102e672350f76dc86fbfdcb14b2432578a52d27 --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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 06:59:25,102 truncating revision to first 12 chars 2016-04-23 06:59:25,102 Setting DEBUG logging. 2016-04-23 06:59:25,102 attempt 1/10 2016-04-23 06:59:25,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2102e672350f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 06:59:25,792 unpacking tar archive at: mozilla-inbound-2102e672350f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:25.390311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:25.390669) ========= script_repo_revision: 2102e672350f76dc86fbfdcb14b2432578a52d27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:25.391151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:25.391472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 06:59:25.402732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-23 06:59:25.403067) ========= /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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:26 INFO - MultiFileLogger online at 20160423 06:59:26 in /builds/slave/test 06:59:26 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 06:59:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:26 INFO - {'append_to_log': False, 06:59:26 INFO - 'base_work_dir': '/builds/slave/test', 06:59:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:26 INFO - 'branch': 'Mozilla-Inbound', 06:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:26 INFO - 'config_files': ('talos/linux_config.py',), 06:59:26 INFO - 'default_actions': ('clobber', 06:59:26 INFO - 'read-buildbot-config', 06:59:26 INFO - 'download-and-extract', 06:59:26 INFO - 'populate-webroot', 06:59:26 INFO - 'create-virtualenv', 06:59:26 INFO - 'install', 06:59:26 INFO - 'run-tests'), 06:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:26 INFO - 'download_minidump_stackwalk': True, 06:59:26 INFO - 'download_symbols': 'ondemand', 06:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:26 INFO - 'installer_path': 'installer.exe', 06:59:26 INFO - 'log_level': 'info', 06:59:26 INFO - 'log_name': 'talos', 06:59:26 INFO - 'log_to_console': True, 06:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:26 INFO - 'opt_config_files': (), 06:59:26 INFO - 'pip_index': False, 06:59:26 INFO - 'sps_profile': False, 06:59:26 INFO - 'sps_profile_interval': 0, 06:59:26 INFO - 'suite': 'dromaeojs-e10s', 06:59:26 INFO - 'system_bits': '32', 06:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:26 INFO - 'title': 'talos-linux64-ix-035', 06:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:26 INFO - 'use_talos_json': True, 06:59:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:26 INFO - 'work_dir': 'build'} 06:59:26 INFO - ##### 06:59:26 INFO - ##### Running clobber step. 06:59:26 INFO - ##### 06:59:26 INFO - Running pre-action listener: _resource_record_pre_action 06:59:26 INFO - Running main action method: clobber 06:59:26 INFO - rmtree: /builds/slave/test/build 06:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:27 INFO - Running post-action listener: _resource_record_post_action 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running read-buildbot-config step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: read_buildbot_config 06:59:27 INFO - Using buildbot properties: 06:59:27 INFO - { 06:59:27 INFO - "project": "", 06:59:27 INFO - "product": "firefox", 06:59:27 INFO - "script_repo_revision": "production", 06:59:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 06:59:27 INFO - "repository": "", 06:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 06:59:27 INFO - "buildid": "20160423043011", 06:59:27 INFO - "pgo_build": "True", 06:59:27 INFO - "basedir": "/builds/slave/test", 06:59:27 INFO - "buildnumber": 501, 06:59:27 INFO - "slavename": "talos-linux64-ix-035", 06:59:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:59:27 INFO - "platform": "ubuntu64_hw", 06:59:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:59:27 INFO - "branch": "mozilla-inbound", 06:59:27 INFO - "repo_path": "integration/mozilla-inbound", 06:59:27 INFO - "revision": "2102e672350f76dc86fbfdcb14b2432578a52d27", 06:59:27 INFO - "stage_platform": "linux64-pgo", 06:59:27 INFO - "builduid": "afa2eaee260f40bcbbc656812b361155", 06:59:27 INFO - "slavebuilddir": "test" 06:59:27 INFO - } 06:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:59:27 INFO - Running post-action listener: _resource_record_post_action 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running download-and-extract step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: download_and_extract 06:59:27 INFO - mkdir: /builds/slave/test/build/tests 06:59:27 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')]} 06:59:27 INFO - https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:33 INFO - Downloaded 1361 bytes. 06:59:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:59:33 INFO - Using the following test package requirements: 06:59:33 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:59:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'jsshell-linux-x86_64.zip'], 06:59:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:33 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:33 INFO - https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:47 INFO - Downloaded 23858767 bytes. 06:59:47 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'] 06:59:47 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 06:59:49 INFO - Return code: 0 06:59:49 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 06:59:49 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')]} 06:59:49 INFO - https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:52 INFO - Downloaded 23858767 bytes. 06:59:52 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'] 06:59:52 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 06:59:53 INFO - Return code: 0 06:59:53 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')]} 06:59:53 INFO - https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:55 INFO - Downloaded 10840145 bytes. 06:59:55 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'] 06:59:55 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 06:59:55 INFO - Return code: 0 06:59: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')]} 06:59:55 INFO - https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:59:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:59:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:59:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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 06:59:57 INFO - Downloaded 58353685 bytes. 06:59:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:59:57 INFO - mkdir: /builds/slave/test/properties 06:59:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:57 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:57 INFO - Contents: 06:59:57 INFO - build_url:https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:59:58 INFO - Running post-action listener: _resource_record_post_action 06:59:58 INFO - Running post-action listener: set_extra_try_arguments 06:59:58 INFO - ##### 06:59:58 INFO - ##### Running populate-webroot step. 06:59:58 INFO - ##### 06:59:58 INFO - Running pre-action listener: _resource_record_pre_action 06:59:58 INFO - Running main action method: populate_webroot 06:59:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:58 INFO - '--tppagecycles', 06:59:58 INFO - '7'], 06:59:58 INFO - 'tests': ['tsvgm']}}, 06:59:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['damp', 'tps']}, 06:59:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'tests': ['damp', 'tps']}, 06:59:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['dromaeo_dom']}, 06:59:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['a11yr', 06:59:58 INFO - 'ts_paint', 06:59:58 INFO - 'tpaint', 06:59:58 INFO - 'sessionrestore', 06:59:58 INFO - 'sessionrestore_no_auto_restore', 06:59:58 INFO - 'tabpaint']}, 06:59:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['tsvgx', 06:59:58 INFO - 'tsvgr_opacity', 06:59:58 INFO - 'tart', 06:59:58 INFO - 'tscrollx', 06:59:58 INFO - 'cart']}, 06:59:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:58 INFO - 'tsvgr_opacity', 06:59:58 INFO - 'tart', 06:59:58 INFO - 'tscrollx', 06:59:58 INFO - 'cart']}, 06:59:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'talos_options': ['--disable-e10s'], 06:59:58 INFO - 'tests': ['tp5o']}, 06:59:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'tests': ['tp5o']}, 06:59:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'talos_options': ['--disable-e10s', 06:59:58 INFO - '--xperf_path', 06:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:58 INFO - 'tests': ['tp5n']}, 06:59:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:58 INFO - 'talos_options': ['--xperf_path', 06:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:58 INFO - 'tests': ['tp5n']}}, 06:59:58 INFO - 'talos.zip': {'path': '', 06:59:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:58 INFO - Running post-action listener: _resource_record_post_action 06:59:58 INFO - ##### 06:59:58 INFO - ##### Running create-virtualenv step. 06:59:58 INFO - ##### 06:59:58 INFO - Running pre-action listener: _resource_record_pre_action 06:59:58 INFO - Running main action method: create_virtualenv 06:59:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:58 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 06:59:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:58 INFO - Using real prefix '/usr' 06:59:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:00 INFO - Installing pip.................done. 07:00:00 INFO - Return code: 0 07:00:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:00 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')]} 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 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')]} 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:00 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 07:00:00 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 07:00:00 INFO - Using env: {'DISPLAY': ':0', 07:00:00 INFO - 'HOME': '/home/cltbld', 07:00:00 INFO - 'LANG': 'en_US.UTF-8', 07:00:00 INFO - 'LANGUAGE': 'en_US:en', 07:00:00 INFO - 'LOGNAME': 'cltbld', 07:00:00 INFO - 'MAIL': '/var/mail/cltbld', 07:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:00 INFO - 'MOZ_NO_REMOTE': '1', 07:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:00 INFO - 'NO_EM_RESTART': '1', 07:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:00 INFO - 'PWD': '/builds/slave/test', 07:00:00 INFO - 'SHELL': '/bin/bash', 07:00:00 INFO - 'SHLVL': '1', 07:00:00 INFO - 'TERM': 'linux', 07:00:00 INFO - 'TMOUT': '86400', 07:00:00 INFO - 'USER': 'cltbld', 07:00:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:00 INFO - '_': '/tools/buildbot/bin/python'} 07:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:00 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 07:00:00 INFO - Cleaning up... 07:00:00 INFO - Return code: 0 07:00:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:00:00 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')]} 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 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')]} 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:00 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:00 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 07:00:00 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 07:00:00 INFO - Using env: {'DISPLAY': ':0', 07:00:00 INFO - 'HOME': '/home/cltbld', 07:00:00 INFO - 'LANG': 'en_US.UTF-8', 07:00:00 INFO - 'LANGUAGE': 'en_US:en', 07:00:00 INFO - 'LOGNAME': 'cltbld', 07:00:00 INFO - 'MAIL': '/var/mail/cltbld', 07:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:00 INFO - 'MOZ_NO_REMOTE': '1', 07:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:00 INFO - 'NO_EM_RESTART': '1', 07:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:00 INFO - 'PWD': '/builds/slave/test', 07:00:00 INFO - 'SHELL': '/bin/bash', 07:00:00 INFO - 'SHLVL': '1', 07:00:00 INFO - 'TERM': 'linux', 07:00:00 INFO - 'TMOUT': '86400', 07:00:00 INFO - 'USER': 'cltbld', 07:00:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:00 INFO - '_': '/tools/buildbot/bin/python'} 07:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:01 INFO - Downloading/unpacking psutil>=0.7.1 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:03 INFO - Installing collected packages: psutil 07:00:03 INFO - Running setup.py install for psutil 07:00:03 INFO - building 'psutil._psutil_linux' extension 07:00:03 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 07:00:03 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 07:00:03 INFO - building 'psutil._psutil_posix' extension 07:00:03 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 07:00:03 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 07:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:03 INFO - Successfully installed psutil 07:00:03 INFO - Cleaning up... 07:00:03 INFO - Return code: 0 07:00:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:00:03 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')]} 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:03 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')]} 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:03 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:03 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 07:00:03 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 07:00:03 INFO - Using env: {'DISPLAY': ':0', 07:00:03 INFO - 'HOME': '/home/cltbld', 07:00:03 INFO - 'LANG': 'en_US.UTF-8', 07:00:03 INFO - 'LANGUAGE': 'en_US:en', 07:00:03 INFO - 'LOGNAME': 'cltbld', 07:00:03 INFO - 'MAIL': '/var/mail/cltbld', 07:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:03 INFO - 'MOZ_NO_REMOTE': '1', 07:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:03 INFO - 'NO_EM_RESTART': '1', 07:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:03 INFO - 'PWD': '/builds/slave/test', 07:00:03 INFO - 'SHELL': '/bin/bash', 07:00:03 INFO - 'SHLVL': '1', 07:00:03 INFO - 'TERM': 'linux', 07:00:03 INFO - 'TMOUT': '86400', 07:00:03 INFO - 'USER': 'cltbld', 07:00:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:03 INFO - '_': '/tools/buildbot/bin/python'} 07:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:06 INFO - Installing collected packages: mozsystemmonitor 07:00:06 INFO - Running setup.py install for mozsystemmonitor 07:00:06 INFO - Successfully installed mozsystemmonitor 07:00:06 INFO - Cleaning up... 07:00:06 INFO - Return code: 0 07:00:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:06 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')]} 07:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:06 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')]} 07:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:06 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:06 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 07:00:06 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 07:00:06 INFO - Using env: {'DISPLAY': ':0', 07:00:06 INFO - 'HOME': '/home/cltbld', 07:00:06 INFO - 'LANG': 'en_US.UTF-8', 07:00:06 INFO - 'LANGUAGE': 'en_US:en', 07:00:06 INFO - 'LOGNAME': 'cltbld', 07:00:06 INFO - 'MAIL': '/var/mail/cltbld', 07:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:06 INFO - 'MOZ_NO_REMOTE': '1', 07:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:06 INFO - 'NO_EM_RESTART': '1', 07:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:06 INFO - 'PWD': '/builds/slave/test', 07:00:06 INFO - 'SHELL': '/bin/bash', 07:00:06 INFO - 'SHLVL': '1', 07:00:06 INFO - 'TERM': 'linux', 07:00:06 INFO - 'TMOUT': '86400', 07:00:06 INFO - 'USER': 'cltbld', 07:00:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:06 INFO - '_': '/tools/buildbot/bin/python'} 07:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:07 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 07:00:07 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 07:00:07 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 07:00:07 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 07:00:07 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 07:00:07 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 07:00:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:09 INFO - Downloading docopt-0.6.1.tar.gz 07:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:09 INFO - Running setup.py install for blobuploader 07:00:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:09 INFO - Running setup.py install for requests 07:00:10 INFO - Running setup.py install for docopt 07:00:10 INFO - Successfully installed blobuploader requests docopt 07:00:10 INFO - Cleaning up... 07:00:10 INFO - Return code: 0 07:00:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:10 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:10 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 07:00:10 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 07:00:10 INFO - Using env: {'DISPLAY': ':0', 07:00:10 INFO - 'HOME': '/home/cltbld', 07:00:10 INFO - 'LANG': 'en_US.UTF-8', 07:00:10 INFO - 'LANGUAGE': 'en_US:en', 07:00:10 INFO - 'LOGNAME': 'cltbld', 07:00:10 INFO - 'MAIL': '/var/mail/cltbld', 07:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:10 INFO - 'MOZ_NO_REMOTE': '1', 07:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:10 INFO - 'NO_EM_RESTART': '1', 07:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:10 INFO - 'PWD': '/builds/slave/test', 07:00:10 INFO - 'SHELL': '/bin/bash', 07:00:10 INFO - 'SHLVL': '1', 07:00:10 INFO - 'TERM': 'linux', 07:00:10 INFO - 'TMOUT': '86400', 07:00:10 INFO - 'USER': 'cltbld', 07:00:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:10 INFO - '_': '/tools/buildbot/bin/python'} 07:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:10 INFO - Running setup.py (path:/tmp/pip-smpOM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:10 INFO - Running setup.py (path:/tmp/pip-TZS6Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:10 INFO - Running setup.py (path:/tmp/pip-cY74DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:10 INFO - Running setup.py (path:/tmp/pip-jA8qhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:10 INFO - Running setup.py (path:/tmp/pip-_xXXur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:10 INFO - Running setup.py (path:/tmp/pip-fauqBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:11 INFO - Running setup.py (path:/tmp/pip-wymwtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:11 INFO - Running setup.py (path:/tmp/pip-7ElMSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:11 INFO - Running setup.py (path:/tmp/pip-x24LV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:11 INFO - Running setup.py (path:/tmp/pip-GHGaS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:11 INFO - Running setup.py (path:/tmp/pip-N7ACji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:11 INFO - Running setup.py (path:/tmp/pip-NYu1FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:11 INFO - Running setup.py (path:/tmp/pip-Xln7Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:11 INFO - Running setup.py (path:/tmp/pip-xZn2MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:11 INFO - Running setup.py (path:/tmp/pip-m_9IQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:11 INFO - Running setup.py (path:/tmp/pip-FrbcHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:11 INFO - Running setup.py (path:/tmp/pip-vgTnRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:11 INFO - Running setup.py install for manifestparser 07:00:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:11 INFO - Running setup.py install for mozcrash 07:00:12 INFO - Running setup.py install for mozdebug 07:00:12 INFO - Running setup.py install for mozdevice 07:00:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for mozfile 07:00:12 INFO - Running setup.py install for mozhttpd 07:00:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for mozinfo 07:00:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for mozInstall 07:00:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for mozleak 07:00:12 INFO - Running setup.py install for mozlog 07:00:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for moznetwork 07:00:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:12 INFO - Running setup.py install for mozprocess 07:00:13 INFO - Running setup.py install for mozprofile 07:00:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:13 INFO - Running setup.py install for mozrunner 07:00:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:13 INFO - Running setup.py install for mozscreenshot 07:00:13 INFO - Running setup.py install for moztest 07:00:13 INFO - Running setup.py install for mozversion 07:00:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:13 INFO - Cleaning up... 07:00:13 INFO - Return code: 0 07:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:13 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')]} 07:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:13 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')]} 07:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:13 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:13 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 07:00:13 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 07:00:13 INFO - Using env: {'DISPLAY': ':0', 07:00:13 INFO - 'HOME': '/home/cltbld', 07:00:13 INFO - 'LANG': 'en_US.UTF-8', 07:00:13 INFO - 'LANGUAGE': 'en_US:en', 07:00:13 INFO - 'LOGNAME': 'cltbld', 07:00:13 INFO - 'MAIL': '/var/mail/cltbld', 07:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:13 INFO - 'MOZ_NO_REMOTE': '1', 07:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:13 INFO - 'NO_EM_RESTART': '1', 07:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:13 INFO - 'PWD': '/builds/slave/test', 07:00:13 INFO - 'SHELL': '/bin/bash', 07:00:13 INFO - 'SHLVL': '1', 07:00:13 INFO - 'TERM': 'linux', 07:00:13 INFO - 'TMOUT': '86400', 07:00:13 INFO - 'USER': 'cltbld', 07:00:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:13 INFO - '_': '/tools/buildbot/bin/python'} 07:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:13 INFO - Running setup.py (path:/tmp/pip-EJ2tqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:13 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)) 07:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:13 INFO - Running setup.py (path:/tmp/pip-aUNMvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:14 INFO - Running setup.py (path:/tmp/pip-7u7nzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:14 INFO - Running setup.py (path:/tmp/pip-vs7U2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:14 INFO - Running setup.py (path:/tmp/pip-z2ZI2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:14 INFO - Running setup.py (path:/tmp/pip-A8LuiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:14 INFO - Running setup.py (path:/tmp/pip-SZCWHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:14 INFO - Running setup.py (path:/tmp/pip-Wjxb9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:14 INFO - Running setup.py (path:/tmp/pip-ewD24L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:14 INFO - Running setup.py (path:/tmp/pip-Grnn1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:14 INFO - Running setup.py (path:/tmp/pip-1lRhuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:14 INFO - Running setup.py (path:/tmp/pip-HQEMGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:14 INFO - Running setup.py (path:/tmp/pip-UjdRgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:14 INFO - Running setup.py (path:/tmp/pip-jVeVtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:14 INFO - Running setup.py (path:/tmp/pip-INA_ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:14 INFO - Running setup.py (path:/tmp/pip-LuSQkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:14 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)) 07:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:14 INFO - Running setup.py (path:/tmp/pip-z7xB97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:15 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)) 07:00:15 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)) 07:00:15 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)) 07:00:15 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)) 07:00:15 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)) 07:00:15 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)) 07:00:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - Downloading blessings-1.6.tar.gz 07:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:17 INFO - Installing collected packages: blessings 07:00:17 INFO - Running setup.py install for blessings 07:00:17 INFO - Successfully installed blessings 07:00:17 INFO - Cleaning up... 07:00:17 INFO - Return code: 0 07:00:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:17 INFO - Reading from file tmpfile_stdout 07:00:17 INFO - Current package versions: 07:00:17 INFO - argparse == 1.2.1 07:00:17 INFO - blessings == 1.6 07:00:17 INFO - blobuploader == 1.2.4 07:00:17 INFO - docopt == 0.6.1 07:00:17 INFO - manifestparser == 1.1 07:00:17 INFO - mozInstall == 1.12 07:00:17 INFO - mozcrash == 0.17 07:00:17 INFO - mozdebug == 0.1 07:00:17 INFO - mozdevice == 0.48 07:00:17 INFO - mozfile == 1.2 07:00:17 INFO - mozhttpd == 0.7 07:00:17 INFO - mozinfo == 0.9 07:00:17 INFO - mozleak == 0.1 07:00:17 INFO - mozlog == 3.1 07:00:17 INFO - moznetwork == 0.27 07:00:17 INFO - mozprocess == 0.22 07:00:17 INFO - mozprofile == 0.28 07:00:17 INFO - mozrunner == 6.11 07:00:17 INFO - mozscreenshot == 0.1 07:00:17 INFO - mozsystemmonitor == 0.0 07:00:17 INFO - moztest == 0.7 07:00:17 INFO - mozversion == 1.4 07:00:17 INFO - psutil == 3.1.1 07:00:17 INFO - requests == 1.2.3 07:00:17 INFO - wsgiref == 0.1.2 07:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:17 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 07:00:17 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 07:00:17 INFO - Using env: {'DISPLAY': ':0', 07:00:17 INFO - 'HOME': '/home/cltbld', 07:00:17 INFO - 'LANG': 'en_US.UTF-8', 07:00:17 INFO - 'LANGUAGE': 'en_US:en', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MAIL': '/var/mail/cltbld', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SHLVL': '1', 07:00:17 INFO - 'TERM': 'linux', 07:00:17 INFO - 'TMOUT': '86400', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - '_': '/tools/buildbot/bin/python'} 07:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 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)) 07:00:17 INFO - Cleaning up... 07:00:17 INFO - Return code: 0 07:00:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:17 INFO - Using env: {'DISPLAY': ':0', 07:00:17 INFO - 'HOME': '/home/cltbld', 07:00:17 INFO - 'LANG': 'en_US.UTF-8', 07:00:17 INFO - 'LANGUAGE': 'en_US:en', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MAIL': '/var/mail/cltbld', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SHLVL': '1', 07:00:17 INFO - 'TERM': 'linux', 07:00:17 INFO - 'TMOUT': '86400', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - '_': '/tools/buildbot/bin/python'} 07:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:17 INFO - Downloading/unpacking jsonschema 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 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 07:00:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:19 INFO - warning: no files found matching '*.txt' 07:00:19 INFO - no previously-included directories found matching 'build' 07:00:19 INFO - no previously-included directories found matching 'dist' 07:00:19 INFO - no previously-included directories found matching '.git*' 07:00:19 INFO - Installing collected packages: jsonschema, functools32 07:00:20 INFO - Running setup.py install for functools32 07:00:20 INFO - warning: no files found matching '*.txt' 07:00:20 INFO - no previously-included directories found matching 'build' 07:00:20 INFO - no previously-included directories found matching 'dist' 07:00:20 INFO - no previously-included directories found matching '.git*' 07:00:20 INFO - Successfully installed jsonschema functools32 07:00:20 INFO - Cleaning up... 07:00:20 INFO - Return code: 0 07:00:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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 0x7f3404fe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', '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 07:00:20 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 07:00:20 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 07:00:20 INFO - Using env: {'DISPLAY': ':0', 07:00:20 INFO - 'HOME': '/home/cltbld', 07:00:20 INFO - 'LANG': 'en_US.UTF-8', 07:00:20 INFO - 'LANGUAGE': 'en_US:en', 07:00:20 INFO - 'LOGNAME': 'cltbld', 07:00:20 INFO - 'MAIL': '/var/mail/cltbld', 07:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:20 INFO - 'MOZ_NO_REMOTE': '1', 07:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:20 INFO - 'NO_EM_RESTART': '1', 07:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:20 INFO - 'PWD': '/builds/slave/test', 07:00:20 INFO - 'SHELL': '/bin/bash', 07:00:20 INFO - 'SHLVL': '1', 07:00:20 INFO - 'TERM': 'linux', 07:00:20 INFO - 'TMOUT': '86400', 07:00:20 INFO - 'USER': 'cltbld', 07:00:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:20 INFO - '_': '/tools/buildbot/bin/python'} 07:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:20 INFO - Downloading/unpacking flake8 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 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 07:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:22 INFO - no previously-included directories found matching 'docs/_build' 07:00:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:23 INFO - Running setup.py install for pep8 07:00:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:23 INFO - no previously-included directories found matching 'docs/_build' 07:00:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:23 INFO - Cleaning up... 07:00:23 INFO - Return code: 0 07:00:23 INFO - Running post-action listener: _resource_record_post_action 07:00:23 INFO - Running post-action listener: _start_resource_monitoring 07:00:23 INFO - Starting resource monitoring. 07:00:23 INFO - ##### 07:00:23 INFO - ##### Running install step. 07:00:23 INFO - ##### 07:00:23 INFO - Running pre-action listener: _resource_record_pre_action 07:00:23 INFO - Running main action method: install 07:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:23 INFO - Reading from file tmpfile_stdout 07:00:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:23 INFO - Reading from file tmpfile_stdout 07:00:23 INFO - Output received: 07:00:23 INFO - Usage: mozinstall [options] installer 07:00:23 INFO - Options: 07:00:23 INFO - -h, --help show this help message and exit 07:00:23 INFO - -d DEST, --destination=DEST 07:00:23 INFO - Directory to install application into. [default: 07:00:23 INFO - "/builds/slave/test"] 07:00:23 INFO - --app=APP Application being installed. [default: firefox] 07:00:23 INFO - mkdir: /builds/slave/test/build/application 07:00:23 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'] 07:00:23 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 07:00:40 INFO - Reading from file tmpfile_stdout 07:00:40 INFO - Output received: 07:00:40 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:40 INFO - Running post-action listener: _resource_record_post_action 07:00:40 INFO - ##### 07:00:40 INFO - ##### Running run-tests step. 07:00:40 INFO - ##### 07:00:40 INFO - Running pre-action listener: _resource_record_pre_action 07:00:40 INFO - Running main action method: run_tests 07:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:40 INFO - Python 2.7.3 07:00:40 INFO - Return code: 0 07:00:40 INFO - grabbing minidump binary from tooltool 07:00:40 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')]} 07:00:40 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 0x10a5410>, '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 0x10a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:40 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 07:00:40 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 07:00:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:40 INFO - Return code: 0 07:00:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:00:41 INFO - Return code: 0 07:00:41 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/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:00:41 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/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:00:41 INFO - Using env: {'DISPLAY': ':0', 07:00:41 INFO - 'HOME': '/home/cltbld', 07:00:41 INFO - 'LANG': 'en_US.UTF-8', 07:00:41 INFO - 'LANGUAGE': 'en_US:en', 07:00:41 INFO - 'LOGNAME': 'cltbld', 07:00:41 INFO - 'MAIL': '/var/mail/cltbld', 07:00:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:41 INFO - 'MOZ_NO_REMOTE': '1', 07:00:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:41 INFO - 'NO_EM_RESTART': '1', 07:00:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:41 INFO - 'PWD': '/builds/slave/test', 07:00:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:41 INFO - 'SHELL': '/bin/bash', 07:00:41 INFO - 'SHLVL': '1', 07:00:41 INFO - 'TERM': 'linux', 07:00:41 INFO - 'TMOUT': '86400', 07:00:41 INFO - 'USER': 'cltbld', 07:00:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420', 07:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:41 INFO - '_': '/tools/buildbot/bin/python'} 07:00:41 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/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:00:41 INFO - mozversion application_buildid: 20160423043011 07:00:41 INFO - mozversion application_changeset: 2102e672350f76dc86fbfdcb14b2432578a52d27 07:00:41 INFO - mozversion application_display_name: Nightly 07:00:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:41 INFO - mozversion application_name: Firefox 07:00:41 INFO - mozversion application_remotingname: firefox 07:00:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:41 INFO - mozversion application_vendor: Mozilla 07:00:41 INFO - mozversion application_version: 48.0a1 07:00:41 INFO - mozversion platform_buildid: 20160423043011 07:00:41 INFO - mozversion platform_changeset: 2102e672350f76dc86fbfdcb14b2432578a52d27 07:00:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:41 INFO - mozversion platform_version: 48.0a1 07:00:41 INFO - using testdate: 1461420041 07:00:41 INFO - actual date: 1461420041 07:00:41 INFO - starting webserver on 'localhost:45833' 07:00:41 INFO - SUITE-START | Running 2 tests 07:00:41 INFO - TEST-START | dromaeo_css 07:00:41 INFO - operating with platform_type : linux_ 07:00:41 INFO - Initialising browser for dromaeo_css test... 07:00:41 INFO - TEST-INFO | started process 16364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXtlZp0/profile http://localhost:45833/getInfo.html) 07:00:44 INFO - PROCESS | 16364 | 07:00:44 INFO - PROCESS | 16364 | (process:16432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:00:45 INFO - PROCESS | 16364 | __metrics Screen width/height:1600/1200 07:00:45 INFO - PROCESS | 16364 | colorDepth:24 07:00:45 INFO - PROCESS | 16364 | Browser inner width/height: 1024/697 07:00:45 INFO - PROCESS | 16364 | __metrics 07:00:46 ERROR - PROCESS | 16364 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:00:47 INFO - TEST-INFO | 16364: exit 0 07:00:47 INFO - Browser initialized. 07:00:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:47 INFO - TEST-INFO | started process 16483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXtlZp0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:49 INFO - PROCESS | 16483 | 07:00:49 INFO - PROCESS | 16483 | (process:16542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:00:59 INFO - PROCESS | 16483 | RSS: Main: 164532224 07:00:59 INFO - PROCESS | 16483 | 07:01:48 INFO - PROCESS | 16483 | 1461420108606 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] 07:03:56 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45833/tests/dromaeo/cssquery-ext.html) 07:03:57 INFO - PROCESS | 16483 | RSS: Main: 169529344 07:03:57 INFO - PROCESS | 16483 | 07:06:59 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-ext.html (next: http://localhost:45833/tests/dromaeo/cssquery-jquery.html) 07:06:59 INFO - PROCESS | 16483 | RSS: Main: 166735872 07:06:59 INFO - PROCESS | 16483 | 07:10:01 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45833/tests/dromaeo/cssquery-mootools.html) 07:10:02 INFO - PROCESS | 16483 | RSS: Main: 167284736 07:10:02 INFO - PROCESS | 16483 | 07:13:03 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45833/tests/dromaeo/cssquery-prototype.html) 07:13:04 INFO - PROCESS | 16483 | RSS: Main: 165228544 07:13:04 INFO - PROCESS | 16483 | 07:16:06 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45833/tests/dromaeo/cssquery-yui.html) 07:16:07 INFO - PROCESS | 16483 | RSS: Main: 166461440 07:16:07 INFO - PROCESS | 16483 | 07:19:09 INFO - PROCESS | 16483 | Cycle 1(1): loaded http://localhost:45833/tests/dromaeo/cssquery-yui.html (next: http://localhost:45833/tests/dromaeo/cssquery-dojo.html) 07:19:10 INFO - PROCESS | 16483 | RSS: Main: 168648704 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | __start_tp_report 07:19:10 INFO - PROCESS | 16483 | _x_x_mozilla_page_load 07:19:10 INFO - PROCESS | 16483 | _x_x_mozilla_page_load_details 07:19:10 INFO - PROCESS | 16483 | |i|pagename|runs| 07:19:10 INFO - PROCESS | 16483 | |0;dojo.html;3075.6309242890848;3155.384699983504;3161.715445609895;3173.5715678383413;3181.2365032392217;5306.575473962079;5330.760115794789;5365.704886231256;5369.48989845965;5405.35135783706;5274;5326.067938110825;5337.6797392156495;5351.224072509483;5413.485718856702;4794.448638406576;4862.5380588844;4907.950920490785;4951.356323677916;4989.027139707759;828.2914833662487;4737.620990320784;4808;4854.587360074398;4982;4885.8626384253175;4894.779734911937;4899.191633380506;4923.581495572863;4936.851894443173;4924;4926.8768280793265;4929.2113261878285;4934.235193545006;4952.678075925053;4834.202356611155;4851.878703032452;4877.731724755137;4893.119238537062;4912.189488734391;5205.765740541685;5228.398734145584;5256.369235691704;5259.658122222043;5266.710330931797;5565.888682226373;5644.096944488862;5665.348484924204;5666.773329066832;5676.8864622707315;5714.628549144292;5721.513671337942;5763.855903602402;5775;5814.244148260699;5317.282166907496;5330.866728331784;5336.43967383423;5344.331958505187;5358.973205133989;5616.269884914935;5806.88386232273;5835.095560188092;5885.6174348668055;5897.941020589825;5581.107022876401;5610.102383618683;5612.045952188138;5617.354004289477;5619.971900140473;5655.773769049274;5658.981383351036;5666.660000399989;5681.0626246668835;5682.289713785777;5674.631148975386;5757.827265182052;5788.5369170466265;5790.392008839095;5853.824385268449;5602.439756024365;5618.185363122325;5654.660720356792;5660.97169514158;5675.943240567624;4201.936970945439;4266.765327906995;4273.529911709709;4280.143971205771;4332.848350307724;3738.36447803874;3809.6761775249415;3831.233753249361;3831.750936189139;3870.59358767331;5288.7091209983055;5299.205119232146;5451.754671039813;5464.617476776667;5498.285222920995;5722.284714410699;5723.198752174699;5769.826905192851;5787.971060144757;5807.738651760681;5293.470652934753;5453.727313634303;5455.645383050089;5485.341758988867;5531.557475401958;4887.340209071801;4889.731064791471;4897.877553061131;4924.285978533093;4961.5286547777905;5867.3839246879315;5883.646981181143;5888.087346461305;5904.350521442638;5911.733971971272;5554.333479982266;5699.344575373885;5716.114002329646;5775.971120144372;5793.044147715748;5880.441358070976;5883.2057672215415;5883.823485295448;5893.528517718658;5895.115732640138;5649.745761440663;5650.519705825051;5653.067243904709;5654.491095801233;5659.9151012735665;5519.724013799214;5789.45000224978;5833.095870140135;5859.5019423349495;5886.146508756292;5491.176323551499;5525.889482210414;5534.7786088556;5537.418571049981;5547.112462006221;5443.482869127427;5531.3362396512675;5535.225068490334;5535.335759708861;5542.861428464159;5587.888242235052;5613.494785469164;5618.494335509824;5632.127020311858;5658.292713410824;5538.363088244903;5576.832695019156;5649.152627105967;5666.121751128581;5668.971655141863;5404.081306177881;5489.780408783604;5529.972350138223;5531.225628412106;5552.333719953632 07:19:10 INFO - PROCESS | 16483 | |1;ext.html;613.3559762249637;656.8160914943816;660.9173853268338;668.5119862500375;686.2794066230457;35819;37358.43962340567;37422.62577374226;37551;37568.62431375685;41205.79397103018;41901;42056.15887682245;42073.789631051804;42089.78955105228;8529.275011624019;8664;8671.482490564158;8672.392932494728;8696.34777391695;8594.957025214866;8682.913170868305;8715.346349023817;8750.12498750123;8763.07987661296;8728.825423491526;8741.825163496726;8764.386492945496;8820.073892241318;8822.558872056372;8709.95645021774;8739.694110706127;8764.386492945496;8766.605502752327;8781.64873405063;8541.145885411472;8704.434211776213;8705.6517739291;8728;8741.475511469333;29377.70622293771;37222.62777372219;37530.43704344437;37553.62446375529;37798.24403511942;3327.251368442081;3410.420228561126;3439.5528581284275;3514.3674138655033;3529.6117427083;29595.260118496994;29948.251293717614;30329.393412131856;30515.694843051508;30625.846870765727;3572.499850020973;3607.5288427427295;3628.909277268063;3653.488511608377;3731.9440208396895;223608;229002;229597;229782.85108574518;255721;58736.706316468146;59093.40906590965;59239.99999999914;59554;59663.70168149218;59591.70204149038;60743;61285;61364.38635613676;61420;17054.573635659206;17082.145892705314;17152.656946861243;17216.05311707868;17262.136893155293;12671.873281267253;12774.23354598727;12828.679283017998;12841.293728844816;12940.09419340637;20023.399298021082;20071.899640501702;20332.08505617251;20809.1676332948;21083.472913177295;7586.696532138652;7746.30283274508;7909.52542847431;8037;8135.877961830577;1045.5660900726266;1063.9308444951052;1097.4183682648209;1142.782871254459;1148.8104462763717;30976.69023309783;31006.84496577548;31066.68933310638;31310.217244569067;31537.211569710482;1124.2860783402598;1128.5824245029391;1165.2367699156896;1173.9706507337214;1212.4725744301256;16446;16651.25069371881;16685.582860428585;16709.582260443585;17059.48821535356;453273;461518;461713;463947;466266;56407.15389269164;56932;57211.71394143086;57372.42627573671;57459.71270143623;1418.7304412161864;1427.745318949536;1429.942802287897;1437.4609521429254;1502.1362716437873;30020.24949376283;30370.240743980692;30459;30629.80199653035;30669.8466507666;49151.26273105835;49181.262281065094;49331;49464.752676236385;49595.75202123966;393348;394491;395037;395299;397235;28615;28747;28937.56593651055;28979.130626081253;29168.854155729085;46298.53701462942;46361;46716;47043.29435058546;47411.28883066826;39680.66380440958;40757.1848563033;41059.384109238985;41399.1720165601;41688.79155604324;39297.41053884251;39425.2114957705;40609.39085913655;40673.38989915094;41345.586544134174;36846.63153368432;37592;37751;40087.198256034135;40250;31743.682563174072;32786.836065819516;33731.32537349288;34787.65212347844;35000.29999400049;25572.360690982874;26525.86737066302;27231;27629.30926726848;27687.169384918485 07:19:10 INFO - PROCESS | 16483 | |2;jquery.html;386.28537206168585;386.8510623409986;397.3483487081186;397.3542992636963;408.25085967250095;14296.770843215883;17658.293668253253;17677.143899890518;18310.542236444096;18318.725219121723;17784.288628454848;17821.198046087924;18010.369637062704;18703.532411689714;18868.245270189174;5191.091558977183;5346.091164502044;6961.895571566431;7328.853422931538;7406.740764073258;6741.865162696743;7173.139223293212;7182.8563428731395;7275.054242948409;7315.963420182891;6777.559458635173;7089.971954066657;7091.326323999212;7096;7113.359797618214;7299.5255308404785;7321.707131714725;7395.075615548057;7400.777976660709;7410.5924174170395;6978.651067446658;7057.823554411129;7221.602811845346;7241.203467618558;7250.854982900312;24734;25584.23247302584;25989.870050649813;27327.273452138907;27406.314842129108;2311.1448763957274;2455.9386015349583;2513.3465299022205;2662.720414356484;2774.18161642316;15944.521664350088;16091.074427803354;16431;16556.254968526446;16590.75113873293;1971.3297478857257;2081.6253074446595;2093.5184907471216;2136.316378758798;2179.2917301876955;91219.54390228073;91857.54071229669;92160;92296.53851730765;93490.53254733683;17714.645707085787;17765.289388424575;18114.456566303033;18131.818681813278;18274.725879111826;13478.326083695776;14220.288985550887;32205;32349.51475727866;32354.514682279783;7855.096663883726;8009.359251259885;8207.630656620466;8283;8289;7830.295273425305;7843.803904902309;7981.042274927046;8003.639836207385;8131;4275.40144379787;4321.913561728811;4325.1782161389865;4344.630706389992;4354.4992325882295;1826.2603645523584;1832.9266829326943;1868.6169335286233;1880.4358692392227;1896.345760712552;966.2028826218258;1006.8540061691014;1047.0681093826502;1097.237419993113;1116.4194618798178;18603.90698046501;18727;19161;19213.807861921483;19242.903785480983;1025.6974192613197;1030.9639162629271;1034.6740776655329;1086.782643471293;1121.1199208621192;10375.27373083877;10604.151667866552;10736.248462607542;10793.67618971432;10811.6215932442;459946;463262;478744;518370;520296;92958;98758.50620746994;99031;100334.99330013359;100401.49799251102;1041.5677493840124;1067.8771941226858;1096.9890301096887;1128.0411650097515;1129.0290350298737;16578.50264492067;16851.7472237919;17029.063401513034;17132.14339283056;17193.742093868354;33567.32865342631;38819.223615526964;40474;40734.59265407308;41690.79154604208;51303.48696512987;55162.72418637881;55197.44802551923;55233;55316;7920.84158316842;8057.315128213933;8356.832863342577;8414.410991230556;8594.140585941606;7667.858364778476;11037.944810275898;13372.93313533426;13515.797263040866;13794.793078104038;11685.532578696757;11823.586174483851;11973.880261197277;11993.980511656608;12014.879851201726;11902.166848320534;12006.459709312927;12051.698707532381;12201.572944946884;12276.324802135969;11647.12646551529;11926.880731192925;12081;12169.939150304192;12312.81530777057;8309.95845020771;8351.1648835116;8367.832643346977;8406.789830254293;8671.132886711279;8512.914335987723;10326.225533084898;11384.37385943781;11552.537898483966;11565.884341156481 07:19:10 INFO - PROCESS | 16483 | |3;mootools.html;1495.0655840099942;1500.8799296056313;1671.5653929978203;1741.8519425848801;1749.9825001749978;7095.716171353152;7725.497842640224;7735.38116950644;8095.109537950828;8102.432829701923;7805.063392392921;7846.176151504095;7874.0157480314965;7880.251376119274;7909.446338756289;2232.2856685860493;2252.222983070838;2256.8533045352083;2258.4692597239637;2260.6156953317977;2208.392692009702;2236.910523579055;2264.61501544737;2276.9203077892275;2278.5898538263104;2164.3831508020216;2187.0158428707064;2193.2214064007285;2209.845310828243;2214.7895949884814;2240.1823334482797;2255.0979608156704;2269.954600907981;2270.1260014894383;2276.226083131735;2219.4340443187048;2220.922267720622;2225.922092726747;2259.898304576298;2264.2188444986455;8003.159668234868;8075.555844428554;8081.070676872177;8083.989501312336;8101.02787665478;4610.354550362952;4741.454732705714;4761.976190119062;4780.976095119537;4792.520747925215;3008.638963324393;3110.424571454288;3187.059817353886;3256.3812875553567;3257.1368587324378;1033.7467320506448;1042.6298663974255;1042.880068792091;1084.69628504019;1925.6245032218724;10716.464176791207;10743.78512429747;10754.08590269828;10859.34843909368;10887.23789334739;4183.958160418357;4189.53366321785;4229.725067870579;4276.251655960256;4277.807498662568;8700.912990870136;8783.604737786814;8794.34042446819;8808.295336373074;8823;4907.533784290486;4918.606511479073;4920.852374428773;4943.579795717333;4949;3917.6082391760597;4449.866504004885;4489.012417268195;4518.2319005769095;4526.434195725535;3519.6480351964597;3523.2601153757487;3581.068922080226;3628.0385697790107;3644.0707619556842;1081.6863109698256;1089.5750657243682;1091.5851976249132;1102.795982743195;1131.3607811586428;907.5190149220923;916.0793402630314;920.6731610278389;932.572428466333;956.273232343424;5585.050541407971;5619.4099619540175;5662.490375866109;5821.679807610622;5890.558208134407;957.5020989085637;981.4896253947907;1002.9749256268651;1005.8340373838381;1014.8985101489792;3951.585083566242;3989.261986532501;4027.838886444568;4033.858814941463;4105.44576482177;9562.235021198287;9680.27397945143;9785.559649815776;9831.410115393099;9932;9824.803503930025;9848.901510984799;9926.950365248127;9962;9992.65025724096;7570.432217583703;7711.498752581064;7760.262775036363;7787.688492460238;7824.37405007598;5539.335279766293;5603.32760068778;5613.831585052455;5634.267545219095;5771.682557459212;9137.040610736043;9202.493862837608;9219.939706933788;9268.026857179899;9268.212201962908;9058.592363343534;9331.0202428744;9371.062893710574;9380.530973451163;9549.331546791658;6157.907631385443;6661.600303981777;6794.388505034571;6832.692528836114;6912;7733.806654833674;7782.066152061789;7783.532988020737;7806.453548251795;7808.492447990862;6957.756478523227;7178.497505174797;7201.531900426456;7252.854942901007;7260.056192694916;7036.964815175891;7054.08296921397;7096.467764917548;7161.820954476179;7182.3894968928225;6166.691665416622;6301.338359472373;6325.778597749057;6335.619862808247;6342.52431067681;4868.318435418973;4889.731064791471;4957.157283261926;4962.851114466572;4997.575206107522;4897.094037603055;4897.216445368724;4914.262860570943;4980.128477516348;4987.10232158215 07:19:10 INFO - PROCESS | 16483 | |4;prototype.html;321.8615995122098;326.98201598912055;332.2955334690455;337.185696542849;338.05850705784394;5505.146702261146;5539.556835453164;5581.386047534768;5617.325920889494;5629;5535.280413546244;5542.1409681499335;5550.195221692852;5550.502273976706;5560.499555040045;4074.9999999999927;4179.477565304337;4290.506591741959;4296.281487405032;4318.747563206666;4269.594388533084;4298.398224248608;4315.611594956454;4321.200577893084;4324.11355672088;4287.764172970486;4299.484061912575;4306.720063195898;4318.179545886287;4320.6327462165755;4027.859024934128;4249.87250382489;4257.510386305584;4273.572642735733;4318.3090705486975;3696.815159242027;3708.369577171887;3713.740038197327;3736.1033351995598;3752.2683076800035;5372.597055220874;5373.785048598052;5375.11310633745;5382.989672693829;5411.702356370398;4607.17070927233;4779.163646361908;4877.292792545097;4894.41267047953;4911.4106307243355;5744.597878148531;5759.3376761672525;5778.971105144489;5800.477956983849;5814.767409303623;4034.8587799427173;4068.6338229559483;4071.801227337234;4082.7142100053006;4091.6931230157857;5941.8811623767715;5973.342932277446;6004.519638428959;6084;6086.969565152191;4175.853845115467;4185.351270553069;4195;4197.719695492904;4198.8110535026;4244.533101358848;4246.851360202378;4248.596383343577;4255.574442555781;4265.658747300208;4708.364370809965;4776.853555146809;4851.878703032382;4895.31465594817;4917.950820491821;5776.797812076557;5798.739056742456;5799.652020878676;5865.149553314745;5889.763149738517;1543.1666899874167;1554.65020370418;1557.9844201558067;1558.0651609034715;1560.9765853512206;1006.4011912911806;1009.5002973528151;1015.2639336480992;1029.2846471702244;1046.2885238038207;5847.56143289255;5939.287285525678;5953.613015154001;5956.64260144384;5964.850878728066;6332.366763323631;6348.904766428507;6362.936370636235;6383.96808015957;6398.712057957403;5741.65550066989;5933.436323549256;5956.821295361059;5962.672053037125;5987.730552125165;3385.3906296866307;3427.451607742799;3437.570303712036;3437.8968630941113;3444.1733983843696;6425.614463132227;6529.477641788741;6559.6064236145985;6559.638530129149;6568.770093046721;6473.546851720334;6484.319146489645;6487.3188315226225;6495.350464953562;6554.70503827329;6341.938869867219;6521.6413097279155;6541.70562324687;6547.639879806561;6551.770688025897;6356.745730170742;6358.618482891041;6365.267994180728;6374.26695929974;6385.904211436739;6159.4456498915315;6250.968745156245;6304.784559874405;6316.305206427198;6337.809865704036;6528.804135875931;6536.934630653633;6543;6549.7380104795275;6562.5406221564035;4349.195398851222;4353.259945809156;4385.122975404868;4392.275274579786;4393.406890069799;6213.937860621336;6271.43557079865;6313.55805093639;6356.55504114726;6370.681465926593;6139.434444216696;6146.78486252979;6175.62946223228;6190.907136393048;6201.379862013762;5875.206847075761;6080.635161890301;6133.969330153321;6152.230971128609;6161.6919154041225;5945.554083443672;6010.128531363015;6022.2171117754415;6034.7284372202475;6063.393660633901;6166.969165154145;6184.515716228163;6184.752609895554;6219.440250377488;6219.533534984804;5847.678377689268;6016.308124565731;6041.9395806041375;6071.453569178795;6084.209052823105 07:19:10 INFO - PROCESS | 16483 | |5;yui.html;777.8133248020473;790.8734602463605;794.9006374203225;803.1807556292582;808.5876203136403;13159.868401315984;13219.140755850874;13396.866031339683;13418.194908305508;13423.798643020351;12815.551455699053;12871.871281287184;12890.548830790924;12893.226406415622;12908.677283067927;676.1615596660155;798.0941631248517;801.5992003998001;802.3781569283823;823.2672921100226;815.6288888555692;817.1175130858659;820.1962077164383;821.3757544266371;822.5311572403732;854.0818619983512;864.8789169516273;865.8051938313891;866.9653213871437;869.0310304011014;850.9702160424387;855.3841234311317;855.5551113421018;855.7047818502668;861.96983105591;626.1609443345939;627.1815281058217;627.2347735762363;629.471244154912;633.9017452294902;12813.743725125538;12880.549180778627;12900.22598644075;12901.548445804352;12907.80638290417;13569.321533923363;13798.310084495735;13826.723465530633;13899.79150312746;13917.164970101827;10272.897271027268;10292.382457052601;10349;10349.275550711453;10364;3631.110377957391;3750.1749615084636;3755.3615885299564;3831.04223944014;3893.1824316893485;51101;51206;51878.48121518774;52675;52759.47240527584;10375.533101010473;10464.372137671764;10497.790044199226;10528.736781580368;10576.629817956335;17147.228374723167;17408.738868916975;17414.39049633282;17417.65164696699;17428.39000634997;8098.068722096917;8207.507549547046;8374.41379103469;8483.060695450062;8575.356848236283;4608.516105808909;4675.579197872208;4845.200541910545;4854.296127061556;4856.490068542752;3292.5555050068415;3377.071305391037;3382.1037425082372;3394.13449570358;3401.727861771052;591.3672370563542;596.7821745063021;609.1046162141645;619.6406084470996;620.3486339343671;707.9079719636414;716.6954044531053;721.0950257426896;725.4341613541446;726.440640706653;8051.718189863327;8259.761035844671;8360.331173506227;8434.831303373898;8747.562621869009;751.6241879060469;761.9847603048019;762.2948772385632;775.8409526047146;792.1959211400433;4388.407564978751;4460.1525710114975;4490.595846373842;4498.50516443191;4523.2988886722615;60339.39660603338;60378.396216037276;62537.68731156315;63495.92032637378;64418;56149.15776263359;56215;56359.43640563624;56648.43351566514;57551.13673294904;49450;50099;50136.749316252455;50169.49830501648;50876;8321.6671333146;8443.95778021106;8708.56457177126;8823.735287941372;8887.244584210415;33504.329913402085;34002.829985849916;34587.654123458444;35008;35011.64988350084;43721.78139109284;44107.338389923534;44171.77914110409;44199.33700994552;44455.33317000183;10796.730081747704;11030.613928512463;11110.277831940897;11123.165762568002;11169;11593.710157246136;11707.473163707484;11828.645140645795;11935.34355610415;12414;10406.739831504274;11263.718407039889;11373.31760094397;11404.600838970597;11405.856737645427;11390.145739069438;11743.295402275891;11828.290302581872;11911.76176476483;12021.639350819489;10900.34597924127;10901.509432075418;11062.834057489305;11141.665750027512;11316.434178290889;9923.900760992297;10124.848127278245;10257.74355641115;10300;10421.583136674448;9592.856107158259;9803.41179529202;9890.406575605486;9905.61321415017;9975.20198384142 07:19:10 INFO - PROCESS | 16483 | __end_tp_report 07:19:10 INFO - PROCESS | 16483 | __start_cc_report 07:19:10 INFO - PROCESS | 16483 | _x_x_mozilla_cycle_collect,348 07:19:10 INFO - PROCESS | 16483 | __end_cc_report 07:19:10 INFO - PROCESS | 16483 | __startTimestamp1461421150031__endTimestamp 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | ------- Summary: start ------- 07:19:10 INFO - PROCESS | 16483 | Number of tests: 6 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#0] dojo.html Cycles:165 Average:5281.79 Median:5531.56 stddev:695.74 (12.6%) stddev-sans-first:676.00 07:19:10 INFO - PROCESS | 16483 | Values: 3075.6 3155.4 3161.7 3173.6 3181.2 5306.6 5330.8 5365.7 5369.5 5405.4 5274.0 5326.1 5337.7 5351.2 5413.5 4794.4 4862.5 4908.0 4951.4 4989.0 828.3 4737.6 4808.0 4854.6 4982.0 4885.9 4894.8 4899.2 4923.6 4936.9 4924.0 4926.9 4929.2 4934.2 4952.7 4834.2 4851.9 4877.7 4893.1 4912.2 5205.8 5228.4 5256.4 5259.7 5266.7 5565.9 5644.1 5665.3 5666.8 5676.9 5714.6 5721.5 5763.9 5775.0 5814.2 5317.3 5330.9 5336.4 5344.3 5359.0 5616.3 5806.9 5835.1 5885.6 5897.9 5581.1 5610.1 5612.0 5617.4 5620.0 5655.8 5659.0 5666.7 5681.1 5682.3 5674.6 5757.8 5788.5 5790.4 5853.8 5602.4 5618.2 5654.7 5661.0 5675.9 4201.9 4266.8 4273.5 4280.1 4332.8 3738.4 3809.7 3831.2 3831.8 3870.6 5288.7 5299.2 5451.8 5464.6 5498.3 5722.3 5723.2 5769.8 5788.0 5807.7 5293.5 5453.7 5455.6 5485.3 5531.6 4887.3 4889.7 4897.9 4924.3 4961.5 5867.4 5883.6 5888.1 5904.4 5911.7 5554.3 5699.3 5716.1 5776.0 5793.0 5880.4 5883.2 5883.8 5893.5 5895.1 5649.7 5650.5 5653.1 5654.5 5659.9 5519.7 5789.5 5833.1 5859.5 5886.1 5491.2 5525.9 5534.8 5537.4 5547.1 5443.5 5531.3 5535.2 5535.3 5542.9 5587.9 5613.5 5618.5 5632.1 5658.3 5538.4 5576.8 5649.2 5666.1 5669.0 5404.1 5489.8 5530.0 5531.2 5552.3 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#1] ext.html Cycles:180 Average:53032.20 Median:37671.50 stddev:99413.73 (263.9%) stddev-sans-first:99614.71 07:19:10 INFO - PROCESS | 16483 | Values: 613.4 656.8 660.9 668.5 686.3 35819.0 37358.4 37422.6 37551.0 37568.6 41205.8 41901.0 42056.2 42073.8 42089.8 8529.3 8664.0 8671.5 8672.4 8696.3 8595.0 8682.9 8715.3 8750.1 8763.1 8728.8 8741.8 8764.4 8820.1 8822.6 8710.0 8739.7 8764.4 8766.6 8781.6 8541.1 8704.4 8705.7 8728.0 8741.5 29377.7 37222.6 37530.4 37553.6 37798.2 3327.3 3410.4 3439.6 3514.4 3529.6 29595.3 29948.3 30329.4 30515.7 30625.8 3572.5 3607.5 3628.9 3653.5 3731.9 223608.0 229002.0 229597.0 229782.9 255721.0 58736.7 59093.4 59240.0 59554.0 59663.7 59591.7 60743.0 61285.0 61364.4 61420.0 17054.6 17082.1 17152.7 17216.1 17262.1 12671.9 12774.2 12828.7 12841.3 12940.1 20023.4 20071.9 20332.1 20809.2 21083.5 7586.7 7746.3 7909.5 8037.0 8135.9 1045.6 1063.9 1097.4 1142.8 1148.8 30976.7 31006.8 31066.7 31310.2 31537.2 1124.3 1128.6 1165.2 1174.0 1212.5 16446.0 16651.3 16685.6 16709.6 17059.5 453273.0 461518.0 461713.0 463947.0 466266.0 56407.2 56932.0 57211.7 57372.4 57459.7 1418.7 1427.7 1429.9 1437.5 1502.1 30020.2 30370.2 30459.0 30629.8 30669.8 49151.3 49181.3 49331.0 49464.8 49595.8 393348.0 394491.0 395037.0 395299.0 397235.0 28615.0 28747.0 28937.6 28979.1 29168.9 46298.5 46361.0 46716.0 47043.3 47411.3 39680.7 40757.2 41059.4 41399.2 41688.8 39297.4 39425.2 40609.4 40673.4 41345.6 36846.6 37592.0 37751.0 40087.2 40250.0 31743.7 32786.8 33731.3 34787.7 35000.3 25572.4 26525.9 27231.0 27629.3 27687.2 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#2] jquery.html Cycles:180 Average:30015.69 Median:25787.05 stddev:80815.88 (313.4%) stddev-sans-first:81011.97 07:19:10 INFO - PROCESS | 16483 | Values: 386.3 386.9 397.3 397.4 408.3 14296.8 17658.3 17677.1 18310.5 18318.7 17784.3 17821.2 18010.4 18703.5 18868.2 5191.1 5346.1 6961.9 7328.9 7406.7 6741.9 7173.1 7182.9 7275.1 7316.0 6777.6 7090.0 7091.3 7096.0 7113.4 7299.5 7321.7 7395.1 7400.8 7410.6 6978.7 7057.8 7221.6 7241.2 7250.9 24734.0 25584.2 25989.9 27327.3 27406.3 2311.1 2455.9 2513.3 2662.7 2774.2 15944.5 16091.1 16431.0 16556.3 16590.8 1971.3 2081.6 2093.5 2136.3 2179.3 91219.5 91857.5 92160.0 92296.5 93490.5 17714.6 17765.3 18114.5 18131.8 18274.7 13478.3 14220.3 32205.0 32349.5 32354.5 7855.1 8009.4 8207.6 8283.0 8289.0 7830.3 7843.8 7981.0 8003.6 8131.0 4275.4 4321.9 4325.2 4344.6 4354.5 1826.3 1832.9 1868.6 1880.4 1896.3 966.2 1006.9 1047.1 1097.2 1116.4 18603.9 18727.0 19161.0 19213.8 19242.9 1025.7 1031.0 1034.7 1086.8 1121.1 10375.3 10604.2 10736.2 10793.7 10811.6 459946.0 463262.0 478744.0 518370.0 520296.0 92958.0 98758.5 99031.0 100335.0 100401.5 1041.6 1067.9 1097.0 1128.0 1129.0 16578.5 16851.7 17029.1 17132.1 17193.7 33567.3 38819.2 40474.0 40734.6 41690.8 51303.5 55162.7 55197.4 55233.0 55316.0 7920.8 8057.3 8356.8 8414.4 8594.1 7667.9 11037.9 13372.9 13515.8 13794.8 11685.5 11823.6 11973.9 11994.0 12014.9 11902.2 12006.5 12051.7 12201.6 12276.3 11647.1 11926.9 12081.0 12169.9 12312.8 8310.0 8351.2 8367.8 8406.8 8671.1 8512.9 10326.2 11384.4 11552.5 11565.9 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#3] mootools.html Cycles:180 Average:5321.56 Median:4983.62 stddev:2903.99 (58.3%) stddev-sans-first:2897.89 07:19:10 INFO - PROCESS | 16483 | Values: 1495.1 1500.9 1671.6 1741.9 1750.0 7095.7 7725.5 7735.4 8095.1 8102.4 7805.1 7846.2 7874.0 7880.3 7909.4 2232.3 2252.2 2256.9 2258.5 2260.6 2208.4 2236.9 2264.6 2276.9 2278.6 2164.4 2187.0 2193.2 2209.8 2214.8 2240.2 2255.1 2270.0 2270.1 2276.2 2219.4 2220.9 2225.9 2259.9 2264.2 8003.2 8075.6 8081.1 8084.0 8101.0 4610.4 4741.5 4762.0 4781.0 4792.5 3008.6 3110.4 3187.1 3256.4 3257.1 1033.7 1042.6 1042.9 1084.7 1925.6 10716.5 10743.8 10754.1 10859.3 10887.2 4184.0 4189.5 4229.7 4276.3 4277.8 8700.9 8783.6 8794.3 8808.3 8823.0 4907.5 4918.6 4920.9 4943.6 4949.0 3917.6 4449.9 4489.0 4518.2 4526.4 3519.6 3523.3 3581.1 3628.0 3644.1 1081.7 1089.6 1091.6 1102.8 1131.4 907.5 916.1 920.7 932.6 956.3 5585.1 5619.4 5662.5 5821.7 5890.6 957.5 981.5 1003.0 1005.8 1014.9 3951.6 3989.3 4027.8 4033.9 4105.4 9562.2 9680.3 9785.6 9831.4 9932.0 9824.8 9848.9 9927.0 9962.0 9992.7 7570.4 7711.5 7760.3 7787.7 7824.4 5539.3 5603.3 5613.8 5634.3 5771.7 9137.0 9202.5 9219.9 9268.0 9268.2 9058.6 9331.0 9371.1 9380.5 9549.3 6157.9 6661.6 6794.4 6832.7 6912.0 7733.8 7782.1 7783.5 7806.5 7808.5 6957.8 7178.5 7201.5 7252.9 7260.1 7037.0 7054.1 7096.5 7161.8 7182.4 6166.7 6301.3 6325.8 6335.6 6342.5 4868.3 4889.7 4957.2 4962.9 4997.6 4897.1 4897.2 4914.3 4980.1 4987.1 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#4] prototype.html Cycles:180 Average:5041.51 Median:5743.13 stddev:1544.92 (26.9%) stddev-sans-first:1508.10 07:19:10 INFO - PROCESS | 16483 | Values: 321.9 327.0 332.3 337.2 338.1 5505.1 5539.6 5581.4 5617.3 5629.0 5535.3 5542.1 5550.2 5550.5 5560.5 4075.0 4179.5 4290.5 4296.3 4318.7 4269.6 4298.4 4315.6 4321.2 4324.1 4287.8 4299.5 4306.7 4318.2 4320.6 4027.9 4249.9 4257.5 4273.6 4318.3 3696.8 3708.4 3713.7 3736.1 3752.3 5372.6 5373.8 5375.1 5383.0 5411.7 4607.2 4779.2 4877.3 4894.4 4911.4 5744.6 5759.3 5779.0 5800.5 5814.8 4034.9 4068.6 4071.8 4082.7 4091.7 5941.9 5973.3 6004.5 6084.0 6087.0 4175.9 4185.4 4195.0 4197.7 4198.8 4244.5 4246.9 4248.6 4255.6 4265.7 4708.4 4776.9 4851.9 4895.3 4918.0 5776.8 5798.7 5799.7 5865.1 5889.8 1543.2 1554.7 1558.0 1558.1 1561.0 1006.4 1009.5 1015.3 1029.3 1046.3 5847.6 5939.3 5953.6 5956.6 5964.9 6332.4 6348.9 6362.9 6384.0 6398.7 5741.7 5933.4 5956.8 5962.7 5987.7 3385.4 3427.5 3437.6 3437.9 3444.2 6425.6 6529.5 6559.6 6559.6 6568.8 6473.5 6484.3 6487.3 6495.4 6554.7 6341.9 6521.6 6541.7 6547.6 6551.8 6356.7 6358.6 6365.3 6374.3 6385.9 6159.4 6251.0 6304.8 6316.3 6337.8 6528.8 6536.9 6543.0 6549.7 6562.5 4349.2 4353.3 4385.1 4392.3 4393.4 6213.9 6271.4 6313.6 6356.6 6370.7 6139.4 6146.8 6175.6 6190.9 6201.4 5875.2 6080.6 6134.0 6152.2 6161.7 5945.6 6010.1 6022.2 6034.7 6063.4 6167.0 6184.5 6184.8 6219.4 6219.5 5847.7 6016.3 6041.9 6071.5 6084.2 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - PROCESS | 16483 | [#5] yui.html Cycles:180 Average:14335.41 Median:4760.39 stddev:17028.32 (357.7%) stddev-sans-first:17045.65 07:19:10 INFO - PROCESS | 16483 | Values: 777.8 790.9 794.9 803.2 808.6 13159.9 13219.1 13396.9 13418.2 13423.8 12815.6 12871.9 12890.5 12893.2 12908.7 676.2 798.1 801.6 802.4 823.3 815.6 817.1 820.2 821.4 822.5 854.1 864.9 865.8 867.0 869.0 851.0 855.4 855.6 855.7 862.0 626.2 627.2 627.2 629.5 633.9 12813.7 12880.5 12900.2 12901.5 12907.8 13569.3 13798.3 13826.7 13899.8 13917.2 10272.9 10292.4 10349.0 10349.3 10364.0 3631.1 3750.2 3755.4 3831.0 3893.2 51101.0 51206.0 51878.5 52675.0 52759.5 10375.5 10464.4 10497.8 10528.7 10576.6 17147.2 17408.7 17414.4 17417.7 17428.4 8098.1 8207.5 8374.4 8483.1 8575.4 4608.5 4675.6 4845.2 4854.3 4856.5 3292.6 3377.1 3382.1 3394.1 3401.7 591.4 596.8 609.1 619.6 620.3 707.9 716.7 721.1 725.4 726.4 8051.7 8259.8 8360.3 8434.8 8747.6 751.6 762.0 762.3 775.8 792.2 4388.4 4460.2 4490.6 4498.5 4523.3 60339.4 60378.4 62537.7 63495.9 64418.0 56149.2 56215.0 56359.4 56648.4 57551.1 49450.0 50099.0 50136.7 50169.5 50876.0 8321.7 8444.0 8708.6 8823.7 8887.2 33504.3 34002.8 34587.7 35008.0 35011.6 43721.8 44107.3 44171.8 44199.3 44455.3 10796.7 11030.6 11110.3 11123.2 11169.0 11593.7 11707.5 11828.6 11935.3 12414.0 10406.7 11263.7 11373.3 11404.6 11405.9 11390.1 11743.3 11828.3 11911.8 12021.6 10900.3 10901.5 11062.8 11141.7 11316.4 9923.9 10124.8 10257.7 10300.0 10421.6 9592.9 9803.4 9890.4 9905.6 9975.2 07:19:10 INFO - PROCESS | 16483 | -------- Summary: end -------- 07:19:10 INFO - PROCESS | 16483 | 07:19:10 INFO - TEST-INFO | 16483: exit 0 07:19:10 INFO - TEST-OK | dromaeo_css | took 1109411ms 07:19:10 INFO - TEST-START | kraken 07:19:10 INFO - operating with platform_type : linux_ 07:19:10 INFO - Initialising browser for kraken test... 07:19:10 INFO - TEST-INFO | started process 16715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDv4f5/profile http://localhost:45833/getInfo.html) 07:19:14 INFO - PROCESS | 16715 | 07:19:14 INFO - PROCESS | 16715 | (process:16782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:19:15 INFO - PROCESS | 16715 | __metrics Screen width/height:1600/1200 07:19:15 INFO - PROCESS | 16715 | colorDepth:24 07:19:15 INFO - PROCESS | 16715 | Browser inner width/height: 1024/697 07:19:15 INFO - PROCESS | 16715 | __metrics 07:19:15 ERROR - PROCESS | 16715 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:19:16 INFO - TEST-INFO | 16715: exit 0 07:19:16 INFO - Browser initialized. 07:19:16 INFO - Running cycle 1/1 for kraken test... 07:19:16 INFO - TEST-INFO | started process 16833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDv4f5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:18 INFO - PROCESS | 16833 | 07:19:18 INFO - PROCESS | 16833 | (process:16892): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:19:28 INFO - PROCESS | 16833 | RSS: Main: 164593664 07:19:28 INFO - PROCESS | 16833 | 07:19:30 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45833/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:31 INFO - PROCESS | 16833 | RSS: Main: 169598976 07:19:31 INFO - PROCESS | 16833 | 07:19:34 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45833/tests/kraken/driver.html?testName=audio-dft) 07:19:35 INFO - PROCESS | 16833 | RSS: Main: 173056000 07:19:35 INFO - PROCESS | 16833 | 07:19:37 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45833/tests/kraken/driver.html?testName=audio-fft) 07:19:38 INFO - PROCESS | 16833 | RSS: Main: 164474880 07:19:38 INFO - PROCESS | 16833 | 07:19:40 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45833/tests/kraken/driver.html?testName=audio-oscillator) 07:19:41 INFO - PROCESS | 16833 | RSS: Main: 164945920 07:19:41 INFO - PROCESS | 16833 | 07:19:43 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:44 INFO - PROCESS | 16833 | RSS: Main: 165396480 07:19:44 INFO - PROCESS | 16833 | 07:19:47 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45833/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:47 INFO - PROCESS | 16833 | RSS: Main: 165785600 07:19:47 INFO - PROCESS | 16833 | 07:19:51 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45833/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:51 INFO - PROCESS | 16833 | RSS: Main: 165580800 07:19:51 INFO - PROCESS | 16833 | 07:19:54 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45833/tests/kraken/driver.html?testName=json-parse-financial) 07:19:55 INFO - PROCESS | 16833 | RSS: Main: 167813120 07:19:55 INFO - PROCESS | 16833 | 07:19:56 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:57 INFO - PROCESS | 16833 | RSS: Main: 167550976 07:19:57 INFO - PROCESS | 16833 | 07:19:59 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:59 INFO - PROCESS | 16833 | RSS: Main: 167796736 07:19:59 INFO - PROCESS | 16833 | 07:20:01 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:02 INFO - PROCESS | 16833 | RSS: Main: 168349696 07:20:02 INFO - PROCESS | 16833 | 07:20:05 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:05 INFO - PROCESS | 16833 | RSS: Main: 168632320 07:20:05 INFO - PROCESS | 16833 | 07:20:08 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:09 INFO - PROCESS | 16833 | RSS: Main: 168611840 07:20:09 INFO - PROCESS | 16833 | 07:20:10 INFO - PROCESS | 16833 | Cycle 1(1): loaded http://localhost:45833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45833/tests/kraken/driver.html?testName=ai-astar) 07:20:11 INFO - PROCESS | 16833 | RSS: Main: 170135552 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | __start_tp_report 07:20:11 INFO - PROCESS | 16833 | _x_x_mozilla_page_load 07:20:11 INFO - PROCESS | 16833 | _x_x_mozilla_page_load_details 07:20:11 INFO - PROCESS | 16833 | |i|pagename|runs| 07:20:11 INFO - PROCESS | 16833 | |0;ai-astar;111;105;110;112;112;123;110;110;111;112 07:20:11 INFO - PROCESS | 16833 | |1;audio-beat-detection;159;126;152;188;130;165;153;127;196;128 07:20:11 INFO - PROCESS | 16833 | |2;audio-dft;164;161;162;161;161;165;173;163;164;162 07:20:11 INFO - PROCESS | 16833 | |3;audio-fft;77;75;74;165;75;76;75;76;169;72 07:20:11 INFO - PROCESS | 16833 | |4;audio-oscillator;93;92;159;93;92;92;141;92;92;143 07:20:11 INFO - PROCESS | 16833 | |5;imaging-gaussian-blur;117;119;118;118;118;117;117;121;117;118 07:20:11 INFO - PROCESS | 16833 | |6;imaging-darkroom;147;147;147;146;146;146;146;146;146;147 07:20:11 INFO - PROCESS | 16833 | |7;imaging-desaturate;95;94;96;95;95;95;95;95;95;95 07:20:11 INFO - PROCESS | 16833 | |8;json-parse-financial;59;58;58;59;60;60;59;79;58;59 07:20:11 INFO - PROCESS | 16833 | |9;json-stringify-tinderbox;61;62;61;61;61;65;61;61;61;62 07:20:11 INFO - PROCESS | 16833 | |10;stanford-crypto-aes;77;79;77;79;78;78;78;78;79;80 07:20:11 INFO - PROCESS | 16833 | |11;stanford-crypto-ccm;127;129;124;132;123;126;123;132;208;135 07:20:11 INFO - PROCESS | 16833 | |12;stanford-crypto-pbkdf2;169;171;174;169;171;172;168;170;176;173 07:20:11 INFO - PROCESS | 16833 | |13;stanford-crypto-sha256-iterative;68;75;71;67;69;67;66;68;67;70 07:20:11 INFO - PROCESS | 16833 | __end_tp_report 07:20:11 INFO - PROCESS | 16833 | __start_cc_report 07:20:11 INFO - PROCESS | 16833 | _x_x_mozilla_cycle_collect,868 07:20:11 INFO - PROCESS | 16833 | __end_cc_report 07:20:11 INFO - PROCESS | 16833 | __startTimestamp1461421211167__endTimestamp 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | ------- Summary: start ------- 07:20:11 INFO - PROCESS | 16833 | Number of tests: 14 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:4.50 (4.0%) stddev-sans-first:4.77 07:20:11 INFO - PROCESS | 16833 | Values: 111.0 105.0 110.0 112.0 112.0 123.0 110.0 110.0 111.0 112.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:156.00 stddev:25.41 (16.3%) stddev-sans-first:26.84 07:20:11 INFO - PROCESS | 16833 | Values: 159.0 126.0 152.0 188.0 130.0 165.0 153.0 127.0 196.0 128.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.60 (2.2%) stddev-sans-first:3.81 07:20:11 INFO - PROCESS | 16833 | Values: 164.0 161.0 162.0 161.0 161.0 165.0 173.0 163.0 164.0 162.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.82 (51.8%) stddev-sans-first:40.72 07:20:11 INFO - PROCESS | 16833 | Values: 77.0 75.0 74.0 165.0 75.0 76.0 75.0 76.0 169.0 72.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:27.16 (29.5%) stddev-sans-first:28.19 07:20:11 INFO - PROCESS | 16833 | Values: 93.0 92.0 159.0 93.0 92.0 92.0 141.0 92.0 92.0 143.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 07:20:11 INFO - PROCESS | 16833 | Values: 117.0 119.0 118.0 118.0 118.0 117.0 117.0 121.0 117.0 118.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:20:11 INFO - PROCESS | 16833 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:20:11 INFO - PROCESS | 16833 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:59.00 stddev:6.40 (10.9%) stddev-sans-first:6.75 07:20:11 INFO - PROCESS | 16833 | Values: 59.0 58.0 58.0 59.0 60.0 60.0 59.0 79.0 58.0 59.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 07:20:11 INFO - PROCESS | 16833 | Values: 61.0 62.0 61.0 61.0 61.0 65.0 61.0 61.0 61.0 62.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:0.95 (1.2%) stddev-sans-first:0.88 07:20:11 INFO - PROCESS | 16833 | Values: 77.0 79.0 77.0 79.0 78.0 78.0 78.0 78.0 79.0 80.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:130.50 stddev:25.67 (19.7%) stddev-sans-first:27.02 07:20:11 INFO - PROCESS | 16833 | Values: 127.0 129.0 124.0 132.0 123.0 126.0 123.0 132.0 208.0 135.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.50 (1.5%) stddev-sans-first:2.51 07:20:11 INFO - PROCESS | 16833 | Values: 169.0 171.0 174.0 169.0 171.0 172.0 168.0 170.0 176.0 173.0 07:20:11 INFO - PROCESS | 16833 | 07:20:11 INFO - PROCESS | 16833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.66 (3.9%) stddev-sans-first:2.80 07:20:11 INFO - PROCESS | 16833 | Values: 68.0 75.0 71.0 67.0 69.0 67.0 66.0 68.0 67.0 70.0 07:20:11 INFO - PROCESS | 16833 | -------- Summary: end -------- 07:20:11 INFO - PROCESS | 16833 | 07:20:12 INFO - TEST-INFO | 16833: exit 0 07:20:12 INFO - TEST-OK | kraken | took 61331ms 07:20:12 INFO - SUITE-END | took 1170s 07:20:12 INFO - Completed test suite (00:19:30) 07:20:12 INFO - javascript benchmark 07:20:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.6309242890848, 3155.384699983504, 3161.715445609895, 3173.5715678383413, 3181.2365032392217, 5306.575473962079, 5330.760115794789, 5365.704886231256, 5369.48989845965, 5405.35135783706, 5274.0, 5326.067938110825, 5337.6797392156495, 5351.224072509483, 5413.485718856702, 4794.448638406576, 4862.5380588844, 4907.950920490785, 4951.356323677916, 4989.027139707759, 828.2914833662487, 4737.620990320784, 4808.0, 4854.587360074398, 4982.0, 4885.8626384253175, 4894.779734911937, 4899.191633380506, 4923.581495572863, 4936.851894443173, 4924.0, 4926.8768280793265, 4929.2113261878285, 4934.235193545006, 4952.678075925053, 4834.202356611155, 4851.878703032452, 4877.731724755137, 4893.119238537062, 4912.189488734391, 5205.765740541685, 5228.398734145584, 5256.369235691704, 5259.658122222043, 5266.710330931797, 5565.888682226373, 5644.096944488862, 5665.348484924204, 5666.773329066832, 5676.8864622707315, 5714.628549144292, 5721.513671337942, 5763.855903602402, 5775.0, 5814.244148260699, 5317.282166907496, 5330.866728331784, 5336.43967383423, 5344.331958505187, 5358.973205133989, 5616.269884914935, 5806.88386232273, 5835.095560188092, 5885.6174348668055, 5897.941020589825, 5581.107022876401, 5610.102383618683, 5612.045952188138, 5617.354004289477, 5619.971900140473, 5655.773769049274, 5658.981383351036, 5666.660000399989, 5681.0626246668835, 5682.289713785777, 5674.631148975386, 5757.827265182052, 5788.5369170466265, 5790.392008839095, 5853.824385268449, 5602.439756024365, 5618.185363122325, 5654.660720356792, 5660.97169514158, 5675.943240567624, 4201.936970945439, 4266.765327906995, 4273.529911709709, 4280.143971205771, 4332.848350307724, 3738.36447803874, 3809.6761775249415, 3831.233753249361, 3831.750936189139, 3870.59358767331, 5288.7091209983055, 5299.205119232146, 5451.754671039813, 5464.617476776667, 5498.285222920995, 5722.284714410699, 5723.198752174699, 5769.826905192851, 5787.971060144757, 5807.738651760681, 5293.470652934753, 5453.727313634303, 5455.645383050089, 5485.341758988867, 5531.557475401958, 4887.340209071801, 4889.731064791471, 4897.877553061131, 4924.285978533093, 4961.5286547777905, 5867.3839246879315, 5883.646981181143, 5888.087346461305, 5904.350521442638, 5911.733971971272, 5554.333479982266, 5699.344575373885, 5716.114002329646, 5775.971120144372, 5793.044147715748, 5880.441358070976, 5883.2057672215415, 5883.823485295448, 5893.528517718658, 5895.115732640138, 5649.745761440663, 5650.519705825051, 5653.067243904709, 5654.491095801233, 5659.9151012735665, 5519.724013799214, 5789.45000224978, 5833.095870140135, 5859.5019423349495, 5886.146508756292, 5491.176323551499, 5525.889482210414, 5534.7786088556, 5537.418571049981, 5547.112462006221, 5443.482869127427, 5531.3362396512675, 5535.225068490334, 5535.335759708861, 5542.861428464159, 5587.888242235052, 5613.494785469164, 5618.494335509824, 5632.127020311858, 5658.292713410824, 5538.363088244903, 5576.832695019156, 5649.152627105967, 5666.121751128581, 5668.971655141863, 5404.081306177881, 5489.780408783604, 5529.972350138223, 5531.225628412106, 5552.333719953632], "value": 5236.700956477072, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.3559762249637, 656.8160914943816, 660.9173853268338, 668.5119862500375, 686.2794066230457, 35819.0, 37358.43962340567, 37422.62577374226, 37551.0, 37568.62431375685, 41205.79397103018, 41901.0, 42056.15887682245, 42073.789631051804, 42089.78955105228, 8529.275011624019, 8664.0, 8671.482490564158, 8672.392932494728, 8696.34777391695, 8594.957025214866, 8682.913170868305, 8715.346349023817, 8750.12498750123, 8763.07987661296, 8728.825423491526, 8741.825163496726, 8764.386492945496, 8820.073892241318, 8822.558872056372, 8709.95645021774, 8739.694110706127, 8764.386492945496, 8766.605502752327, 8781.64873405063, 8541.145885411472, 8704.434211776213, 8705.6517739291, 8728.0, 8741.475511469333, 29377.70622293771, 37222.62777372219, 37530.43704344437, 37553.62446375529, 37798.24403511942, 3327.251368442081, 3410.420228561126, 3439.5528581284275, 3514.3674138655033, 3529.6117427083, 29595.260118496994, 29948.251293717614, 30329.393412131856, 30515.694843051508, 30625.846870765727, 3572.499850020973, 3607.5288427427295, 3628.909277268063, 3653.488511608377, 3731.9440208396895, 223608.0, 229002.0, 229597.0, 229782.85108574518, 255721.0, 58736.706316468146, 59093.40906590965, 59239.99999999914, 59554.0, 59663.70168149218, 59591.70204149038, 60743.0, 61285.0, 61364.38635613676, 61420.0, 17054.573635659206, 17082.145892705314, 17152.656946861243, 17216.05311707868, 17262.136893155293, 12671.873281267253, 12774.23354598727, 12828.679283017998, 12841.293728844816, 12940.09419340637, 20023.399298021082, 20071.899640501702, 20332.08505617251, 20809.1676332948, 21083.472913177295, 7586.696532138652, 7746.30283274508, 7909.52542847431, 8037.0, 8135.877961830577, 1045.5660900726266, 1063.9308444951052, 1097.4183682648209, 1142.782871254459, 1148.8104462763717, 30976.69023309783, 31006.84496577548, 31066.68933310638, 31310.217244569067, 31537.211569710482, 1124.2860783402598, 1128.5824245029391, 1165.2367699156896, 1173.9706507337214, 1212.4725744301256, 16446.0, 16651.25069371881, 16685.582860428585, 16709.582260443585, 17059.48821535356, 453273.0, 461518.0, 461713.0, 463947.0, 466266.0, 56407.15389269164, 56932.0, 57211.71394143086, 57372.42627573671, 57459.71270143623, 1418.7304412161864, 1427.745318949536, 1429.942802287897, 1437.4609521429254, 1502.1362716437873, 30020.24949376283, 30370.240743980692, 30459.0, 30629.80199653035, 30669.8466507666, 49151.26273105835, 49181.262281065094, 49331.0, 49464.752676236385, 49595.75202123966, 393348.0, 394491.0, 395037.0, 395299.0, 397235.0, 28615.0, 28747.0, 28937.56593651055, 28979.130626081253, 29168.854155729085, 46298.53701462942, 46361.0, 46716.0, 47043.29435058546, 47411.28883066826, 39680.66380440958, 40757.1848563033, 41059.384109238985, 41399.1720165601, 41688.79155604324, 39297.41053884251, 39425.2114957705, 40609.39085913655, 40673.38989915094, 41345.586544134174, 36846.63153368432, 37592.0, 37751.0, 40087.198256034135, 40250.0, 31743.682563174072, 32786.836065819516, 33731.32537349288, 34787.65212347844, 35000.29999400049, 25572.360690982874, 26525.86737066302, 27231.0, 27629.30926726848, 27687.169384918485], "value": 19431.07598569184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.28537206168585, 386.8510623409986, 397.3483487081186, 397.3542992636963, 408.25085967250095, 14296.770843215883, 17658.293668253253, 17677.143899890518, 18310.542236444096, 18318.725219121723, 17784.288628454848, 17821.198046087924, 18010.369637062704, 18703.532411689714, 18868.245270189174, 5191.091558977183, 5346.091164502044, 6961.895571566431, 7328.853422931538, 7406.740764073258, 6741.865162696743, 7173.139223293212, 7182.8563428731395, 7275.054242948409, 7315.963420182891, 6777.559458635173, 7089.971954066657, 7091.326323999212, 7096.0, 7113.359797618214, 7299.5255308404785, 7321.707131714725, 7395.075615548057, 7400.777976660709, 7410.5924174170395, 6978.651067446658, 7057.823554411129, 7221.602811845346, 7241.203467618558, 7250.854982900312, 24734.0, 25584.23247302584, 25989.870050649813, 27327.273452138907, 27406.314842129108, 2311.1448763957274, 2455.9386015349583, 2513.3465299022205, 2662.720414356484, 2774.18161642316, 15944.521664350088, 16091.074427803354, 16431.0, 16556.254968526446, 16590.75113873293, 1971.3297478857257, 2081.6253074446595, 2093.5184907471216, 2136.316378758798, 2179.2917301876955, 91219.54390228073, 91857.54071229669, 92160.0, 92296.53851730765, 93490.53254733683, 17714.645707085787, 17765.289388424575, 18114.456566303033, 18131.818681813278, 18274.725879111826, 13478.326083695776, 14220.288985550887, 32205.0, 32349.51475727866, 32354.514682279783, 7855.096663883726, 8009.359251259885, 8207.630656620466, 8283.0, 8289.0, 7830.295273425305, 7843.803904902309, 7981.042274927046, 8003.639836207385, 8131.0, 4275.40144379787, 4321.913561728811, 4325.1782161389865, 4344.630706389992, 4354.4992325882295, 1826.2603645523584, 1832.9266829326943, 1868.6169335286233, 1880.4358692392227, 1896.345760712552, 966.2028826218258, 1006.8540061691014, 1047.0681093826502, 1097.237419993113, 1116.4194618798178, 18603.90698046501, 18727.0, 19161.0, 19213.807861921483, 19242.903785480983, 1025.6974192613197, 1030.9639162629271, 1034.6740776655329, 1086.782643471293, 1121.1199208621192, 10375.27373083877, 10604.151667866552, 10736.248462607542, 10793.67618971432, 10811.6215932442, 459946.0, 463262.0, 478744.0, 518370.0, 520296.0, 92958.0, 98758.50620746994, 99031.0, 100334.99330013359, 100401.49799251102, 1041.5677493840124, 1067.8771941226858, 1096.9890301096887, 1128.0411650097515, 1129.0290350298737, 16578.50264492067, 16851.7472237919, 17029.063401513034, 17132.14339283056, 17193.742093868354, 33567.32865342631, 38819.223615526964, 40474.0, 40734.59265407308, 41690.79154604208, 51303.48696512987, 55162.72418637881, 55197.44802551923, 55233.0, 55316.0, 7920.84158316842, 8057.315128213933, 8356.832863342577, 8414.410991230556, 8594.140585941606, 7667.858364778476, 11037.944810275898, 13372.93313533426, 13515.797263040866, 13794.793078104038, 11685.532578696757, 11823.586174483851, 11973.880261197277, 11993.980511656608, 12014.879851201726, 11902.166848320534, 12006.459709312927, 12051.698707532381, 12201.572944946884, 12276.324802135969, 11647.12646551529, 11926.880731192925, 12081.0, 12169.939150304192, 12312.81530777057, 8309.95845020771, 8351.1648835116, 8367.832643346977, 8406.789830254293, 8671.132886711279, 8512.914335987723, 10326.225533084898, 11384.37385943781, 11552.537898483966, 11565.884341156481], "value": 9892.370729416718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.0655840099942, 1500.8799296056313, 1671.5653929978203, 1741.8519425848801, 1749.9825001749978, 7095.716171353152, 7725.497842640224, 7735.38116950644, 8095.109537950828, 8102.432829701923, 7805.063392392921, 7846.176151504095, 7874.0157480314965, 7880.251376119274, 7909.446338756289, 2232.2856685860493, 2252.222983070838, 2256.8533045352083, 2258.4692597239637, 2260.6156953317977, 2208.392692009702, 2236.910523579055, 2264.61501544737, 2276.9203077892275, 2278.5898538263104, 2164.3831508020216, 2187.0158428707064, 2193.2214064007285, 2209.845310828243, 2214.7895949884814, 2240.1823334482797, 2255.0979608156704, 2269.954600907981, 2270.1260014894383, 2276.226083131735, 2219.4340443187048, 2220.922267720622, 2225.922092726747, 2259.898304576298, 2264.2188444986455, 8003.159668234868, 8075.555844428554, 8081.070676872177, 8083.989501312336, 8101.02787665478, 4610.354550362952, 4741.454732705714, 4761.976190119062, 4780.976095119537, 4792.520747925215, 3008.638963324393, 3110.424571454288, 3187.059817353886, 3256.3812875553567, 3257.1368587324378, 1033.7467320506448, 1042.6298663974255, 1042.880068792091, 1084.69628504019, 1925.6245032218724, 10716.464176791207, 10743.78512429747, 10754.08590269828, 10859.34843909368, 10887.23789334739, 4183.958160418357, 4189.53366321785, 4229.725067870579, 4276.251655960256, 4277.807498662568, 8700.912990870136, 8783.604737786814, 8794.34042446819, 8808.295336373074, 8823.0, 4907.533784290486, 4918.606511479073, 4920.852374428773, 4943.579795717333, 4949.0, 3917.6082391760597, 4449.866504004885, 4489.012417268195, 4518.2319005769095, 4526.434195725535, 3519.6480351964597, 3523.2601153757487, 3581.068922080226, 3628.0385697790107, 3644.0707619556842, 1081.6863109698256, 1089.5750657243682, 1091.5851976249132, 1102.795982743195, 1131.3607811586428, 907.5190149220923, 916.0793402630314, 920.6731610278389, 932.572428466333, 956.273232343424, 5585.050541407971, 5619.4099619540175, 5662.490375866109, 5821.679807610622, 5890.558208134407, 957.5020989085637, 981.4896253947907, 1002.9749256268651, 1005.8340373838381, 1014.8985101489792, 3951.585083566242, 3989.261986532501, 4027.838886444568, 4033.858814941463, 4105.44576482177, 9562.235021198287, 9680.27397945143, 9785.559649815776, 9831.410115393099, 9932.0, 9824.803503930025, 9848.901510984799, 9926.950365248127, 9962.0, 9992.65025724096, 7570.432217583703, 7711.498752581064, 7760.262775036363, 7787.688492460238, 7824.37405007598, 5539.335279766293, 5603.32760068778, 5613.831585052455, 5634.267545219095, 5771.682557459212, 9137.040610736043, 9202.493862837608, 9219.939706933788, 9268.026857179899, 9268.212201962908, 9058.592363343534, 9331.0202428744, 9371.062893710574, 9380.530973451163, 9549.331546791658, 6157.907631385443, 6661.600303981777, 6794.388505034571, 6832.692528836114, 6912.0, 7733.806654833674, 7782.066152061789, 7783.532988020737, 7806.453548251795, 7808.492447990862, 6957.756478523227, 7178.497505174797, 7201.531900426456, 7252.854942901007, 7260.056192694916, 7036.964815175891, 7054.08296921397, 7096.467764917548, 7161.820954476179, 7182.3894968928225, 6166.691665416622, 6301.338359472373, 6325.778597749057, 6335.619862808247, 6342.52431067681, 4868.318435418973, 4889.731064791471, 4957.157283261926, 4962.851114466572, 4997.575206107522, 4897.094037603055, 4897.216445368724, 4914.262860570943, 4980.128477516348, 4987.10232158215], "value": 4338.9211469175025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8615995122098, 326.98201598912055, 332.2955334690455, 337.185696542849, 338.05850705784394, 5505.146702261146, 5539.556835453164, 5581.386047534768, 5617.325920889494, 5629.0, 5535.280413546244, 5542.1409681499335, 5550.195221692852, 5550.502273976706, 5560.499555040045, 4074.9999999999927, 4179.477565304337, 4290.506591741959, 4296.281487405032, 4318.747563206666, 4269.594388533084, 4298.398224248608, 4315.611594956454, 4321.200577893084, 4324.11355672088, 4287.764172970486, 4299.484061912575, 4306.720063195898, 4318.179545886287, 4320.6327462165755, 4027.859024934128, 4249.87250382489, 4257.510386305584, 4273.572642735733, 4318.3090705486975, 3696.815159242027, 3708.369577171887, 3713.740038197327, 3736.1033351995598, 3752.2683076800035, 5372.597055220874, 5373.785048598052, 5375.11310633745, 5382.989672693829, 5411.702356370398, 4607.17070927233, 4779.163646361908, 4877.292792545097, 4894.41267047953, 4911.4106307243355, 5744.597878148531, 5759.3376761672525, 5778.971105144489, 5800.477956983849, 5814.767409303623, 4034.8587799427173, 4068.6338229559483, 4071.801227337234, 4082.7142100053006, 4091.6931230157857, 5941.8811623767715, 5973.342932277446, 6004.519638428959, 6084.0, 6086.969565152191, 4175.853845115467, 4185.351270553069, 4195.0, 4197.719695492904, 4198.8110535026, 4244.533101358848, 4246.851360202378, 4248.596383343577, 4255.574442555781, 4265.658747300208, 4708.364370809965, 4776.853555146809, 4851.878703032382, 4895.31465594817, 4917.950820491821, 5776.797812076557, 5798.739056742456, 5799.652020878676, 5865.149553314745, 5889.763149738517, 1543.1666899874167, 1554.65020370418, 1557.9844201558067, 1558.0651609034715, 1560.9765853512206, 1006.4011912911806, 1009.5002973528151, 1015.2639336480992, 1029.2846471702244, 1046.2885238038207, 5847.56143289255, 5939.287285525678, 5953.613015154001, 5956.64260144384, 5964.850878728066, 6332.366763323631, 6348.904766428507, 6362.936370636235, 6383.96808015957, 6398.712057957403, 5741.65550066989, 5933.436323549256, 5956.821295361059, 5962.672053037125, 5987.730552125165, 3385.3906296866307, 3427.451607742799, 3437.570303712036, 3437.8968630941113, 3444.1733983843696, 6425.614463132227, 6529.477641788741, 6559.6064236145985, 6559.638530129149, 6568.770093046721, 6473.546851720334, 6484.319146489645, 6487.3188315226225, 6495.350464953562, 6554.70503827329, 6341.938869867219, 6521.6413097279155, 6541.70562324687, 6547.639879806561, 6551.770688025897, 6356.745730170742, 6358.618482891041, 6365.267994180728, 6374.26695929974, 6385.904211436739, 6159.4456498915315, 6250.968745156245, 6304.784559874405, 6316.305206427198, 6337.809865704036, 6528.804135875931, 6536.934630653633, 6543.0, 6549.7380104795275, 6562.5406221564035, 4349.195398851222, 4353.259945809156, 4385.122975404868, 4392.275274579786, 4393.406890069799, 6213.937860621336, 6271.43557079865, 6313.55805093639, 6356.55504114726, 6370.681465926593, 6139.434444216696, 6146.78486252979, 6175.62946223228, 6190.907136393048, 6201.379862013762, 5875.206847075761, 6080.635161890301, 6133.969330153321, 6152.230971128609, 6161.6919154041225, 5945.554083443672, 6010.128531363015, 6022.2171117754415, 6034.7284372202475, 6063.393660633901, 6166.969165154145, 6184.515716228163, 6184.752609895554, 6219.440250377488, 6219.533534984804, 5847.678377689268, 6016.308124565731, 6041.9395806041375, 6071.453569178795, 6084.209052823105], "value": 4546.402242465365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8133248020473, 790.8734602463605, 794.9006374203225, 803.1807556292582, 808.5876203136403, 13159.868401315984, 13219.140755850874, 13396.866031339683, 13418.194908305508, 13423.798643020351, 12815.551455699053, 12871.871281287184, 12890.548830790924, 12893.226406415622, 12908.677283067927, 676.1615596660155, 798.0941631248517, 801.5992003998001, 802.3781569283823, 823.2672921100226, 815.6288888555692, 817.1175130858659, 820.1962077164383, 821.3757544266371, 822.5311572403732, 854.0818619983512, 864.8789169516273, 865.8051938313891, 866.9653213871437, 869.0310304011014, 850.9702160424387, 855.3841234311317, 855.5551113421018, 855.7047818502668, 861.96983105591, 626.1609443345939, 627.1815281058217, 627.2347735762363, 629.471244154912, 633.9017452294902, 12813.743725125538, 12880.549180778627, 12900.22598644075, 12901.548445804352, 12907.80638290417, 13569.321533923363, 13798.310084495735, 13826.723465530633, 13899.79150312746, 13917.164970101827, 10272.897271027268, 10292.382457052601, 10349.0, 10349.275550711453, 10364.0, 3631.110377957391, 3750.1749615084636, 3755.3615885299564, 3831.04223944014, 3893.1824316893485, 51101.0, 51206.0, 51878.48121518774, 52675.0, 52759.47240527584, 10375.533101010473, 10464.372137671764, 10497.790044199226, 10528.736781580368, 10576.629817956335, 17147.228374723167, 17408.738868916975, 17414.39049633282, 17417.65164696699, 17428.39000634997, 8098.068722096917, 8207.507549547046, 8374.41379103469, 8483.060695450062, 8575.356848236283, 4608.516105808909, 4675.579197872208, 4845.200541910545, 4854.296127061556, 4856.490068542752, 3292.5555050068415, 3377.071305391037, 3382.1037425082372, 3394.13449570358, 3401.727861771052, 591.3672370563542, 596.7821745063021, 609.1046162141645, 619.6406084470996, 620.3486339343671, 707.9079719636414, 716.6954044531053, 721.0950257426896, 725.4341613541446, 726.440640706653, 8051.718189863327, 8259.761035844671, 8360.331173506227, 8434.831303373898, 8747.562621869009, 751.6241879060469, 761.9847603048019, 762.2948772385632, 775.8409526047146, 792.1959211400433, 4388.407564978751, 4460.1525710114975, 4490.595846373842, 4498.50516443191, 4523.2988886722615, 60339.39660603338, 60378.396216037276, 62537.68731156315, 63495.92032637378, 64418.0, 56149.15776263359, 56215.0, 56359.43640563624, 56648.43351566514, 57551.13673294904, 49450.0, 50099.0, 50136.749316252455, 50169.49830501648, 50876.0, 8321.6671333146, 8443.95778021106, 8708.56457177126, 8823.735287941372, 8887.244584210415, 33504.329913402085, 34002.829985849916, 34587.654123458444, 35008.0, 35011.64988350084, 43721.78139109284, 44107.338389923534, 44171.77914110409, 44199.33700994552, 44455.33317000183, 10796.730081747704, 11030.613928512463, 11110.277831940897, 11123.165762568002, 11169.0, 11593.710157246136, 11707.473163707484, 11828.645140645795, 11935.34355610415, 12414.0, 10406.739831504274, 11263.718407039889, 11373.31760094397, 11404.600838970597, 11405.856737645427, 11390.145739069438, 11743.295402275891, 11828.290302581872, 11911.76176476483, 12021.639350819489, 10900.34597924127, 10901.509432075418, 11062.834057489305, 11141.665750027512, 11316.434178290889, 9923.900760992297, 10124.848127278245, 10257.74355641115, 10300.0, 10421.583136674448, 9592.856107158259, 9803.41179529202, 9890.406575605486, 9905.61321415017, 9975.20198384142], "value": 6516.064869627554, "unit": "score"}], "name": "dromaeo_css", "value": 7111.957920569283, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 112.0, 112.0, 123.0, 110.0, 110.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 152.0, 188.0, 130.0, 165.0, 153.0, 127.0, 196.0, 128.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 161.0, 161.0, 165.0, 173.0, 163.0, 164.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 165.0, 75.0, 76.0, 75.0, 76.0, 169.0, 72.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 159.0, 93.0, 92.0, 92.0, 141.0, 92.0, 92.0, 143.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 117.0, 121.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 60.0, 60.0, 59.0, 79.0, 58.0, 59.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 65.0, 61.0, 61.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 80.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 124.0, 132.0, 123.0, 126.0, 123.0, 132.0, 208.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 174.0, 169.0, 171.0, 172.0, 168.0, 170.0, 176.0, 173.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 71.0, 67.0, 69.0, 67.0, 66.0, 68.0, 67.0, 70.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1566.1, "alertThreshold": 2.0}]} 07:20:12 INFO - Return code: 0 07:20:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:20:12 ERROR - # TBPL SUCCESS # 07:20:12 INFO - Running post-action listener: _resource_record_post_action 07:20:12 INFO - Running post-run listener: _resource_record_post_run 07:20:13 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537681920; Read time: 8; Write time: 416996 07:20:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244760576; Read time: 0; Write time: 209816 07:20:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292921344; Read time: 8; Write time: 207180 07:20:13 INFO - Running post-run listener: _upload_blobber_files 07:20:13 INFO - Blob upload gear active. 07:20:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:13 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 07:20:13 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'] 07:20:13 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 07:20:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:14 INFO - (blobuploader) - INFO - Done attempting. 07:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:15 INFO - (blobuploader) - INFO - Done attempting. 07:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:15 INFO - Return code: 0 07:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25f7a66173df3bd35b963b558f79b78f3ed4727e5bb33ed20116082a32194715a564e5f9eb99232d16781d842f0fb15a0ff25fc3c9c995707175d76bad79f3ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300c78223d32fb204234a48cc697c901f9c235765b3a3e354120cc244f124f2407c89450694bab8e51d13c785166ce0ccdf878f3228d044834d4cae1d0096a82"} 07:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:15 INFO - Contents: 07:20:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25f7a66173df3bd35b963b558f79b78f3ed4727e5bb33ed20116082a32194715a564e5f9eb99232d16781d842f0fb15a0ff25fc3c9c995707175d76bad79f3ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300c78223d32fb204234a48cc697c901f9c235765b3a3e354120cc244f124f2407c89450694bab8e51d13c785166ce0ccdf878f3228d044834d4cae1d0096a82"} 07:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:15 INFO - Copying logs to upload dir... 07:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.598395 ========= master_lag: 17.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-23 07:20:32.495580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:20:32.499333) ========= 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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 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/25f7a66173df3bd35b963b558f79b78f3ed4727e5bb33ed20116082a32194715a564e5f9eb99232d16781d842f0fb15a0ff25fc3c9c995707175d76bad79f3ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300c78223d32fb204234a48cc697c901f9c235765b3a3e354120cc244f124f2407c89450694bab8e51d13c785166ce0ccdf878f3228d044834d4cae1d0096a82"} build_url:https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/CDz9KKoxR2ac-Ft0pfmJ5Q/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/25f7a66173df3bd35b963b558f79b78f3ed4727e5bb33ed20116082a32194715a564e5f9eb99232d16781d842f0fb15a0ff25fc3c9c995707175d76bad79f3ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300c78223d32fb204234a48cc697c901f9c235765b3a3e354120cc244f124f2407c89450694bab8e51d13c785166ce0ccdf878f3228d044834d4cae1d0096a82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:20:32.526296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:20:32.526911) ========= 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=ed14279e38b05397cf4aa391000001a4-1461418515.872997-1774964420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:20:32.579190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:20:32.579584) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:20:32.580146) ========= ========= Total master_lag: 17.63 =========