builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1464616789.54 results: success (0) buildid: 20160530043007 builduid: 71d04c5192ff44219e33b258fd677f34 revision: d0337c1582a148c5e7ebc441010074256edb8839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.540400) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.541180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.542330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.575877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.576199) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 06:59:49-- 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% 225M=0s 2016-05-30 06:59:49 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.679363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.679917) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015797 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.730618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:49.731002) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d0337c1582a148c5e7ebc441010074256edb8839 --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 d0337c1582a148c5e7ebc441010074256edb8839 --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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 06:59:50,052 truncating revision to first 12 chars 2016-05-30 06:59:50,053 Setting DEBUG logging. 2016-05-30 06:59:50,053 attempt 1/10 2016-05-30 06:59:50,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d0337c1582a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 06:59:50,355 unpacking tar archive at: mozilla-inbound-d0337c1582a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:50.393305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:50.393622) ========= script_repo_revision: d0337c1582a148c5e7ebc441010074256edb8839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:50.394069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:50.394430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:59:50.405306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 06:59:50.405616) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:50 INFO - MultiFileLogger online at 20160530 06:59:50 in /builds/slave/test 06:59:50 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:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:50 INFO - {'append_to_log': False, 06:59:50 INFO - 'base_work_dir': '/builds/slave/test', 06:59:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:59:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:50 INFO - 'branch': 'Mozilla-Inbound', 06:59:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:50 INFO - 'config_files': ('talos/linux_config.py',), 06:59:50 INFO - 'default_actions': ('clobber', 06:59:50 INFO - 'read-buildbot-config', 06:59:50 INFO - 'download-and-extract', 06:59:50 INFO - 'populate-webroot', 06:59:50 INFO - 'create-virtualenv', 06:59:50 INFO - 'install', 06:59:50 INFO - 'run-tests'), 06:59:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:50 INFO - 'download_minidump_stackwalk': True, 06:59:50 INFO - 'download_symbols': 'ondemand', 06:59:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:50 INFO - 'installer_path': 'installer.exe', 06:59:50 INFO - 'log_level': 'info', 06:59:50 INFO - 'log_name': 'talos', 06:59:50 INFO - 'log_to_console': True, 06:59:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:50 INFO - 'opt_config_files': (), 06:59:50 INFO - 'pip_index': False, 06:59:50 INFO - 'sps_profile': False, 06:59:50 INFO - 'sps_profile_interval': 0, 06:59:50 INFO - 'suite': 'dromaeojs-e10s', 06:59:50 INFO - 'system_bits': '32', 06:59:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:50 INFO - 'title': 'talos-linux64-ix-042', 06:59:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:50 INFO - 'use_talos_json': True, 06:59:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:50 INFO - 'work_dir': 'build'} 06:59:50 INFO - ##### 06:59:50 INFO - ##### Running clobber step. 06:59:50 INFO - ##### 06:59:50 INFO - Running pre-action listener: _resource_record_pre_action 06:59:50 INFO - Running main action method: clobber 06:59:50 INFO - rmtree: /builds/slave/test/build 06:59:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:51 INFO - Running post-action listener: _resource_record_post_action 06:59:51 INFO - ##### 06:59:51 INFO - ##### Finished clobber step (success) 06:59:51 INFO - ##### 06:59:51 INFO - ##### 06:59:51 INFO - ##### Running read-buildbot-config step. 06:59:51 INFO - ##### 06:59:51 INFO - Running pre-action listener: _resource_record_pre_action 06:59:51 INFO - Running main action method: read_buildbot_config 06:59:51 INFO - Using buildbot properties: 06:59:51 INFO - { 06:59:51 INFO - "project": "", 06:59:51 INFO - "product": "firefox", 06:59:51 INFO - "script_repo_revision": "production", 06:59:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 06:59:51 INFO - "repository": "", 06:59:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 06:59:51 INFO - "buildid": "20160530043007", 06:59:51 INFO - "pgo_build": "True", 06:59:51 INFO - "basedir": "/builds/slave/test", 06:59:51 INFO - "buildnumber": 1093, 06:59:51 INFO - "slavename": "talos-linux64-ix-042", 06:59:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:59:51 INFO - "platform": "ubuntu64_hw", 06:59:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:59:51 INFO - "branch": "mozilla-inbound", 06:59:51 INFO - "repo_path": "integration/mozilla-inbound", 06:59:51 INFO - "revision": "d0337c1582a148c5e7ebc441010074256edb8839", 06:59:51 INFO - "stage_platform": "linux64-pgo", 06:59:51 INFO - "builduid": "71d04c5192ff44219e33b258fd677f34", 06:59:51 INFO - "slavebuilddir": "test" 06:59:51 INFO - } 06:59:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:59:51 INFO - Running post-action listener: _resource_record_post_action 06:59:51 INFO - ##### 06:59:51 INFO - ##### Finished read-buildbot-config step (success) 06:59:51 INFO - ##### 06:59:51 INFO - ##### 06:59:51 INFO - ##### Running download-and-extract step. 06:59:51 INFO - ##### 06:59:51 INFO - Running pre-action listener: _resource_record_pre_action 06:59:51 INFO - Running main action method: download_and_extract 06:59:51 INFO - mkdir: /builds/slave/test/build/tests 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:51 INFO - https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:59:56 INFO - Downloaded 1361 bytes. 06:59:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:59:56 INFO - Using the following test package requirements: 06:59:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:59:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'jsshell-linux-x86_64.zip'], 06:59:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:56 INFO - https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:03 INFO - Downloaded 24410062 bytes. 07:00:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:04 INFO - Return code: 0 07:00:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:06 INFO - Downloaded 24410062 bytes. 07:00:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:08 INFO - Return code: 0 07:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:08 INFO - https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:00:09 INFO - Downloaded 10834055 bytes. 07:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:00:09 INFO - Return code: 0 07:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:09 INFO - https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:00:10 INFO - Downloaded 58916821 bytes. 07:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:00:10 INFO - mkdir: /builds/slave/test/properties 07:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:10 INFO - Contents: 07:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - Running post-action listener: set_extra_try_arguments 07:00:11 INFO - ##### 07:00:11 INFO - ##### Finished download-and-extract step (success) 07:00:11 INFO - ##### 07:00:11 INFO - ##### 07:00:11 INFO - ##### Running populate-webroot step. 07:00:11 INFO - ##### 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: populate_webroot 07:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:11 INFO - '--tppagecycles', 07:00:11 INFO - '7'], 07:00:11 INFO - 'tests': ['tsvgm']}}, 07:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s', 07:00:11 INFO - '--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}, 07:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}}, 07:00:11 INFO - 'talos.zip': {'path': '', 07:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - ##### 07:00:11 INFO - ##### Finished populate-webroot step (success) 07:00:11 INFO - ##### 07:00:11 INFO - ##### 07:00:11 INFO - ##### Running create-virtualenv step. 07:00:11 INFO - ##### 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: create_virtualenv 07:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:11 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 07:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:11 INFO - Using real prefix '/usr' 07:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:13 INFO - Installing pip.................done. 07:00:13 INFO - Return code: 0 07:00:13 INFO - Installing pip>=1.5 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', '--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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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', '--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:13 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: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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:13 INFO - '_': '/tools/buildbot/bin/python'} 07:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:14 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:14 INFO - Cleaning up... 07:00:14 INFO - Return code: 0 07:00:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:14 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>=3.1.1'] in /builds/slave/test/build 07:00:14 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>=3.1.1 07:00:14 INFO - Using env: {'DISPLAY': ':0', 07:00:14 INFO - 'HOME': '/home/cltbld', 07:00:14 INFO - 'LANG': 'en_US.UTF-8', 07:00:14 INFO - 'LANGUAGE': 'en_US:en', 07:00:14 INFO - 'LOGNAME': 'cltbld', 07:00:14 INFO - 'MAIL': '/var/mail/cltbld', 07:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:14 INFO - 'MOZ_NO_REMOTE': '1', 07:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:14 INFO - 'NO_EM_RESTART': '1', 07:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:14 INFO - 'PWD': '/builds/slave/test', 07:00:14 INFO - 'SHELL': '/bin/bash', 07:00:14 INFO - 'SHLVL': '1', 07:00:14 INFO - 'TERM': 'linux', 07:00:14 INFO - 'TMOUT': '86400', 07:00:14 INFO - 'USER': 'cltbld', 07:00:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:14 INFO - '_': '/tools/buildbot/bin/python'} 07:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:14 INFO - Downloading/unpacking psutil>=3.1.1 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:16 INFO - Installing collected packages: psutil 07:00:16 INFO - Running setup.py install for psutil 07:00:16 INFO - building 'psutil._psutil_linux' extension 07:00:16 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:16 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:16 INFO - building 'psutil._psutil_posix' extension 07:00:16 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:16 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:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:16 INFO - Successfully installed psutil 07:00:16 INFO - Cleaning up... 07:00:16 INFO - Return code: 0 07:00:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:16 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:16 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.3'] in /builds/slave/test/build 07:00:16 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.3 07:00:16 INFO - Using env: {'DISPLAY': ':0', 07:00:16 INFO - 'HOME': '/home/cltbld', 07:00:16 INFO - 'LANG': 'en_US.UTF-8', 07:00:16 INFO - 'LANGUAGE': 'en_US:en', 07:00:16 INFO - 'LOGNAME': 'cltbld', 07:00:16 INFO - 'MAIL': '/var/mail/cltbld', 07:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:16 INFO - 'MOZ_NO_REMOTE': '1', 07:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:16 INFO - 'NO_EM_RESTART': '1', 07:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:16 INFO - 'PWD': '/builds/slave/test', 07:00:16 INFO - 'SHELL': '/bin/bash', 07:00:16 INFO - 'SHLVL': '1', 07:00:16 INFO - 'TERM': 'linux', 07:00:16 INFO - 'TMOUT': '86400', 07:00:16 INFO - 'USER': 'cltbld', 07:00:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:16 INFO - '_': '/tools/buildbot/bin/python'} 07:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 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:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:19 INFO - Installing collected packages: mozsystemmonitor 07:00:19 INFO - Running setup.py install for mozsystemmonitor 07:00:19 INFO - Successfully installed mozsystemmonitor 07:00:19 INFO - Cleaning up... 07:00:19 INFO - Return code: 0 07:00:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:19 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 07:00:19 INFO - 'HOME': '/home/cltbld', 07:00:19 INFO - 'LANG': 'en_US.UTF-8', 07:00:19 INFO - 'LANGUAGE': 'en_US:en', 07:00:19 INFO - 'LOGNAME': 'cltbld', 07:00:19 INFO - 'MAIL': '/var/mail/cltbld', 07:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:19 INFO - 'MOZ_NO_REMOTE': '1', 07:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:19 INFO - 'NO_EM_RESTART': '1', 07:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:19 INFO - 'PWD': '/builds/slave/test', 07:00:19 INFO - 'SHELL': '/bin/bash', 07:00:19 INFO - 'SHLVL': '1', 07:00:19 INFO - 'TERM': 'linux', 07:00:19 INFO - 'TMOUT': '86400', 07:00:19 INFO - 'USER': 'cltbld', 07:00:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:19 INFO - '_': '/tools/buildbot/bin/python'} 07:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:19 INFO - Downloading/unpacking blobuploader==1.2.4 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:21 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Downloading docopt-0.6.1.tar.gz 07:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:22 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:22 INFO - Running setup.py install for blobuploader 07:00:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:22 INFO - Running setup.py install for requests 07:00:22 INFO - Running setup.py install for docopt 07:00:22 INFO - Successfully installed blobuploader requests docopt 07:00:22 INFO - Cleaning up... 07:00:22 INFO - Return code: 0 07:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:22 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 07:00:22 INFO - 'HOME': '/home/cltbld', 07:00:22 INFO - 'LANG': 'en_US.UTF-8', 07:00:22 INFO - 'LANGUAGE': 'en_US:en', 07:00:22 INFO - 'LOGNAME': 'cltbld', 07:00:22 INFO - 'MAIL': '/var/mail/cltbld', 07:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:22 INFO - 'MOZ_NO_REMOTE': '1', 07:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:22 INFO - 'NO_EM_RESTART': '1', 07:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:22 INFO - 'PWD': '/builds/slave/test', 07:00:22 INFO - 'SHELL': '/bin/bash', 07:00:22 INFO - 'SHLVL': '1', 07:00:22 INFO - 'TERM': 'linux', 07:00:22 INFO - 'TMOUT': '86400', 07:00:22 INFO - 'USER': 'cltbld', 07:00:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:22 INFO - '_': '/tools/buildbot/bin/python'} 07:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:22 INFO - Running setup.py (path:/tmp/pip-7_UA0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:22 INFO - Running setup.py (path:/tmp/pip-NPRpd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:22 INFO - Running setup.py (path:/tmp/pip-W1bZza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:23 INFO - Running setup.py (path:/tmp/pip-G81dRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:23 INFO - Running setup.py (path:/tmp/pip-lDEhjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:23 INFO - Running setup.py (path:/tmp/pip-5oj3Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:23 INFO - Running setup.py (path:/tmp/pip-tKfDZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:23 INFO - Running setup.py (path:/tmp/pip-1pI22u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:23 INFO - Running setup.py (path:/tmp/pip-qC9Aq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:23 INFO - Running setup.py (path:/tmp/pip-4tjkB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:23 INFO - Running setup.py (path:/tmp/pip-psokOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:23 INFO - Running setup.py (path:/tmp/pip-N4n6Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:23 INFO - Running setup.py (path:/tmp/pip-I7PVpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:23 INFO - Running setup.py (path:/tmp/pip-Fgw9RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:23 INFO - Running setup.py (path:/tmp/pip-W3bXPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:23 INFO - Running setup.py (path:/tmp/pip-3hWLDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:23 INFO - Running setup.py (path:/tmp/pip-lCqHbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:24 INFO - Running setup.py install for manifestparser 07:00:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozcrash 07:00:24 INFO - Running setup.py install for mozdebug 07:00:24 INFO - Running setup.py install for mozdevice 07:00:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozfile 07:00:24 INFO - Running setup.py install for mozhttpd 07:00:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozinfo 07:00:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozInstall 07:00:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozleak 07:00:24 INFO - Running setup.py install for mozlog 07:00:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Running setup.py install for moznetwork 07:00:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Running setup.py install for mozprocess 07:00:25 INFO - Running setup.py install for mozprofile 07:00:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Running setup.py install for mozrunner 07:00:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Running setup.py install for mozscreenshot 07:00:25 INFO - Running setup.py install for moztest 07:00:25 INFO - Running setup.py install for mozversion 07:00:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:25 INFO - Cleaning up... 07:00:25 INFO - Return code: 0 07:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:25 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 07:00:25 INFO - 'HOME': '/home/cltbld', 07:00:25 INFO - 'LANG': 'en_US.UTF-8', 07:00:25 INFO - 'LANGUAGE': 'en_US:en', 07:00:25 INFO - 'LOGNAME': 'cltbld', 07:00:25 INFO - 'MAIL': '/var/mail/cltbld', 07:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:25 INFO - 'MOZ_NO_REMOTE': '1', 07:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:25 INFO - 'NO_EM_RESTART': '1', 07:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:25 INFO - 'PWD': '/builds/slave/test', 07:00:25 INFO - 'SHELL': '/bin/bash', 07:00:25 INFO - 'SHLVL': '1', 07:00:25 INFO - 'TERM': 'linux', 07:00:25 INFO - 'TMOUT': '86400', 07:00:25 INFO - 'USER': 'cltbld', 07:00:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:25 INFO - '_': '/tools/buildbot/bin/python'} 07:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:26 INFO - Running setup.py (path:/tmp/pip-VHytEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:26 INFO - Running setup.py (path:/tmp/pip-SsYQs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:26 INFO - Running setup.py (path:/tmp/pip-sN7Mb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:26 INFO - Running setup.py (path:/tmp/pip-VDDZ0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:26 INFO - Running setup.py (path:/tmp/pip-_ZtvT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:26 INFO - Running setup.py (path:/tmp/pip-8gGiPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:26 INFO - Running setup.py (path:/tmp/pip-7oJJdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:26 INFO - Running setup.py (path:/tmp/pip-hXnTTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:26 INFO - Running setup.py (path:/tmp/pip-koDkEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:26 INFO - Running setup.py (path:/tmp/pip-N2BLj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:26 INFO - Running setup.py (path:/tmp/pip-13b62S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:26 INFO - Running setup.py (path:/tmp/pip-IUmbCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:26 INFO - Running setup.py (path:/tmp/pip-CbgECR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:26 INFO - Running setup.py (path:/tmp/pip-h795Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:27 INFO - Running setup.py (path:/tmp/pip-RJORZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:27 INFO - Running setup.py (path:/tmp/pip-NILce1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:27 INFO - Running setup.py (path:/tmp/pip-G_UI8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:27 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:27 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:27 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:27 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:27 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:27 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:29 INFO - Downloading blessings-1.6.tar.gz 07:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:29 INFO - Installing collected packages: blessings 07:00:29 INFO - Running setup.py install for blessings 07:00:29 INFO - Successfully installed blessings 07:00:29 INFO - Cleaning up... 07:00:29 INFO - Return code: 0 07:00:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:29 INFO - Reading from file tmpfile_stdout 07:00:29 INFO - Current package versions: 07:00:29 INFO - argparse == 1.2.1 07:00:29 INFO - blessings == 1.6 07:00:29 INFO - blobuploader == 1.2.4 07:00:29 INFO - docopt == 0.6.1 07:00:29 INFO - manifestparser == 1.1 07:00:29 INFO - mozInstall == 1.12 07:00:29 INFO - mozcrash == 0.17 07:00:29 INFO - mozdebug == 0.1 07:00:29 INFO - mozdevice == 0.48 07:00:29 INFO - mozfile == 1.2 07:00:29 INFO - mozhttpd == 0.7 07:00:29 INFO - mozinfo == 0.9 07:00:29 INFO - mozleak == 0.1 07:00:29 INFO - mozlog == 3.2 07:00:29 INFO - moznetwork == 0.27 07:00:29 INFO - mozprocess == 0.22 07:00:29 INFO - mozprofile == 0.28 07:00:29 INFO - mozrunner == 6.11 07:00:29 INFO - mozscreenshot == 0.1 07:00:29 INFO - mozsystemmonitor == 0.3 07:00:29 INFO - moztest == 0.7 07:00:29 INFO - mozversion == 1.4 07:00:29 INFO - psutil == 3.1.1 07:00:29 INFO - requests == 1.2.3 07:00:29 INFO - wsgiref == 0.1.2 07:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:29 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 07:00:29 INFO - 'HOME': '/home/cltbld', 07:00:29 INFO - 'LANG': 'en_US.UTF-8', 07:00:29 INFO - 'LANGUAGE': 'en_US:en', 07:00:29 INFO - 'LOGNAME': 'cltbld', 07:00:29 INFO - 'MAIL': '/var/mail/cltbld', 07:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:29 INFO - 'MOZ_NO_REMOTE': '1', 07:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:29 INFO - 'NO_EM_RESTART': '1', 07:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:29 INFO - 'PWD': '/builds/slave/test', 07:00:29 INFO - 'SHELL': '/bin/bash', 07:00:29 INFO - 'SHLVL': '1', 07:00:29 INFO - 'TERM': 'linux', 07:00:29 INFO - 'TMOUT': '86400', 07:00:29 INFO - 'USER': 'cltbld', 07:00:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:29 INFO - '_': '/tools/buildbot/bin/python'} 07:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Cleaning up... 07:00:29 INFO - Return code: 0 07:00:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:29 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 07:00:29 INFO - 'HOME': '/home/cltbld', 07:00:29 INFO - 'LANG': 'en_US.UTF-8', 07:00:29 INFO - 'LANGUAGE': 'en_US:en', 07:00:29 INFO - 'LOGNAME': 'cltbld', 07:00:29 INFO - 'MAIL': '/var/mail/cltbld', 07:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:29 INFO - 'MOZ_NO_REMOTE': '1', 07:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:29 INFO - 'NO_EM_RESTART': '1', 07:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:29 INFO - 'PWD': '/builds/slave/test', 07:00:29 INFO - 'SHELL': '/bin/bash', 07:00:29 INFO - 'SHLVL': '1', 07:00:29 INFO - 'TERM': 'linux', 07:00:29 INFO - 'TMOUT': '86400', 07:00:29 INFO - 'USER': 'cltbld', 07:00:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:29 INFO - '_': '/tools/buildbot/bin/python'} 07:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:30 INFO - Downloading/unpacking jsonschema 07:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:32 INFO - Downloading/unpacking functools32 (from jsonschema) 07:00:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:32 INFO - warning: no files found matching '*.txt' 07:00:32 INFO - no previously-included directories found matching 'build' 07:00:32 INFO - no previously-included directories found matching 'dist' 07:00:32 INFO - no previously-included directories found matching '.git*' 07:00:32 INFO - Installing collected packages: jsonschema, functools32 07:00:32 INFO - Running setup.py install for functools32 07:00:32 INFO - warning: no files found matching '*.txt' 07:00:32 INFO - no previously-included directories found matching 'build' 07:00:32 INFO - no previously-included directories found matching 'dist' 07:00:32 INFO - no previously-included directories found matching '.git*' 07:00:32 INFO - Successfully installed jsonschema functools32 07:00:32 INFO - Cleaning up... 07:00:32 INFO - Return code: 0 07:00:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:00:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:32 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 0x7f54a3828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 07:00:32 INFO - 'HOME': '/home/cltbld', 07:00:32 INFO - 'LANG': 'en_US.UTF-8', 07:00:32 INFO - 'LANGUAGE': 'en_US:en', 07:00:32 INFO - 'LOGNAME': 'cltbld', 07:00:32 INFO - 'MAIL': '/var/mail/cltbld', 07:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:32 INFO - 'MOZ_NO_REMOTE': '1', 07:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:32 INFO - 'NO_EM_RESTART': '1', 07:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:32 INFO - 'PWD': '/builds/slave/test', 07:00:32 INFO - 'SHELL': '/bin/bash', 07:00:32 INFO - 'SHLVL': '1', 07:00:32 INFO - 'TERM': 'linux', 07:00:32 INFO - 'TMOUT': '86400', 07:00:32 INFO - 'USER': 'cltbld', 07:00:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:32 INFO - '_': '/tools/buildbot/bin/python'} 07:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:32 INFO - Downloading/unpacking flake8 07:00:32 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:32 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:32 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:32 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:32 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:32 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:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:35 INFO - no previously-included directories found matching 'docs/_build' 07:00:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:35 INFO - Running setup.py install for pep8 07:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:35 INFO - no previously-included directories found matching 'docs/_build' 07:00:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:35 INFO - Cleaning up... 07:00:35 INFO - Return code: 0 07:00:35 INFO - Running post-action listener: _resource_record_post_action 07:00:35 INFO - Running post-action listener: _start_resource_monitoring 07:00:35 INFO - Starting resource monitoring. 07:00:35 INFO - ##### 07:00:35 INFO - ##### Finished create-virtualenv step (success) 07:00:35 INFO - ##### 07:00:35 INFO - ##### 07:00:35 INFO - ##### Running install step. 07:00:35 INFO - ##### 07:00:35 INFO - Running pre-action listener: _resource_record_pre_action 07:00:35 INFO - Running main action method: install 07:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:35 INFO - Reading from file tmpfile_stdout 07:00:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:35 INFO - Reading from file tmpfile_stdout 07:00:35 INFO - Output received: 07:00:35 INFO - Usage: mozinstall [options] installer 07:00:35 INFO - Options: 07:00:35 INFO - -h, --help show this help message and exit 07:00:35 INFO - -d DEST, --destination=DEST 07:00:35 INFO - Directory to install application into. [default: 07:00:35 INFO - "/builds/slave/test"] 07:00:35 INFO - --app=APP Application being installed. [default: firefox] 07:00:35 INFO - mkdir: /builds/slave/test/build/application 07:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:00:52 INFO - Reading from file tmpfile_stdout 07:00:52 INFO - Output received: 07:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:52 INFO - Running post-action listener: _resource_record_post_action 07:00:52 INFO - ##### 07:00:52 INFO - ##### Finished install step (success) 07:00:52 INFO - ##### 07:00:52 INFO - ##### 07:00:52 INFO - ##### Running run-tests step. 07:00:52 INFO - ##### 07:00:52 INFO - Running pre-action listener: _resource_record_pre_action 07:00:52 INFO - Running main action method: run_tests 07:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:52 INFO - Python 2.7.3 07:00:52 INFO - Return code: 0 07:00:52 INFO - grabbing minidump binary from tooltool 07:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:52 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd9c0>, '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 0x29be8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:52 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:52 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:52 INFO - Calling ['/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'] with output_timeout 600 07:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:52 INFO - Return code: 0 07:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:00:53 INFO - Return code: 0 07:00:53 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/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:53 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/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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:53 INFO - Using env: {'DISPLAY': ':0', 07:00:53 INFO - 'HOME': '/home/cltbld', 07:00:53 INFO - 'LANG': 'en_US.UTF-8', 07:00:53 INFO - 'LANGUAGE': 'en_US:en', 07:00:53 INFO - 'LOGNAME': 'cltbld', 07:00:53 INFO - 'MAIL': '/var/mail/cltbld', 07:00:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:53 INFO - 'MOZ_NO_REMOTE': '1', 07:00:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:53 INFO - 'NO_EM_RESTART': '1', 07:00:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:53 INFO - 'PWD': '/builds/slave/test', 07:00:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:53 INFO - 'SHELL': '/bin/bash', 07:00:53 INFO - 'SHLVL': '1', 07:00:53 INFO - 'TERM': 'linux', 07:00:53 INFO - 'TMOUT': '86400', 07:00:53 INFO - 'USER': 'cltbld', 07:00:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827', 07:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:53 INFO - '_': '/tools/buildbot/bin/python'} 07:00:53 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/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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:53 INFO - mozversion application_buildid: 20160530043007 07:00:53 INFO - mozversion application_changeset: d0337c1582a148c5e7ebc441010074256edb8839 07:00:53 INFO - mozversion application_display_name: Nightly 07:00:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:53 INFO - mozversion application_name: Firefox 07:00:53 INFO - mozversion application_remotingname: firefox 07:00:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:53 INFO - mozversion application_vendor: Mozilla 07:00:53 INFO - mozversion application_version: 49.0a1 07:00:53 INFO - mozversion platform_buildid: 20160530043007 07:00:53 INFO - mozversion platform_changeset: d0337c1582a148c5e7ebc441010074256edb8839 07:00:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:53 INFO - mozversion platform_version: 49.0a1 07:00:53 INFO - using testdate: 1464616853 07:00:53 INFO - actual date: 1464616853 07:00:53 INFO - starting webserver on 'localhost:34265' 07:00:53 INFO - SUITE-START | Running 2 tests 07:00:53 INFO - TEST-START | dromaeo_css 07:00:53 INFO - operating with platform_type : linux_ 07:00:53 INFO - Initialising browser for dromaeo_css test... 07:00:53 INFO - TEST-INFO | started process 10973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXX3keT/profile http://localhost:34265/getInfo.html) 07:00:58 INFO - PROCESS | 10973 | __metrics Screen width/height:1600/1200 07:00:58 INFO - PROCESS | 10973 | colorDepth:24 07:00:58 INFO - PROCESS | 10973 | Browser inner width/height: 1024/697 07:00:58 INFO - PROCESS | 10973 | __metrics 07:00:59 ERROR - PROCESS | 10973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:01:00 INFO - TEST-INFO | 10973: exit 0 07:01:00 INFO - Browser initialized. 07:01:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:00 INFO - TEST-INFO | started process 11092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXX3keT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:12 INFO - PROCESS | 11092 | RSS: Main: 167235584 07:01:12 INFO - PROCESS | 11092 | 07:02:01 INFO - PROCESS | 11092 | 1464616921704 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:04:10 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34265/tests/dromaeo/cssquery-ext.html) 07:04:11 INFO - PROCESS | 11092 | RSS: Main: 171266048 07:04:11 INFO - PROCESS | 11092 | 07:07:13 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-ext.html (next: http://localhost:34265/tests/dromaeo/cssquery-jquery.html) 07:07:14 INFO - PROCESS | 11092 | RSS: Main: 169897984 07:07:14 INFO - PROCESS | 11092 | 07:10:16 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34265/tests/dromaeo/cssquery-mootools.html) 07:10:16 INFO - PROCESS | 11092 | RSS: Main: 171257856 07:10:16 INFO - PROCESS | 11092 | 07:13:18 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34265/tests/dromaeo/cssquery-prototype.html) 07:13:19 INFO - PROCESS | 11092 | RSS: Main: 168968192 07:13:19 INFO - PROCESS | 11092 | 07:16:21 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34265/tests/dromaeo/cssquery-yui.html) 07:16:22 INFO - PROCESS | 11092 | RSS: Main: 170934272 07:16:22 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-yui.html (next: http://localhost:34265/tests/dromaeo/cssquery-dojo.html) 07:19:24 INFO - PROCESS | 11092 | RSS: Main: 172138496 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | __start_tp_report 07:19:24 INFO - PROCESS | 11092 | _x_x_mozilla_page_load 07:19:24 INFO - PROCESS | 11092 | _x_x_mozilla_page_load_details 07:19:24 INFO - PROCESS | 11092 | |i|pagename|runs| 07:19:24 INFO - PROCESS | 11092 | |0;dojo.html;3136.357046805405;3207.711305982464;3224.5969253843264;3245.594300712411;3248.2366643838695;5495.780168793243;5554.1668749687515;5560.888782224353;5615.9157612635845;5645.15322701595;5335.1197052486295;5433.402325744175;5443.564514838813;5527.751251193696;5544.805931792388;4966.230234313678;4997.900041999158;5008.549230569248;5042.924356134661;5148.665336753118;4962.851114466554;5135.9743201283945;5136.845894623168;5144.279800827887;5179.378474583036;4983.775730092155;5072.112380333427;5147.099257629919;5147.150720131192;5151.613628977823;5099.898002039976;5102.897942041139;5145.151050076733;5158.7678554464765;5166.638335316529;5061.721605311706;5064.088464076464;5074.771635276385;5074.873128171788;5107.9744601277125;5300.0459917214885;5393.514583687448;5491.423400542965;5510.338759348863;5552.250446189753;5778.797742079049;5785.045467497858;5819.301683797971;5845.298564172326;5855.473007429352;5934.436228558323;5950.553708471839;5951.6726580038085;5956.52347812174;5959.910601340984;5465.344158700942;5530;5535.225068490415;5545.916811247835;5551.167324901297;6057.878842423127;6060.606060606046;6086.452219300196;6101.60339577926;6108.908366374508;5839.766409343663;5840.853978650568;5846.503047241032;5854.941450585439;5867.677277749679;5688.573356998241;5716.771329146871;5738.626989245686;5799.159121927297;5803.419658034247;5734.082546792577;5769.798057068067;5778.653280803165;5781.248437703156;5794.159846822187;5783.768649253982;5793.449622285876;5799;5807.245058142415;5813.941860581424;4325.286327755885;4341.891452713708;4354.9782251088545;4382.539833317455;4405.603495685404;3827.27281816454;3901.258760835489;3901.902452438712;3904.980475097663;3945.0926286954164;5708.771649134072;5732.3407808101765;5736.426357364314;5749.13762935563;5777.480026797609;5746.597738158289;5923.851903702442;5953.255843019622;5991.910121348184;6047.758089676452;5679;5683.346415162227;5704.629199102045;5704.885902282014;5766.163906233573;4907.852764417074;4909.975450122798;4913.87715307113;4920.434150072788;4954.355933728592;5813.5349172066135;6075.513958883367;6126.9452004266695;6141.977005061692;6206.689665516707;5935.495482884004;6024.969875150597;6035.547333949883;6044.818655440344;6070.666113363719;6224.2842073160355;6232.937670623236;6245.68771561411;6246.906296405648;6249.625022498664;5630.887382252414;5852.619579727304;5889.528837692888;5926.762929482772;5975.312839023568;5982.102684597346;6008.699565021644;6041.728122234422;6045.758169673164;6082.239720034996;5543.417941116125;5913.615614985184;5928.051511758271;5930.8056019273145;5933.970330148321;5726.74229659658;5767.365589785037;5799.797007104899;5837.912431313449;5838.912416313674;5751.166080918327;5753.367129615655;5759.164921086335;5766.135079738073;5784.190213370048;5675.631083979528;5764.798232061858;5882;5922.022866227025;5923.378045305181;5530.198121272312;5570.470805273492;5575.470330318613;5677.432256774455;5801.5938884279385 07:19:24 INFO - PROCESS | 11092 | |1;ext.html;556.8524341049623;609.4058293164165;621.64255553057;624.241546520977;625.4589779840438;38021.239575208514;42375.36436953448;42408.57591424085;42455.78772106143;42462;42815.78592107043;43434.34848477275;43456.348154777705;43503.12993740123;43527.99999999992;8338.95830520848;8542.74371768848;8601.913980860205;8616.396852220347;8616.784580385478;8775.780605484882;8842.602082906253;8843.646254149826;8879.467231966071;8887.600057997406;8886.333524985652;8923.330750193729;8931.598078086468;8934;8949.552522373888;8836.983746869128;8916.375853690277;8922.598483068245;8924.152205540528;8938.508382038985;8704.651813927436;8740.169683880022;8763.561821908943;8768.605412756442;8782.12178782123;38794.612053879384;39163;39294.21411571753;39492.80253598742;39670;3675.5956844747056;3691.741578089535;3715.6841668458214;3921.392184211452;4159.188958153161;32803.3032585932;33053.3389332212;33114.834425827714;33410.665893341;33860.830695846365;4389.648828093745;4408.915696339063;4423.358613001129;4429.291313389842;4545.931811022837;325967;328647;329200;329834;331325;58941.410585893595;59025.40974590199;59153;59389;59437.702811485666;54315.45684543183;59676.70161649164;60529.39470605326;61552.384476154664;62115.37884621186;14065.156090634595;14227.78658320126;14316.785248221286;14320.928395358165;14336.784948225784;11196.160287978435;11363.886361136283;11403.486843092081;11404.94297528507;11426.942865285786;17392.82607173912;17564.5608859777;17578;17646.558836028944;17719.73420398695;6407.807765767035;6415.1981002374705;6597.208334999831;6605.735770569219;6628.27089020217;972.4554249620236;1017.2777328097134;1038.776663017455;1073.6295977887617;1095.5836782022939;31057.534136987964;33410.832945835115;33453.33093338168;33842.15394615105;34091.318173636886;1086.5327908999047;1122.2985633978763;1124.2355198465123;1137.1641843245209;1209.5887398284626;17080.145992700316;17446.825531744773;17552.03463809477;17562.50718688926;17598.736018959728;550252;550282;551226;551361;553014;59020;59972.70013649991;60202;60206.69896650489;60351.69824150939;1358.8369395672582;1376.7521846067605;1383.5019393018506;1395.0931894268604;1395.4766962389103;31197.53203701901;32798;32949;33245.16887077843;33247.168820779676;52220.73889630527;52476;53020;53046.469535305696;53149.7342513285;498369;504533;506107;507481;509379;44786.77606611946;44887.32669010033;45460.090798184516;45667;46212.53787462082;50311.245331319325;50714.49285507245;50908.23637645364;51011.74494127654;51551.742241290056;41427;41554.79222603868;42554;42560;43532.56467435285;41563.7921810389;41773.37339939843;41904.1619167621;41958.370624440046;42473.36289955591;42075.36886946637;42351.36472952847;42662.36006459968;42927.785361072994;43023.354649679655;34688.479672805435;37550;37822;38240.61759382482;38247.61752382552;27866.58200126959;28650.426991459637;28705.425891481635;28980;29043.85478072596 07:19:24 INFO - PROCESS | 11092 | |2;jquery.html;397.3582663997645;399.7521536647279;403.2640431213037;404.41360027959456;416.9630859220615;13815.792763108562;17846.46460606182;18576.535586610342;19099.618007639856;19362;18397.896126232434;18767.906160469178;19035;19148.61702765944;19168.233270669156;5523.889522209553;5646.435356464362;5802.477777000069;5803.491092315986;5841.386654401291;5456.263404440409;5682.971585142069;5706.80026199081;5734.483896449318;5749.59752817303;5743.425657434265;5813.06990881459;5831.883362332751;5838.065909454488;5852.063669812831;5899.115132730103;6030.306514750816;6039.8792024159275;6067.635941843503;6068.393160683919;5767.855803604902;5801.82594522165;5845.298564172284;6569.146011018584;7079.469039822034;23435.4141146471;25227.369315767068;25467;25564.744352556423;26572.86713566439;2464.297675162588;2475.962860557093;2486.2292689266387;2558.7057488388887;2659.2155314182364;15067;15991;15997.760033599505;16105.114218717967;16379.918100409423;2104.6422108241636;2177.716896803421;2178.1505212966954;2209.3371988403414;2267.5464907018495;90596;95459;97283.0271697281;97588.0241197586;98055.50972245094;16694.4156954506;17656.470305890845;17723.556911077325;17837.554061148316;18176.45470635883;32176.35647287041;32364.676353236166;32395.352092958008;32417.675823241938;32716.509252361233;8929.24101451371;9304.255659547356;9392.201662858733;9423.717288481357;9447.677325174482;7380.151282602569;7441.181470038291;7550.433717471212;7551.660175292125;7762.262585054411;8663.306935445149;8724.607392667345;8765.737027889174;8860.556972151368;9049.411788233876;3232.337370838972;3405.7275417966503;3453.8618455262013;3499.0460779319715;3635.8000309983204;959.3236768078488;995.0646392391274;1061.0026575019458;1084.4740300954031;1091.9235653504338;18113.728294075598;18581.25674973013;19095.80904190968;19139;19308.903455482632;954.1651055326589;966.2656381150376;1000.7698229407132;1006.6728313298207;1046.283295942282;10463.05832475081;10678.305910115818;10738.409387483764;10747.462626868626;10817.621383251548;416079;454357;473525;475227;476788;56648.433515664314;59146.704266478395;62079.689601551705;80237.59881200673;90675;988.649029594498;991.5028307255951;1001.1840350114634;1009.0464511037;1013.7212266626736;16738.246778894736;16865.91567042206;17026.829731702524;17193.656126877144;17385.391511297043;39807.40288895611;40560.79719601501;40787.59212407838;41394.58605413907;42108;54904.450955489934;56583.43416565946;56854.14718779139;56933;57843.71078144582;8798.208161265517;8952.597133128895;9001.32490063261;9054.366194366594;9104.544772761468;12625.936870315589;13549.796753048515;13622.318884055956;13624.114432562248;13770.65573360674;11616.012638925447;11784.116191285859;11831.230969986924;11855.644330670093;12046.879531204575;11207.71980700489;11465.541378344773;11831.82252266234;11949.163558550817;12061.75876482483;12374.319412432042;12421.689457763267;12547.49810007626;12608.558700445441;12674.112812103065;8512.319014478951;8671.578432790939;8700.303975682056;8723.651053958025;8872.955635221782;8747.518886461306;10912.836307455553;11552.480138393961;11928.821067683819;12002.1598488105 07:19:24 INFO - PROCESS | 11092 | |3;mootools.html;1528.793612862264;1568.0826716370923;1733.8352856478639;1809.7013992691207;1867.225101582844;7681.846363072736;8557.400981931267;8917.598708058136;9534.475603841785;9547.57035933383;8734.781630459225;8738.300935925126;8756.255718263956;8831.955840220806;8870.911290887088;2322.6980492535945;2328.7671232876746;2341.274204996457;2347.2019513365453;2353.7410884802657;2304.1129165271323;2315.4674424882287;2352.3883790214495;2365.6096744037213;2372.3120295114395;2339.4619237575366;2346.8709220992837;2370.087516306226;2372.146027430124;2372.54921564903;2250.459889626478;2286.1084177170915;2291.5416916616578;2316.1198744477074;2319.895604697793;2329.918452854142;2347.319277409549;2347.9882600587057;2358.268936629633;2364.47981444082;8817.338699597556;8949;8952.776180595538;8973.057828927998;9008.369414141012;5289.365276166846;5342.519173274424;5410.1343784994215;5456.508914197741;5472.644278121909;3424.520567120605;3511.8595256189724;3535.4166562517153;3582.140286331262;3628.7641303315463;1128.7629597784476;1175.142146233246;1208.800547909594;1214.6416807041944;1224.9142560020803;12605.243685378815;12637.43131559082;12639.304838233893;12640.873591264153;12684.048696347718;4587;4757.9286310705365;4765.1660959331975;4812.181929072066;4828.637852161102;10622.521986510626;10666.520006599721;10699.679009629723;10704.678859634223;10755.247132700792;5323.041852466593;5355.169948657965;5374.381946076173;5383.838484845461;5387.568994480433;4275.931017245689;4962.429320628102;4969.279454479152;5103.617228707862;5161.948380516147;4107.404426358161;4133.090720041646;4169.374593810952;4221.197972385237;4224.809883555247;1289.3295486347047;1297.4291311822767;1321.1610627251573;1325.357201757147;1338.036613638179;918.2837386838277;993.941452353256;1027.2398425165472;1029.629333439961;1043.087298613713;6243.96878015607;6304.905426418607;6316.178896743394;6370.267419246846;6400.135981642512;464.13902211397374;470.5318208382681;471.61092099018447;482.31511254018676;492.50257240186954;4167.666586673059;4394.758288294174;4401.163778882003;4432.268675668479;4448.221561226773;11388.487518061707;11742.58900938463;11895.167338286237;11976.820347694616;12012.639620811215;11738.58914937973;11822.940885295691;11830.17188796776;11839.763204735857;11847.170698051053;8275.793105172419;8603.526806025604;8651.307895368356;8664.653413863502;8792.42849214799;6301.117843501822;6590.176227971504;6594.802155935329;6619.470442364695;6665.66671666405;10908.236423450282;11010.174236932102;11036.944815275872;11066.778664426827;11108.44457777124;10864.239503234698;11217.831732524182;11243.718907027063;11308;11386.259893107253;7353.742619008309;8115.310198632947;8355.707550235713;8380.12008739098;8491.065982742017;9208.079192080739;9233.722988310361;9257;9308.627654893728;9332.533373331442;7832.4517283791865;7926.405519585939;7968.84062318762;7986.440949133737;8345.33237340999;7625.580593067212;7681.270279323456;7731.536107833548;7783.844323113392;7992.6802927884555;7135.393491553276;7204.495685302189;7303.707851685873;7382.9261707384385;7393.334599886036;5337.6797392156595;5417.024935511646;5507.944920550904;5524.66851988882;5644.0687286598895;5430.266913966564;5476.726163691879;5537.861553461195;5568.55451563882;5637.069883469346 07:19:24 INFO - PROCESS | 11092 | |4;prototype.html;331.7928664533713;341.00086745834705;345.74587678056633;348.23214811340995;351.9155402703352;5562.249096371994;5589.329280486342;5623.7908849597325;5639.577031722627;5679.488846003859;5520.420355862637;5566.137248726453;5572.498475137247;5577.665340079598;5594.272744543204;4126.401671757593;4387.276099443596;4393.912121757563;4401.05377343871;4441.444819397575;4338.392625032498;4341.066670665807;4344.239758042346;4346.195953748551;4365.345198220277;4289.892752681192;4307.160103779748;4310.353446982962;4317.395564620955;4323.675724320673;4327.2954403497815;4352.194843953863;4362.952891306096;4367.737935723835;4375.309184851293;3679.9264014719824;3765.3410653135593;3767.1335592813807;3767.3407153747985;3780.6030366811365;5378.709109813655;5382.811601593926;5388;5407.215953686693;5422.295101636762;4924.926126108111;4949.8020079196785;4953.1332016896895;4979.45226025137;4991.4758950310425;5706.400827913092;5829.5919285650025;5837.532997360201;5848.649081055108;5848.912266316009;4180.47744031996;4193.454850869398;4224.514180869178;4226.5418430641375;4228.703990720651;5958.020989505248;6140.570160088796;6140.969295153541;6202.875942481125;6226.844328891769;4264.402983582301;4299.871003869889;4304.225239456928;4320.638998715394;4334.8266069357505;4339.500957389878;4344.6089851913475;4353.172897149531;4354.82419746673;4355.128974205171;4955.4796746341835;4968.701877887338;4971.130052240844;4972.229304457815;4975.203967365204;5688.146777983336;5848.590598658138;5862.14998825168;5881.735321910439;5939;1462.795208670787;1477.2909003678294;1479.88900832438;1480.3486465954945;1483.9851601483847;932.5616960028775;952.2667545989549;955.7610597350663;956.9330196830484;978.7993461340408;5032.943081952831;5076.619253555924;5589.860253493695;5715.342550660262;5758.337791153987;6096.658735078276;6117.84705382369;6119.663418511936;6144.539159563051;6160.1375807387;5569.387367389584;5749.195112684228;5775.711214439261;5811.564132690065;5815.76736930518;3208.812739286479;3245.2860370718877;3253.6095668519456;3254.9674503255137;3277.1807048237943;6303.401176888188;6325.493960483151;6329;6330.100969709161;6375.171227740364;5872.706364681749;6171.814845554641;6173.9073913891325;6185.84535386619;6231.345708700612;6229.626222426669;6310.652914089677;6341.397567231105;6355.822088955522;6361.01404282337;5938.257717785277;6073.906696794619;6090.086487026982;6093.512518998381;6095.299040610209;5974.880502390015;6050.7277172526465;6055.303640081447;6063.423974722395;6108.75564977396;6145.787516493969;6317.4630156437215;6351.301356850835;6372.139761132188;6396.328385519453;4247.683218202367;4259.893502662334;4280.7157852644705;4285.4000439939055;4294.871153865389;6024.337322894566;6103.786367477117;6144.139820425234;6158.414950579688;6167;5866.765329386947;5885.293764748258;5981.611195272293;6006.279246490449;6064.969675151596;5877.971355012941;5900.586958912835;5906.763729450774;5920.822375328747;5983;5809.738561764815;5845.41545845412;5863.296404431496;5886.970565147318;5893.499052580579;5340.813071542478;5837.474627283565;5868.794592189253;5915.704214789157;5936.317323507679;5718.885622287614;5813.273340832396;5838.190161050088;5842.912356314744;5843.561732869966 07:19:24 INFO - PROCESS | 11092 | |5;yui.html;756.912955010174;808.0465051239535;809.5506993618542;838.7399906029132;854.786303424144;14380.784288235685;14559.053661512007;14676.339564719587;14785;14796.704065918688;14083.507077252298;14128.081674691139;14138.081024733385;14155.796757275644;14163.362648680833;799.596203917024;806.105223202245;824.5135370131621;825.8224481736426;833.3458235285302;816.824382757707;822.235321151329;823.0904850140598;825.4345773145385;825.5046971816922;841.3017195727562;843.6035063520167;849.8810166576684;851.3912552524944;853.4751128056232;837.0708513549955;844.5059640110543;845.2646197807885;847.1486156412827;847.546562589012;615.9507239420835;623.3392603839944;624.4473640827855;625.3402660193494;627.1533429869639;13349.66625834362;13411.396487158101;13464.730705385837;13488.730225395535;13498.662533436644;13506.797398039038;13563.660908477268;13670.658233544242;13751.724965500734;13771.98547372733;10768.569257229701;10777.191710621657;10862.45687715619;10983.011528962432;11236.550537978472;3759.6992240620957;3770.8491660333552;3806.276807406584;3810.12367155553;3910.511186101737;58590.70704646492;59373;59808.99999999956;59950.70024649893;60362.39637603656;10371.896281037092;10426.426546540013;10474.947625261824;10786.298890572245;11229.3262404256;18504.537386565175;19889.204431822563;19963.800361996484;20086.899565502077;20127;8342.332613390914;8358.996920369473;8497.405181637227;8509.149085091565;8570.4000719949;4529.886752831139;4541.159885421142;4564.680472366969;4618.145643056046;4654.138984287918;3588.0671025533547;3614.4397618369194;3630.2920930418845;3643.7813731176216;3671;657.9998402428378;660.6498555765452;663.0750103605443;672.0322735261208;683.2586643491768;724.9963750181215;735.2647352647352;739.312439431334;762.9656665450068;776.2276534847863;8948;9215.907840921505;9216.907830921738;9611.759706007406;9650.855237171449;758.4501236603529;759.9962000189963;764.931156195945;769.1234781915707;790.1821614628832;4329;4454;4487.7980490877335;4547.499775024745;4705.1765940960195;68847.3115268851;69658.30341696518;70349;70377.64811175912;70857;54801.725991369785;55381;55640;60495.69752151299;61849.38150618436;55157.724211378685;57038.42961570414;57783;58233;59300.703496483104;9885.258605604753;9952.054554817281;10002.599896004078;10029.10677643684;10060.245481588763;34204.802831900764;36612.45081323729;36946.261074777816;37954.620453795105;38619;49410.258846116616;50820.49179508157;51953.22070169026;52198.73900630624;52550.47449525456;12589.530716595476;12699.42852571655;12851.871481285067;13071.346432678518;13490.527831526242;13733.631746063505;13889.777635578663;13909.374078166304;14108.263013861966;14495.275236237934;12943.741125177632;12995;13339.66650833737;13460.326983650582;13644.454221831016;12353;12509.56216532417;12620;12766.425510851848;13140.540081097115;10751.677449676523;12042.578509752117;12624;13090.214587124803;13296.468141274241;10544.420056896637;10610.257281990187;10795.946020269848;11095.5561777528;11387.032102271069;11309.71725706864;11331.830022549504;11343.20597558163;11464;11588.6523404298 07:19:24 INFO - PROCESS | 11092 | __end_tp_report 07:19:24 INFO - PROCESS | 11092 | __start_cc_report 07:19:24 INFO - PROCESS | 11092 | _x_x_mozilla_cycle_collect,345 07:19:24 INFO - PROCESS | 11092 | __end_cc_report 07:19:24 INFO - PROCESS | 11092 | __startTimestamp1464617964920__endTimestamp 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | ------- Summary: start ------- 07:19:24 INFO - PROCESS | 11092 | Number of tests: 6 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#0] dojo.html Cycles:165 Average:5495.47 Median:5736.43 stddev:645.43 (11.3%) stddev-sans-first:620.31 07:19:24 INFO - PROCESS | 11092 | Values: 3136.4 3207.7 3224.6 3245.6 3248.2 5495.8 5554.2 5560.9 5615.9 5645.2 5335.1 5433.4 5443.6 5527.8 5544.8 4966.2 4997.9 5008.5 5042.9 5148.7 4962.9 5136.0 5136.8 5144.3 5179.4 4983.8 5072.1 5147.1 5147.2 5151.6 5099.9 5102.9 5145.2 5158.8 5166.6 5061.7 5064.1 5074.8 5074.9 5108.0 5300.0 5393.5 5491.4 5510.3 5552.3 5778.8 5785.0 5819.3 5845.3 5855.5 5934.4 5950.6 5951.7 5956.5 5959.9 5465.3 5530.0 5535.2 5545.9 5551.2 6057.9 6060.6 6086.5 6101.6 6108.9 5839.8 5840.9 5846.5 5854.9 5867.7 5688.6 5716.8 5738.6 5799.2 5803.4 5734.1 5769.8 5778.7 5781.2 5794.2 5783.8 5793.4 5799.0 5807.2 5813.9 4325.3 4341.9 4355.0 4382.5 4405.6 3827.3 3901.3 3901.9 3905.0 3945.1 5708.8 5732.3 5736.4 5749.1 5777.5 5746.6 5923.9 5953.3 5991.9 6047.8 5679.0 5683.3 5704.6 5704.9 5766.2 4907.9 4910.0 4913.9 4920.4 4954.4 5813.5 6075.5 6126.9 6142.0 6206.7 5935.5 6025.0 6035.5 6044.8 6070.7 6224.3 6232.9 6245.7 6246.9 6249.6 5630.9 5852.6 5889.5 5926.8 5975.3 5982.1 6008.7 6041.7 6045.8 6082.2 5543.4 5913.6 5928.1 5930.8 5934.0 5726.7 5767.4 5799.8 5837.9 5838.9 5751.2 5753.4 5759.2 5766.1 5784.2 5675.6 5764.8 5882.0 5922.0 5923.4 5530.2 5570.5 5575.5 5677.4 5801.6 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#1] ext.html Cycles:180 Average:62581.94 Median:42739.07 stddev:125274.81 (293.1%) stddev-sans-first:125539.68 07:19:24 INFO - PROCESS | 11092 | Values: 556.9 609.4 621.6 624.2 625.5 38021.2 42375.4 42408.6 42455.8 42462.0 42815.8 43434.3 43456.3 43503.1 43528.0 8339.0 8542.7 8601.9 8616.4 8616.8 8775.8 8842.6 8843.6 8879.5 8887.6 8886.3 8923.3 8931.6 8934.0 8949.6 8837.0 8916.4 8922.6 8924.2 8938.5 8704.7 8740.2 8763.6 8768.6 8782.1 38794.6 39163.0 39294.2 39492.8 39670.0 3675.6 3691.7 3715.7 3921.4 4159.2 32803.3 33053.3 33114.8 33410.7 33860.8 4389.6 4408.9 4423.4 4429.3 4545.9 325967.0 328647.0 329200.0 329834.0 331325.0 58941.4 59025.4 59153.0 59389.0 59437.7 54315.5 59676.7 60529.4 61552.4 62115.4 14065.2 14227.8 14316.8 14320.9 14336.8 11196.2 11363.9 11403.5 11404.9 11426.9 17392.8 17564.6 17578.0 17646.6 17719.7 6407.8 6415.2 6597.2 6605.7 6628.3 972.5 1017.3 1038.8 1073.6 1095.6 31057.5 33410.8 33453.3 33842.2 34091.3 1086.5 1122.3 1124.2 1137.2 1209.6 17080.1 17446.8 17552.0 17562.5 17598.7 550252.0 550282.0 551226.0 551361.0 553014.0 59020.0 59972.7 60202.0 60206.7 60351.7 1358.8 1376.8 1383.5 1395.1 1395.5 31197.5 32798.0 32949.0 33245.2 33247.2 52220.7 52476.0 53020.0 53046.5 53149.7 498369.0 504533.0 506107.0 507481.0 509379.0 44786.8 44887.3 45460.1 45667.0 46212.5 50311.2 50714.5 50908.2 51011.7 51551.7 41427.0 41554.8 42554.0 42560.0 43532.6 41563.8 41773.4 41904.2 41958.4 42473.4 42075.4 42351.4 42662.4 42927.8 43023.4 34688.5 37550.0 37822.0 38240.6 38247.6 27866.6 28650.4 28705.4 28980.0 29043.9 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#2] jquery.html Cycles:180 Average:28933.60 Median:3476.45 stddev:75740.39 (2178.7%) stddev-sans-first:75922.55 07:19:24 INFO - PROCESS | 11092 | Values: 397.4 399.8 403.3 404.4 417.0 13815.8 17846.5 18576.5 19099.6 19362.0 18397.9 18767.9 19035.0 19148.6 19168.2 5523.9 5646.4 5802.5 5803.5 5841.4 5456.3 5683.0 5706.8 5734.5 5749.6 5743.4 5813.1 5831.9 5838.1 5852.1 5899.1 6030.3 6039.9 6067.6 6068.4 5767.9 5801.8 5845.3 6569.1 7079.5 23435.4 25227.4 25467.0 25564.7 26572.9 2464.3 2476.0 2486.2 2558.7 2659.2 15067.0 15991.0 15997.8 16105.1 16379.9 2104.6 2177.7 2178.2 2209.3 2267.5 90596.0 95459.0 97283.0 97588.0 98055.5 16694.4 17656.5 17723.6 17837.6 18176.5 32176.4 32364.7 32395.4 32417.7 32716.5 8929.2 9304.3 9392.2 9423.7 9447.7 7380.2 7441.2 7550.4 7551.7 7762.3 8663.3 8724.6 8765.7 8860.6 9049.4 3232.3 3405.7 3453.9 3499.0 3635.8 959.3 995.1 1061.0 1084.5 1091.9 18113.7 18581.3 19095.8 19139.0 19308.9 954.2 966.3 1000.8 1006.7 1046.3 10463.1 10678.3 10738.4 10747.5 10817.6 416079.0 454357.0 473525.0 475227.0 476788.0 56648.4 59146.7 62079.7 80237.6 90675.0 988.6 991.5 1001.2 1009.0 1013.7 16738.2 16865.9 17026.8 17193.7 17385.4 39807.4 40560.8 40787.6 41394.6 42108.0 54904.5 56583.4 56854.1 56933.0 57843.7 8798.2 8952.6 9001.3 9054.4 9104.5 12625.9 13549.8 13622.3 13624.1 13770.7 11616.0 11784.1 11831.2 11855.6 12046.9 11207.7 11465.5 11831.8 11949.2 12061.8 12374.3 12421.7 12547.5 12608.6 12674.1 8512.3 8671.6 8700.3 8723.7 8873.0 8747.5 10912.8 11552.5 11928.8 12002.2 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#3] mootools.html Cycles:180 Average:6071.23 Median:467.34 stddev:3524.85 (754.2%) stddev-sans-first:3518.21 07:19:24 INFO - PROCESS | 11092 | Values: 1528.8 1568.1 1733.8 1809.7 1867.2 7681.8 8557.4 8917.6 9534.5 9547.6 8734.8 8738.3 8756.3 8832.0 8870.9 2322.7 2328.8 2341.3 2347.2 2353.7 2304.1 2315.5 2352.4 2365.6 2372.3 2339.5 2346.9 2370.1 2372.1 2372.5 2250.5 2286.1 2291.5 2316.1 2319.9 2329.9 2347.3 2348.0 2358.3 2364.5 8817.3 8949.0 8952.8 8973.1 9008.4 5289.4 5342.5 5410.1 5456.5 5472.6 3424.5 3511.9 3535.4 3582.1 3628.8 1128.8 1175.1 1208.8 1214.6 1224.9 12605.2 12637.4 12639.3 12640.9 12684.0 4587.0 4757.9 4765.2 4812.2 4828.6 10622.5 10666.5 10699.7 10704.7 10755.2 5323.0 5355.2 5374.4 5383.8 5387.6 4275.9 4962.4 4969.3 5103.6 5161.9 4107.4 4133.1 4169.4 4221.2 4224.8 1289.3 1297.4 1321.2 1325.4 1338.0 918.3 993.9 1027.2 1029.6 1043.1 6244.0 6304.9 6316.2 6370.3 6400.1 464.1 470.5 471.6 482.3 492.5 4167.7 4394.8 4401.2 4432.3 4448.2 11388.5 11742.6 11895.2 11976.8 12012.6 11738.6 11822.9 11830.2 11839.8 11847.2 8275.8 8603.5 8651.3 8664.7 8792.4 6301.1 6590.2 6594.8 6619.5 6665.7 10908.2 11010.2 11036.9 11066.8 11108.4 10864.2 11217.8 11243.7 11308.0 11386.3 7353.7 8115.3 8355.7 8380.1 8491.1 9208.1 9233.7 9257.0 9308.6 9332.5 7832.5 7926.4 7968.8 7986.4 8345.3 7625.6 7681.3 7731.5 7783.8 7992.7 7135.4 7204.5 7303.7 7382.9 7393.3 5337.7 5417.0 5507.9 5524.7 5644.1 5430.3 5476.7 5537.9 5568.6 5637.1 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#4] prototype.html Cycles:180 Average:4959.46 Median:5697.27 stddev:1479.53 (26.0%) stddev-sans-first:1442.34 07:19:24 INFO - PROCESS | 11092 | Values: 331.8 341.0 345.7 348.2 351.9 5562.2 5589.3 5623.8 5639.6 5679.5 5520.4 5566.1 5572.5 5577.7 5594.3 4126.4 4387.3 4393.9 4401.1 4441.4 4338.4 4341.1 4344.2 4346.2 4365.3 4289.9 4307.2 4310.4 4317.4 4323.7 4327.3 4352.2 4363.0 4367.7 4375.3 3679.9 3765.3 3767.1 3767.3 3780.6 5378.7 5382.8 5388.0 5407.2 5422.3 4924.9 4949.8 4953.1 4979.5 4991.5 5706.4 5829.6 5837.5 5848.6 5848.9 4180.5 4193.5 4224.5 4226.5 4228.7 5958.0 6140.6 6141.0 6202.9 6226.8 4264.4 4299.9 4304.2 4320.6 4334.8 4339.5 4344.6 4353.2 4354.8 4355.1 4955.5 4968.7 4971.1 4972.2 4975.2 5688.1 5848.6 5862.1 5881.7 5939.0 1462.8 1477.3 1479.9 1480.3 1484.0 932.6 952.3 955.8 956.9 978.8 5032.9 5076.6 5589.9 5715.3 5758.3 6096.7 6117.8 6119.7 6144.5 6160.1 5569.4 5749.2 5775.7 5811.6 5815.8 3208.8 3245.3 3253.6 3255.0 3277.2 6303.4 6325.5 6329.0 6330.1 6375.2 5872.7 6171.8 6173.9 6185.8 6231.3 6229.6 6310.7 6341.4 6355.8 6361.0 5938.3 6073.9 6090.1 6093.5 6095.3 5974.9 6050.7 6055.3 6063.4 6108.8 6145.8 6317.5 6351.3 6372.1 6396.3 4247.7 4259.9 4280.7 4285.4 4294.9 6024.3 6103.8 6144.1 6158.4 6167.0 5866.8 5885.3 5981.6 6006.3 6065.0 5878.0 5900.6 5906.8 5920.8 5983.0 5809.7 5845.4 5863.3 5887.0 5893.5 5340.8 5837.5 5868.8 5915.7 5936.3 5718.9 5813.3 5838.2 5842.9 5843.6 07:19:24 INFO - PROCESS | 11092 | 07:19:24 INFO - PROCESS | 11092 | [#5] yui.html Cycles:180 Average:15806.11 Median:4508.84 stddev:19016.06 (421.8%) stddev-sans-first:19035.83 07:19:24 INFO - PROCESS | 11092 | Values: 756.9 808.0 809.6 838.7 854.8 14380.8 14559.1 14676.3 14785.0 14796.7 14083.5 14128.1 14138.1 14155.8 14163.4 799.6 806.1 824.5 825.8 833.3 816.8 822.2 823.1 825.4 825.5 841.3 843.6 849.9 851.4 853.5 837.1 844.5 845.3 847.1 847.5 616.0 623.3 624.4 625.3 627.2 13349.7 13411.4 13464.7 13488.7 13498.7 13506.8 13563.7 13670.7 13751.7 13772.0 10768.6 10777.2 10862.5 10983.0 11236.6 3759.7 3770.8 3806.3 3810.1 3910.5 58590.7 59373.0 59809.0 59950.7 60362.4 10371.9 10426.4 10474.9 10786.3 11229.3 18504.5 19889.2 19963.8 20086.9 20127.0 8342.3 8359.0 8497.4 8509.1 8570.4 4529.9 4541.2 4564.7 4618.1 4654.1 3588.1 3614.4 3630.3 3643.8 3671.0 658.0 660.6 663.1 672.0 683.3 725.0 735.3 739.3 763.0 776.2 8948.0 9215.9 9216.9 9611.8 9650.9 758.5 760.0 764.9 769.1 790.2 4329.0 4454.0 4487.8 4547.5 4705.2 68847.3 69658.3 70349.0 70377.6 70857.0 54801.7 55381.0 55640.0 60495.7 61849.4 55157.7 57038.4 57783.0 58233.0 59300.7 9885.3 9952.1 10002.6 10029.1 10060.2 34204.8 36612.5 36946.3 37954.6 38619.0 49410.3 50820.5 51953.2 52198.7 52550.5 12589.5 12699.4 12851.9 13071.3 13490.5 13733.6 13889.8 13909.4 14108.3 14495.3 12943.7 12995.0 13339.7 13460.3 13644.5 12353.0 12509.6 12620.0 12766.4 13140.5 10751.7 12042.6 12624.0 13090.2 13296.5 10544.4 10610.3 10795.9 11095.6 11387.0 11309.7 11331.8 11343.2 11464.0 11588.7 07:19:24 INFO - PROCESS | 11092 | -------- Summary: end -------- 07:19:24 INFO - PROCESS | 11092 | 07:19:25 INFO - TEST-INFO | 11092: exit 0 07:19:25 INFO - TEST-OK | dromaeo_css | took 1111894ms 07:19:25 INFO - TEST-START | kraken 07:19:25 INFO - operating with platform_type : linux_ 07:19:25 INFO - Initialising browser for kraken test... 07:19:25 INFO - TEST-INFO | started process 11324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKx5t4m/profile http://localhost:34265/getInfo.html) 07:19:30 INFO - PROCESS | 11324 | __metrics Screen width/height:1600/1200 07:19:30 INFO - PROCESS | 11324 | colorDepth:24 07:19:30 INFO - PROCESS | 11324 | Browser inner width/height: 1024/697 07:19:30 INFO - PROCESS | 11324 | __metrics 07:19:30 ERROR - PROCESS | 11324 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:19:31 INFO - TEST-INFO | 11324: exit 0 07:19:31 INFO - Browser initialized. 07:19:31 INFO - Running cycle 1/1 for kraken test... 07:19:31 INFO - TEST-INFO | started process 11447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKx5t4m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:43 INFO - PROCESS | 11447 | RSS: Main: 167059456 07:19:43 INFO - PROCESS | 11447 | 07:19:46 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:46 INFO - PROCESS | 11447 | RSS: Main: 172396544 07:19:46 INFO - PROCESS | 11447 | 07:19:49 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-dft) 07:19:50 INFO - PROCESS | 11447 | RSS: Main: 171933696 07:19:50 INFO - PROCESS | 11447 | 07:19:53 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-fft) 07:19:53 INFO - PROCESS | 11447 | RSS: Main: 166510592 07:19:53 INFO - PROCESS | 11447 | 07:19:56 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-oscillator) 07:19:56 INFO - PROCESS | 11447 | RSS: Main: 166866944 07:19:56 INFO - PROCESS | 11447 | 07:19:58 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:59 INFO - PROCESS | 11447 | RSS: Main: 167198720 07:19:59 INFO - PROCESS | 11447 | 07:20:02 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:03 INFO - PROCESS | 11447 | RSS: Main: 167743488 07:20:03 INFO - PROCESS | 11447 | 07:20:06 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:07 INFO - PROCESS | 11447 | RSS: Main: 165396480 07:20:07 INFO - PROCESS | 11447 | 07:20:10 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34265/tests/kraken/driver.html?testName=json-parse-financial) 07:20:10 INFO - PROCESS | 11447 | RSS: Main: 166764544 07:20:10 INFO - PROCESS | 11447 | 07:20:12 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:12 INFO - PROCESS | 11447 | RSS: Main: 167452672 07:20:12 INFO - PROCESS | 11447 | 07:20:14 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:15 INFO - PROCESS | 11447 | RSS: Main: 167956480 07:20:15 INFO - PROCESS | 11447 | 07:20:17 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:18 INFO - PROCESS | 11447 | RSS: Main: 168079360 07:20:18 INFO - PROCESS | 11447 | 07:20:20 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:21 INFO - PROCESS | 11447 | RSS: Main: 168243200 07:20:21 INFO - PROCESS | 11447 | 07:20:24 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:24 INFO - PROCESS | 11447 | RSS: Main: 167735296 07:20:24 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34265/tests/kraken/driver.html?testName=ai-astar) 07:20:26 INFO - PROCESS | 11447 | RSS: Main: 168587264 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | __start_tp_report 07:20:26 INFO - PROCESS | 11447 | _x_x_mozilla_page_load 07:20:26 INFO - PROCESS | 11447 | _x_x_mozilla_page_load_details 07:20:26 INFO - PROCESS | 11447 | |i|pagename|runs| 07:20:26 INFO - PROCESS | 11447 | |0;ai-astar;113;106;111;112;113;115;111;111;111;111 07:20:26 INFO - PROCESS | 11447 | |1;audio-beat-detection;176;125;162;176;126;157;151;127;196;133 07:20:26 INFO - PROCESS | 11447 | |2;audio-dft;162;169;162;163;165;168;167;161;161;163 07:20:26 INFO - PROCESS | 11447 | |3;audio-fft;75;76;81;154;76;75;74;76;171;74 07:20:26 INFO - PROCESS | 11447 | |4;audio-oscillator;84;83;149;83;83;83;137;83;84;139 07:20:26 INFO - PROCESS | 11447 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;118;118;118 07:20:26 INFO - PROCESS | 11447 | |6;imaging-darkroom;147;147;147;148;146;146;146;146;146;146 07:20:26 INFO - PROCESS | 11447 | |7;imaging-desaturate;97;96;95;95;95;95;95;95;95;95 07:20:26 INFO - PROCESS | 11447 | |8;json-parse-financial;55;54;55;54;54;57;53;54;54;58 07:20:26 INFO - PROCESS | 11447 | |9;json-stringify-tinderbox;63;63;62;63;62;61;62;61;64;62 07:20:26 INFO - PROCESS | 11447 | |10;stanford-crypto-aes;87;81;81;86;82;84;86;80;113;83 07:20:26 INFO - PROCESS | 11447 | |11;stanford-crypto-ccm;133;132;135;127;129;126;134;124;140;124 07:20:26 INFO - PROCESS | 11447 | |12;stanford-crypto-pbkdf2;170;170;163;164;160;163;167;170;162;159 07:20:26 INFO - PROCESS | 11447 | |13;stanford-crypto-sha256-iterative;63;65;65;65;63;63;63;68;68;62 07:20:26 INFO - PROCESS | 11447 | __end_tp_report 07:20:26 INFO - PROCESS | 11447 | __start_cc_report 07:20:26 INFO - PROCESS | 11447 | _x_x_mozilla_cycle_collect,887 07:20:26 INFO - PROCESS | 11447 | __end_cc_report 07:20:26 INFO - PROCESS | 11447 | __startTimestamp1464618026688__endTimestamp 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | ------- Summary: start ------- 07:20:26 INFO - PROCESS | 11447 | Number of tests: 14 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:2.32 (2.1%) stddev-sans-first:2.39 07:20:26 INFO - PROCESS | 11447 | Values: 113.0 106.0 111.0 112.0 113.0 115.0 111.0 111.0 111.0 111.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:159.50 stddev:24.94 (15.6%) stddev-sans-first:25.01 07:20:26 INFO - PROCESS | 11447 | Values: 176.0 125.0 162.0 176.0 126.0 157.0 151.0 127.0 196.0 133.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.96 (1.8%) stddev-sans-first:3.04 07:20:26 INFO - PROCESS | 11447 | Values: 162.0 169.0 162.0 163.0 165.0 168.0 167.0 161.0 161.0 163.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:36.80 (48.7%) stddev-sans-first:38.43 07:20:26 INFO - PROCESS | 11447 | Values: 75.0 76.0 81.0 154.0 76.0 75.0 74.0 76.0 171.0 74.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:83.00 stddev:28.37 (34.2%) stddev-sans-first:29.43 07:20:26 INFO - PROCESS | 11447 | Values: 84.0 83.0 149.0 83.0 83.0 83.0 137.0 83.0 84.0 139.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:20:26 INFO - PROCESS | 11447 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:20:26 INFO - PROCESS | 11447 | Values: 147.0 147.0 147.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.33 07:20:26 INFO - PROCESS | 11447 | Values: 97.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.64 07:20:26 INFO - PROCESS | 11447 | Values: 55.0 54.0 55.0 54.0 54.0 57.0 53.0 54.0 54.0 58.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 07:20:26 INFO - PROCESS | 11447 | Values: 63.0 63.0 62.0 63.0 62.0 61.0 62.0 61.0 64.0 62.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:83.50 stddev:9.68 (11.6%) stddev-sans-first:10.27 07:20:26 INFO - PROCESS | 11447 | Values: 87.0 81.0 81.0 86.0 82.0 84.0 86.0 80.0 113.0 83.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:132.50 stddev:5.27 (4.0%) stddev-sans-first:5.51 07:20:26 INFO - PROCESS | 11447 | Values: 133.0 132.0 135.0 127.0 129.0 126.0 134.0 124.0 140.0 124.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:4.18 (2.5%) stddev-sans-first:3.99 07:20:26 INFO - PROCESS | 11447 | Values: 170.0 170.0 163.0 164.0 160.0 163.0 167.0 170.0 162.0 159.0 07:20:26 INFO - PROCESS | 11447 | 07:20:26 INFO - PROCESS | 11447 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:2.12 (3.3%) stddev-sans-first:2.18 07:20:26 INFO - PROCESS | 11447 | Values: 63.0 65.0 65.0 65.0 63.0 63.0 63.0 68.0 68.0 62.0 07:20:26 INFO - PROCESS | 11447 | -------- Summary: end -------- 07:20:26 INFO - PROCESS | 11447 | 07:20:27 INFO - TEST-INFO | 11447: exit 0 07:20:27 INFO - TEST-OK | kraken | took 62027ms 07:20:27 INFO - SUITE-END | took 1173s 07:20:27 INFO - Completed test suite (00:19:34) 07:20:27 INFO - javascript benchmark 07:20:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7415.809724488623, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.357046805405, 3207.711305982464, 3224.5969253843264, 3245.594300712411, 3248.2366643838695, 5495.780168793243, 5554.1668749687515, 5560.888782224353, 5615.9157612635845, 5645.15322701595, 5335.1197052486295, 5433.402325744175, 5443.564514838813, 5527.751251193696, 5544.805931792388, 4966.230234313678, 4997.900041999158, 5008.549230569248, 5042.924356134661, 5148.665336753118, 4962.851114466554, 5135.9743201283945, 5136.845894623168, 5144.279800827887, 5179.378474583036, 4983.775730092155, 5072.112380333427, 5147.099257629919, 5147.150720131192, 5151.613628977823, 5099.898002039976, 5102.897942041139, 5145.151050076733, 5158.7678554464765, 5166.638335316529, 5061.721605311706, 5064.088464076464, 5074.771635276385, 5074.873128171788, 5107.9744601277125, 5300.0459917214885, 5393.514583687448, 5491.423400542965, 5510.338759348863, 5552.250446189753, 5778.797742079049, 5785.045467497858, 5819.301683797971, 5845.298564172326, 5855.473007429352, 5934.436228558323, 5950.553708471839, 5951.6726580038085, 5956.52347812174, 5959.910601340984, 5465.344158700942, 5530.0, 5535.225068490415, 5545.916811247835, 5551.167324901297, 6057.878842423127, 6060.606060606046, 6086.452219300196, 6101.60339577926, 6108.908366374508, 5839.766409343663, 5840.853978650568, 5846.503047241032, 5854.941450585439, 5867.677277749679, 5688.573356998241, 5716.771329146871, 5738.626989245686, 5799.159121927297, 5803.419658034247, 5734.082546792577, 5769.798057068067, 5778.653280803165, 5781.248437703156, 5794.159846822187, 5783.768649253982, 5793.449622285876, 5799.0, 5807.245058142415, 5813.941860581424, 4325.286327755885, 4341.891452713708, 4354.9782251088545, 4382.539833317455, 4405.603495685404, 3827.27281816454, 3901.258760835489, 3901.902452438712, 3904.980475097663, 3945.0926286954164, 5708.771649134072, 5732.3407808101765, 5736.426357364314, 5749.13762935563, 5777.480026797609, 5746.597738158289, 5923.851903702442, 5953.255843019622, 5991.910121348184, 6047.758089676452, 5679.0, 5683.346415162227, 5704.629199102045, 5704.885902282014, 5766.163906233573, 4907.852764417074, 4909.975450122798, 4913.87715307113, 4920.434150072788, 4954.355933728592, 5813.5349172066135, 6075.513958883367, 6126.9452004266695, 6141.977005061692, 6206.689665516707, 5935.495482884004, 6024.969875150597, 6035.547333949883, 6044.818655440344, 6070.666113363719, 6224.2842073160355, 6232.937670623236, 6245.68771561411, 6246.906296405648, 6249.625022498664, 5630.887382252414, 5852.619579727304, 5889.528837692888, 5926.762929482772, 5975.312839023568, 5982.102684597346, 6008.699565021644, 6041.728122234422, 6045.758169673164, 6082.239720034996, 5543.417941116125, 5913.615614985184, 5928.051511758271, 5930.8056019273145, 5933.970330148321, 5726.74229659658, 5767.365589785037, 5799.797007104899, 5837.912431313449, 5838.912416313674, 5751.166080918327, 5753.367129615655, 5759.164921086335, 5766.135079738073, 5784.190213370048, 5675.631083979528, 5764.798232061858, 5882.0, 5922.022866227025, 5923.378045305181, 5530.198121272312, 5570.470805273492, 5575.470330318613, 5677.432256774455, 5801.5938884279385], "value": 5450.488844947307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8524341049623, 609.4058293164165, 621.64255553057, 624.241546520977, 625.4589779840438, 38021.239575208514, 42375.36436953448, 42408.57591424085, 42455.78772106143, 42462.0, 42815.78592107043, 43434.34848477275, 43456.348154777705, 43503.12993740123, 43527.99999999992, 8338.95830520848, 8542.74371768848, 8601.913980860205, 8616.396852220347, 8616.784580385478, 8775.780605484882, 8842.602082906253, 8843.646254149826, 8879.467231966071, 8887.600057997406, 8886.333524985652, 8923.330750193729, 8931.598078086468, 8934.0, 8949.552522373888, 8836.983746869128, 8916.375853690277, 8922.598483068245, 8924.152205540528, 8938.508382038985, 8704.651813927436, 8740.169683880022, 8763.561821908943, 8768.605412756442, 8782.12178782123, 38794.612053879384, 39163.0, 39294.21411571753, 39492.80253598742, 39670.0, 3675.5956844747056, 3691.741578089535, 3715.6841668458214, 3921.392184211452, 4159.188958153161, 32803.3032585932, 33053.3389332212, 33114.834425827714, 33410.665893341, 33860.830695846365, 4389.648828093745, 4408.915696339063, 4423.358613001129, 4429.291313389842, 4545.931811022837, 325967.0, 328647.0, 329200.0, 329834.0, 331325.0, 58941.410585893595, 59025.40974590199, 59153.0, 59389.0, 59437.702811485666, 54315.45684543183, 59676.70161649164, 60529.39470605326, 61552.384476154664, 62115.37884621186, 14065.156090634595, 14227.78658320126, 14316.785248221286, 14320.928395358165, 14336.784948225784, 11196.160287978435, 11363.886361136283, 11403.486843092081, 11404.94297528507, 11426.942865285786, 17392.82607173912, 17564.5608859777, 17578.0, 17646.558836028944, 17719.73420398695, 6407.807765767035, 6415.1981002374705, 6597.208334999831, 6605.735770569219, 6628.27089020217, 972.4554249620236, 1017.2777328097134, 1038.776663017455, 1073.6295977887617, 1095.5836782022939, 31057.534136987964, 33410.832945835115, 33453.33093338168, 33842.15394615105, 34091.318173636886, 1086.5327908999047, 1122.2985633978763, 1124.2355198465123, 1137.1641843245209, 1209.5887398284626, 17080.145992700316, 17446.825531744773, 17552.03463809477, 17562.50718688926, 17598.736018959728, 550252.0, 550282.0, 551226.0, 551361.0, 553014.0, 59020.0, 59972.70013649991, 60202.0, 60206.69896650489, 60351.69824150939, 1358.8369395672582, 1376.7521846067605, 1383.5019393018506, 1395.0931894268604, 1395.4766962389103, 31197.53203701901, 32798.0, 32949.0, 33245.16887077843, 33247.168820779676, 52220.73889630527, 52476.0, 53020.0, 53046.469535305696, 53149.7342513285, 498369.0, 504533.0, 506107.0, 507481.0, 509379.0, 44786.77606611946, 44887.32669010033, 45460.090798184516, 45667.0, 46212.53787462082, 50311.245331319325, 50714.49285507245, 50908.23637645364, 51011.74494127654, 51551.742241290056, 41427.0, 41554.79222603868, 42554.0, 42560.0, 43532.56467435285, 41563.7921810389, 41773.37339939843, 41904.1619167621, 41958.370624440046, 42473.36289955591, 42075.36886946637, 42351.36472952847, 42662.36006459968, 42927.785361072994, 43023.354649679655, 34688.479672805435, 37550.0, 37822.0, 38240.61759382482, 38247.61752382552, 27866.58200126959, 28650.426991459637, 28705.425891481635, 28980.0, 29043.85478072596], "value": 20402.790073564174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3582663997645, 399.7521536647279, 403.2640431213037, 404.41360027959456, 416.9630859220615, 13815.792763108562, 17846.46460606182, 18576.535586610342, 19099.618007639856, 19362.0, 18397.896126232434, 18767.906160469178, 19035.0, 19148.61702765944, 19168.233270669156, 5523.889522209553, 5646.435356464362, 5802.477777000069, 5803.491092315986, 5841.386654401291, 5456.263404440409, 5682.971585142069, 5706.80026199081, 5734.483896449318, 5749.59752817303, 5743.425657434265, 5813.06990881459, 5831.883362332751, 5838.065909454488, 5852.063669812831, 5899.115132730103, 6030.306514750816, 6039.8792024159275, 6067.635941843503, 6068.393160683919, 5767.855803604902, 5801.82594522165, 5845.298564172284, 6569.146011018584, 7079.469039822034, 23435.4141146471, 25227.369315767068, 25467.0, 25564.744352556423, 26572.86713566439, 2464.297675162588, 2475.962860557093, 2486.2292689266387, 2558.7057488388887, 2659.2155314182364, 15067.0, 15991.0, 15997.760033599505, 16105.114218717967, 16379.918100409423, 2104.6422108241636, 2177.716896803421, 2178.1505212966954, 2209.3371988403414, 2267.5464907018495, 90596.0, 95459.0, 97283.0271697281, 97588.0241197586, 98055.50972245094, 16694.4156954506, 17656.470305890845, 17723.556911077325, 17837.554061148316, 18176.45470635883, 32176.35647287041, 32364.676353236166, 32395.352092958008, 32417.675823241938, 32716.509252361233, 8929.24101451371, 9304.255659547356, 9392.201662858733, 9423.717288481357, 9447.677325174482, 7380.151282602569, 7441.181470038291, 7550.433717471212, 7551.660175292125, 7762.262585054411, 8663.306935445149, 8724.607392667345, 8765.737027889174, 8860.556972151368, 9049.411788233876, 3232.337370838972, 3405.7275417966503, 3453.8618455262013, 3499.0460779319715, 3635.8000309983204, 959.3236768078488, 995.0646392391274, 1061.0026575019458, 1084.4740300954031, 1091.9235653504338, 18113.728294075598, 18581.25674973013, 19095.80904190968, 19139.0, 19308.903455482632, 954.1651055326589, 966.2656381150376, 1000.7698229407132, 1006.6728313298207, 1046.283295942282, 10463.05832475081, 10678.305910115818, 10738.409387483764, 10747.462626868626, 10817.621383251548, 416079.0, 454357.0, 473525.0, 475227.0, 476788.0, 56648.433515664314, 59146.704266478395, 62079.689601551705, 80237.59881200673, 90675.0, 988.649029594498, 991.5028307255951, 1001.1840350114634, 1009.0464511037, 1013.7212266626736, 16738.246778894736, 16865.91567042206, 17026.829731702524, 17193.656126877144, 17385.391511297043, 39807.40288895611, 40560.79719601501, 40787.59212407838, 41394.58605413907, 42108.0, 54904.450955489934, 56583.43416565946, 56854.14718779139, 56933.0, 57843.71078144582, 8798.208161265517, 8952.597133128895, 9001.32490063261, 9054.366194366594, 9104.544772761468, 12625.936870315589, 13549.796753048515, 13622.318884055956, 13624.114432562248, 13770.65573360674, 11616.012638925447, 11784.116191285859, 11831.230969986924, 11855.644330670093, 12046.879531204575, 11207.71980700489, 11465.541378344773, 11831.82252266234, 11949.163558550817, 12061.75876482483, 12374.319412432042, 12421.689457763267, 12547.49810007626, 12608.558700445441, 12674.112812103065, 8512.319014478951, 8671.578432790939, 8700.303975682056, 8723.651053958025, 8872.955635221782, 8747.518886461306, 10912.836307455553, 11552.480138393961, 11928.821067683819, 12002.1598488105], "value": 10076.614011706652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.793612862264, 1568.0826716370923, 1733.8352856478639, 1809.7013992691207, 1867.225101582844, 7681.846363072736, 8557.400981931267, 8917.598708058136, 9534.475603841785, 9547.57035933383, 8734.781630459225, 8738.300935925126, 8756.255718263956, 8831.955840220806, 8870.911290887088, 2322.6980492535945, 2328.7671232876746, 2341.274204996457, 2347.2019513365453, 2353.7410884802657, 2304.1129165271323, 2315.4674424882287, 2352.3883790214495, 2365.6096744037213, 2372.3120295114395, 2339.4619237575366, 2346.8709220992837, 2370.087516306226, 2372.146027430124, 2372.54921564903, 2250.459889626478, 2286.1084177170915, 2291.5416916616578, 2316.1198744477074, 2319.895604697793, 2329.918452854142, 2347.319277409549, 2347.9882600587057, 2358.268936629633, 2364.47981444082, 8817.338699597556, 8949.0, 8952.776180595538, 8973.057828927998, 9008.369414141012, 5289.365276166846, 5342.519173274424, 5410.1343784994215, 5456.508914197741, 5472.644278121909, 3424.520567120605, 3511.8595256189724, 3535.4166562517153, 3582.140286331262, 3628.7641303315463, 1128.7629597784476, 1175.142146233246, 1208.800547909594, 1214.6416807041944, 1224.9142560020803, 12605.243685378815, 12637.43131559082, 12639.304838233893, 12640.873591264153, 12684.048696347718, 4587.0, 4757.9286310705365, 4765.1660959331975, 4812.181929072066, 4828.637852161102, 10622.521986510626, 10666.520006599721, 10699.679009629723, 10704.678859634223, 10755.247132700792, 5323.041852466593, 5355.169948657965, 5374.381946076173, 5383.838484845461, 5387.568994480433, 4275.931017245689, 4962.429320628102, 4969.279454479152, 5103.617228707862, 5161.948380516147, 4107.404426358161, 4133.090720041646, 4169.374593810952, 4221.197972385237, 4224.809883555247, 1289.3295486347047, 1297.4291311822767, 1321.1610627251573, 1325.357201757147, 1338.036613638179, 918.2837386838277, 993.941452353256, 1027.2398425165472, 1029.629333439961, 1043.087298613713, 6243.96878015607, 6304.905426418607, 6316.178896743394, 6370.267419246846, 6400.135981642512, 464.13902211397374, 470.5318208382681, 471.61092099018447, 482.31511254018676, 492.50257240186954, 4167.666586673059, 4394.758288294174, 4401.163778882003, 4432.268675668479, 4448.221561226773, 11388.487518061707, 11742.58900938463, 11895.167338286237, 11976.820347694616, 12012.639620811215, 11738.58914937973, 11822.940885295691, 11830.17188796776, 11839.763204735857, 11847.170698051053, 8275.793105172419, 8603.526806025604, 8651.307895368356, 8664.653413863502, 8792.42849214799, 6301.117843501822, 6590.176227971504, 6594.802155935329, 6619.470442364695, 6665.66671666405, 10908.236423450282, 11010.174236932102, 11036.944815275872, 11066.778664426827, 11108.44457777124, 10864.239503234698, 11217.831732524182, 11243.718907027063, 11308.0, 11386.259893107253, 7353.742619008309, 8115.310198632947, 8355.707550235713, 8380.12008739098, 8491.065982742017, 9208.079192080739, 9233.722988310361, 9257.0, 9308.627654893728, 9332.533373331442, 7832.4517283791865, 7926.405519585939, 7968.84062318762, 7986.440949133737, 8345.33237340999, 7625.580593067212, 7681.270279323456, 7731.536107833548, 7783.844323113392, 7992.6802927884555, 7135.393491553276, 7204.495685302189, 7303.707851685873, 7382.9261707384385, 7393.334599886036, 5337.6797392156595, 5417.024935511646, 5507.944920550904, 5524.66851988882, 5644.0687286598895, 5430.266913966564, 5476.726163691879, 5537.861553461195, 5568.55451563882, 5637.069883469346], "value": 4750.463961249911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.7928664533713, 341.00086745834705, 345.74587678056633, 348.23214811340995, 351.9155402703352, 5562.249096371994, 5589.329280486342, 5623.7908849597325, 5639.577031722627, 5679.488846003859, 5520.420355862637, 5566.137248726453, 5572.498475137247, 5577.665340079598, 5594.272744543204, 4126.401671757593, 4387.276099443596, 4393.912121757563, 4401.05377343871, 4441.444819397575, 4338.392625032498, 4341.066670665807, 4344.239758042346, 4346.195953748551, 4365.345198220277, 4289.892752681192, 4307.160103779748, 4310.353446982962, 4317.395564620955, 4323.675724320673, 4327.2954403497815, 4352.194843953863, 4362.952891306096, 4367.737935723835, 4375.309184851293, 3679.9264014719824, 3765.3410653135593, 3767.1335592813807, 3767.3407153747985, 3780.6030366811365, 5378.709109813655, 5382.811601593926, 5388.0, 5407.215953686693, 5422.295101636762, 4924.926126108111, 4949.8020079196785, 4953.1332016896895, 4979.45226025137, 4991.4758950310425, 5706.400827913092, 5829.5919285650025, 5837.532997360201, 5848.649081055108, 5848.912266316009, 4180.47744031996, 4193.454850869398, 4224.514180869178, 4226.5418430641375, 4228.703990720651, 5958.020989505248, 6140.570160088796, 6140.969295153541, 6202.875942481125, 6226.844328891769, 4264.402983582301, 4299.871003869889, 4304.225239456928, 4320.638998715394, 4334.8266069357505, 4339.500957389878, 4344.6089851913475, 4353.172897149531, 4354.82419746673, 4355.128974205171, 4955.4796746341835, 4968.701877887338, 4971.130052240844, 4972.229304457815, 4975.203967365204, 5688.146777983336, 5848.590598658138, 5862.14998825168, 5881.735321910439, 5939.0, 1462.795208670787, 1477.2909003678294, 1479.88900832438, 1480.3486465954945, 1483.9851601483847, 932.5616960028775, 952.2667545989549, 955.7610597350663, 956.9330196830484, 978.7993461340408, 5032.943081952831, 5076.619253555924, 5589.860253493695, 5715.342550660262, 5758.337791153987, 6096.658735078276, 6117.84705382369, 6119.663418511936, 6144.539159563051, 6160.1375807387, 5569.387367389584, 5749.195112684228, 5775.711214439261, 5811.564132690065, 5815.76736930518, 3208.812739286479, 3245.2860370718877, 3253.6095668519456, 3254.9674503255137, 3277.1807048237943, 6303.401176888188, 6325.493960483151, 6329.0, 6330.100969709161, 6375.171227740364, 5872.706364681749, 6171.814845554641, 6173.9073913891325, 6185.84535386619, 6231.345708700612, 6229.626222426669, 6310.652914089677, 6341.397567231105, 6355.822088955522, 6361.01404282337, 5938.257717785277, 6073.906696794619, 6090.086487026982, 6093.512518998381, 6095.299040610209, 5974.880502390015, 6050.7277172526465, 6055.303640081447, 6063.423974722395, 6108.75564977396, 6145.787516493969, 6317.4630156437215, 6351.301356850835, 6372.139761132188, 6396.328385519453, 4247.683218202367, 4259.893502662334, 4280.7157852644705, 4285.4000439939055, 4294.871153865389, 6024.337322894566, 6103.786367477117, 6144.139820425234, 6158.414950579688, 6167.0, 5866.765329386947, 5885.293764748258, 5981.611195272293, 6006.279246490449, 6064.969675151596, 5877.971355012941, 5900.586958912835, 5906.763729450774, 5920.822375328747, 5983.0, 5809.738561764815, 5845.41545845412, 5863.296404431496, 5886.970565147318, 5893.499052580579, 5340.813071542478, 5837.474627283565, 5868.794592189253, 5915.704214789157, 5936.317323507679, 5718.885622287614, 5813.273340832396, 5838.190161050088, 5842.912356314744, 5843.561732869966], "value": 4481.9413431674875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.912955010174, 808.0465051239535, 809.5506993618542, 838.7399906029132, 854.786303424144, 14380.784288235685, 14559.053661512007, 14676.339564719587, 14785.0, 14796.704065918688, 14083.507077252298, 14128.081674691139, 14138.081024733385, 14155.796757275644, 14163.362648680833, 799.596203917024, 806.105223202245, 824.5135370131621, 825.8224481736426, 833.3458235285302, 816.824382757707, 822.235321151329, 823.0904850140598, 825.4345773145385, 825.5046971816922, 841.3017195727562, 843.6035063520167, 849.8810166576684, 851.3912552524944, 853.4751128056232, 837.0708513549955, 844.5059640110543, 845.2646197807885, 847.1486156412827, 847.546562589012, 615.9507239420835, 623.3392603839944, 624.4473640827855, 625.3402660193494, 627.1533429869639, 13349.66625834362, 13411.396487158101, 13464.730705385837, 13488.730225395535, 13498.662533436644, 13506.797398039038, 13563.660908477268, 13670.658233544242, 13751.724965500734, 13771.98547372733, 10768.569257229701, 10777.191710621657, 10862.45687715619, 10983.011528962432, 11236.550537978472, 3759.6992240620957, 3770.8491660333552, 3806.276807406584, 3810.12367155553, 3910.511186101737, 58590.70704646492, 59373.0, 59808.99999999956, 59950.70024649893, 60362.39637603656, 10371.896281037092, 10426.426546540013, 10474.947625261824, 10786.298890572245, 11229.3262404256, 18504.537386565175, 19889.204431822563, 19963.800361996484, 20086.899565502077, 20127.0, 8342.332613390914, 8358.996920369473, 8497.405181637227, 8509.149085091565, 8570.4000719949, 4529.886752831139, 4541.159885421142, 4564.680472366969, 4618.145643056046, 4654.138984287918, 3588.0671025533547, 3614.4397618369194, 3630.2920930418845, 3643.7813731176216, 3671.0, 657.9998402428378, 660.6498555765452, 663.0750103605443, 672.0322735261208, 683.2586643491768, 724.9963750181215, 735.2647352647352, 739.312439431334, 762.9656665450068, 776.2276534847863, 8948.0, 9215.907840921505, 9216.907830921738, 9611.759706007406, 9650.855237171449, 758.4501236603529, 759.9962000189963, 764.931156195945, 769.1234781915707, 790.1821614628832, 4329.0, 4454.0, 4487.7980490877335, 4547.499775024745, 4705.1765940960195, 68847.3115268851, 69658.30341696518, 70349.0, 70377.64811175912, 70857.0, 54801.725991369785, 55381.0, 55640.0, 60495.69752151299, 61849.38150618436, 55157.724211378685, 57038.42961570414, 57783.0, 58233.0, 59300.703496483104, 9885.258605604753, 9952.054554817281, 10002.599896004078, 10029.10677643684, 10060.245481588763, 34204.802831900764, 36612.45081323729, 36946.261074777816, 37954.620453795105, 38619.0, 49410.258846116616, 50820.49179508157, 51953.22070169026, 52198.73900630624, 52550.47449525456, 12589.530716595476, 12699.42852571655, 12851.871481285067, 13071.346432678518, 13490.527831526242, 13733.631746063505, 13889.777635578663, 13909.374078166304, 14108.263013861966, 14495.275236237934, 12943.741125177632, 12995.0, 13339.66650833737, 13460.326983650582, 13644.454221831016, 12353.0, 12509.56216532417, 12620.0, 12766.425510851848, 13140.540081097115, 10751.677449676523, 12042.578509752117, 12624.0, 13090.214587124803, 13296.468141274241, 10544.420056896637, 10610.257281990187, 10795.946020269848, 11095.5561777528, 11387.032102271069, 11309.71725706864, 11331.830022549504, 11343.20597558163, 11464.0, 11588.6523404298], "value": 6970.538569601843, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 112.0, 113.0, 115.0, 111.0, 111.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 125.0, 162.0, 176.0, 126.0, 157.0, 151.0, 127.0, 196.0, 133.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 162.0, 163.0, 165.0, 168.0, 167.0, 161.0, 161.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 81.0, 154.0, 76.0, 75.0, 74.0, 76.0, 171.0, 74.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 149.0, 83.0, 83.0, 83.0, 137.0, 83.0, 84.0, 139.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 57.0, 53.0, 54.0, 54.0, 58.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 62.0, 61.0, 62.0, 61.0, 64.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 81.0, 86.0, 82.0, 84.0, 86.0, 80.0, 113.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 135.0, 127.0, 129.0, 126.0, 134.0, 124.0, 140.0, 124.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 163.0, 164.0, 160.0, 163.0, 167.0, 170.0, 162.0, 159.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 65.0, 63.0, 63.0, 63.0, 68.0, 68.0, 62.0], "value": 64.5, "unit": "score"}]}]} 07:20:27 INFO - Return code: 0 07:20:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:20:27 ERROR - # TBPL SUCCESS # 07:20:27 INFO - Running post-action listener: _resource_record_post_action 07:20:27 INFO - ##### 07:20:27 INFO - ##### Finished run-tests step (success) 07:20:27 INFO - ##### 07:20:27 INFO - Running post-run listener: _resource_record_post_run 07:20:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538935296; Read time: 16; Write time: 809216 07:20:28 INFO - TinderboxPrint: CPU usage
13.5% 07:20:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:20:28 INFO - TinderboxPrint: I/O write bytes / time
538,935,296 / 809,216 07:20:28 INFO - TinderboxPrint: CPU idle
8,228.2 (86.5%) 07:20:28 INFO - TinderboxPrint: CPU user
1,222.8 (12.9%) 07:20:28 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:28 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 247341056; Read time: 0; Write time: 456516 07:20:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291594240; Read time: 16; Write time: 352700 07:20:28 INFO - Running post-run listener: _upload_blobber_files 07:20:28 INFO - Blob upload gear active. 07:20:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:28 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:28 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:28 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:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:29 INFO - (blobuploader) - INFO - Done attempting. 07:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:30 INFO - (blobuploader) - INFO - Done attempting. 07:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:36 INFO - (blobuploader) - INFO - Done attempting. 07:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:36 INFO - Return code: 0 07:20:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efba42f1c4c5fa82bcd27e6a88f35f2c080ebcf447af4e58be51dc7d13706d8037a1342dbd4db6c3c888ba72496b739bc22a7e6c7379764fe02e7f5cd0c4c565", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be9459cf33b47e7fcf71f0fbad48b85bf9ecf9f004cbe2cdaf6c8ae1631a14df133a28a08f20d472b3af28712aeaa9e780bc50348dfa008850de6033049f82d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e2a166c5b442b0fec01684cfa71d817a292d51e4555b80381149da91a54f58511e4859f195e6527d08b5b9d57efa3ac6637602d53353147d59d87bbeccbade"} 07:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:36 INFO - Contents: 07:20:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efba42f1c4c5fa82bcd27e6a88f35f2c080ebcf447af4e58be51dc7d13706d8037a1342dbd4db6c3c888ba72496b739bc22a7e6c7379764fe02e7f5cd0c4c565", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be9459cf33b47e7fcf71f0fbad48b85bf9ecf9f004cbe2cdaf6c8ae1631a14df133a28a08f20d472b3af28712aeaa9e780bc50348dfa008850de6033049f82d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e2a166c5b442b0fec01684cfa71d817a292d51e4555b80381149da91a54f58511e4859f195e6527d08b5b9d57efa3ac6637602d53353147d59d87bbeccbade"} 07:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:36 INFO - Copying logs to upload dir... 07:20:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.618655 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 07:20:36.031941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 07:20:36.035146) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 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/efba42f1c4c5fa82bcd27e6a88f35f2c080ebcf447af4e58be51dc7d13706d8037a1342dbd4db6c3c888ba72496b739bc22a7e6c7379764fe02e7f5cd0c4c565", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be9459cf33b47e7fcf71f0fbad48b85bf9ecf9f004cbe2cdaf6c8ae1631a14df133a28a08f20d472b3af28712aeaa9e780bc50348dfa008850de6033049f82d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e2a166c5b442b0fec01684cfa71d817a292d51e4555b80381149da91a54f58511e4859f195e6527d08b5b9d57efa3ac6637602d53353147d59d87bbeccbade"} build_url:https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/eQvV0RzDQLCYebDHOY3wog/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efba42f1c4c5fa82bcd27e6a88f35f2c080ebcf447af4e58be51dc7d13706d8037a1342dbd4db6c3c888ba72496b739bc22a7e6c7379764fe02e7f5cd0c4c565", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be9459cf33b47e7fcf71f0fbad48b85bf9ecf9f004cbe2cdaf6c8ae1631a14df133a28a08f20d472b3af28712aeaa9e780bc50348dfa008850de6033049f82d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e2a166c5b442b0fec01684cfa71d817a292d51e4555b80381149da91a54f58511e4859f195e6527d08b5b9d57efa3ac6637602d53353147d59d87bbeccbade"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 07:20:36.060112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:20:36.060470) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464616691.358838-1648424827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:20:36.143550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 07:20:36.143907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 07:20:36.144213) ========= ========= Total master_lag: 0.17 =========