builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1464844157.83 results: success (0) buildid: 20160601193105 builduid: a891cf4004bc452cbed6414577280937 revision: 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.832958) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.833785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.834105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.868954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.869254) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 22:09:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.7M=0s 2016-06-01 22:09:18 (25.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.961992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:17.962320) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019542 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.048409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.048823) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd --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 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd --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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 22:09:18,386 truncating revision to first 12 chars 2016-06-01 22:09:18,386 Setting DEBUG logging. 2016-06-01 22:09:18,386 attempt 1/10 2016-06-01 22:09:18,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/24bd574ecbf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 22:09:18,827 unpacking tar archive at: mozilla-inbound-24bd574ecbf0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.833087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.833426) ========= script_repo_revision: 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.833951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.834319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 22:09:18.863294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-01 22:09:18.863651) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:09:19 INFO - MultiFileLogger online at 20160601 22:09:19 in /builds/slave/test 22:09:19 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 22:09:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:09:19 INFO - {'append_to_log': False, 22:09:19 INFO - 'base_work_dir': '/builds/slave/test', 22:09:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:09:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:09:19 INFO - 'branch': 'Mozilla-Inbound', 22:09:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:09:19 INFO - 'config_files': ('talos/linux_config.py',), 22:09:19 INFO - 'default_actions': ('clobber', 22:09:19 INFO - 'read-buildbot-config', 22:09:19 INFO - 'download-and-extract', 22:09:19 INFO - 'populate-webroot', 22:09:19 INFO - 'create-virtualenv', 22:09:19 INFO - 'install', 22:09:19 INFO - 'run-tests'), 22:09:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:09:19 INFO - 'download_minidump_stackwalk': True, 22:09:19 INFO - 'download_symbols': 'ondemand', 22:09:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:09:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:09:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:09:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:09:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:09:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:09:19 INFO - 'installer_path': 'installer.exe', 22:09:19 INFO - 'log_level': 'info', 22:09:19 INFO - 'log_name': 'talos', 22:09:19 INFO - 'log_to_console': True, 22:09:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:09:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:09:19 INFO - 'opt_config_files': (), 22:09:19 INFO - 'pip_index': False, 22:09:19 INFO - 'sps_profile': False, 22:09:19 INFO - 'sps_profile_interval': 0, 22:09:19 INFO - 'suite': 'dromaeojs-e10s', 22:09:19 INFO - 'system_bits': '32', 22:09:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:09:19 INFO - 'title': 'talos-linux64-ix-066', 22:09:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:09:19 INFO - 'use_talos_json': True, 22:09:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:09:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:09:19 INFO - 'work_dir': 'build'} 22:09:19 INFO - ##### 22:09:19 INFO - ##### Running clobber step. 22:09:19 INFO - ##### 22:09:19 INFO - Running pre-action listener: _resource_record_pre_action 22:09:19 INFO - Running main action method: clobber 22:09:19 INFO - rmtree: /builds/slave/test/build 22:09:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:09:19 INFO - Running post-action listener: _resource_record_post_action 22:09:19 INFO - ##### 22:09:19 INFO - ##### Finished clobber step (success) 22:09:19 INFO - ##### 22:09:19 INFO - ##### 22:09:19 INFO - ##### Running read-buildbot-config step. 22:09:19 INFO - ##### 22:09:19 INFO - Running pre-action listener: _resource_record_pre_action 22:09:19 INFO - Running main action method: read_buildbot_config 22:09:19 INFO - Using buildbot properties: 22:09:19 INFO - { 22:09:19 INFO - "project": "", 22:09:19 INFO - "product": "firefox", 22:09:19 INFO - "script_repo_revision": "production", 22:09:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:09:19 INFO - "repository": "", 22:09:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:09:19 INFO - "buildid": "20160601193105", 22:09:19 INFO - "pgo_build": "True", 22:09:19 INFO - "basedir": "/builds/slave/test", 22:09:19 INFO - "buildnumber": 643, 22:09:19 INFO - "slavename": "talos-linux64-ix-066", 22:09:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:09:19 INFO - "platform": "ubuntu64_hw", 22:09:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:09:19 INFO - "branch": "mozilla-inbound", 22:09:19 INFO - "repo_path": "integration/mozilla-inbound", 22:09:19 INFO - "revision": "24bd574ecbf0c8630290fc81f76e6a928d3ee8dd", 22:09:19 INFO - "stage_platform": "linux64-pgo", 22:09:19 INFO - "builduid": "a891cf4004bc452cbed6414577280937", 22:09:19 INFO - "slavebuilddir": "test" 22:09:19 INFO - } 22:09:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:09:19 INFO - Running post-action listener: _resource_record_post_action 22:09:19 INFO - ##### 22:09:19 INFO - ##### Finished read-buildbot-config step (success) 22:09:19 INFO - ##### 22:09:19 INFO - ##### 22:09:19 INFO - ##### Running download-and-extract step. 22:09:19 INFO - ##### 22:09:19 INFO - Running pre-action listener: _resource_record_pre_action 22:09:19 INFO - Running main action method: download_and_extract 22:09:19 INFO - mkdir: /builds/slave/test/build/tests 22:09: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')]} 22:09:19 INFO - https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:20 INFO - Downloaded 1361 bytes. 22:09:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:09:20 INFO - Using the following test package requirements: 22:09:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:09:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:09:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:09:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'jsshell-linux-x86_64.zip'], 22:09:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:09:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:09:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:09:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:09:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:09:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:09:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:20 INFO - https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:21 INFO - Downloaded 24423190 bytes. 22:09:21 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'] 22:09:21 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 22:09:23 INFO - Return code: 0 22:09:23 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 22:09:23 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')]} 22:09:23 INFO - https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:29 INFO - Downloaded 24423190 bytes. 22:09:29 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'] 22:09:29 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 22:09:31 INFO - Return code: 0 22:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:31 INFO - https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:32 INFO - Downloaded 10834055 bytes. 22:09:32 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'] 22:09:32 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 22:09:32 INFO - Return code: 0 22:09: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')]} 22:09:32 INFO - https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_cCMZZmQbiDJi10WIzdtg/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 22:09:34 INFO - Downloaded 59061399 bytes. 22:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:09:34 INFO - mkdir: /builds/slave/test/properties 22:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:09:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:09:34 INFO - Contents: 22:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:09:35 INFO - Running post-action listener: _resource_record_post_action 22:09:35 INFO - Running post-action listener: set_extra_try_arguments 22:09:35 INFO - ##### 22:09:35 INFO - ##### Finished download-and-extract step (success) 22:09:35 INFO - ##### 22:09:35 INFO - ##### 22:09:35 INFO - ##### Running populate-webroot step. 22:09:35 INFO - ##### 22:09:35 INFO - Running pre-action listener: _resource_record_pre_action 22:09:35 INFO - Running main action method: populate_webroot 22:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:09:35 INFO - '--tppagecycles', 22:09:35 INFO - '7'], 22:09:35 INFO - 'tests': ['tsvgm']}}, 22:09:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:09:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:09:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['damp', 'tps']}, 22:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'tests': ['damp', 'tps']}, 22:09:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['dromaeo_dom']}, 22:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:09:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['a11yr', 22:09:35 INFO - 'ts_paint', 22:09:35 INFO - 'tpaint', 22:09:35 INFO - 'sessionrestore', 22:09:35 INFO - 'sessionrestore_no_auto_restore', 22:09:35 INFO - 'tabpaint']}, 22:09:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['tsvgx', 22:09:35 INFO - 'tsvgr_opacity', 22:09:35 INFO - 'tart', 22:09:35 INFO - 'tscrollx', 22:09:35 INFO - 'cart']}, 22:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:09:35 INFO - 'tsvgr_opacity', 22:09:35 INFO - 'tart', 22:09:35 INFO - 'tscrollx', 22:09:35 INFO - 'cart']}, 22:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'talos_options': ['--disable-e10s'], 22:09:35 INFO - 'tests': ['tp5o']}, 22:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'tests': ['tp5o']}, 22:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'talos_options': ['--disable-e10s', 22:09:35 INFO - '--xperf_path', 22:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:35 INFO - 'tests': ['tp5n']}, 22:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:35 INFO - 'talos_options': ['--xperf_path', 22:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:35 INFO - 'tests': ['tp5n']}}, 22:09:35 INFO - 'talos.zip': {'path': '', 22:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:09:35 INFO - Running post-action listener: _resource_record_post_action 22:09:35 INFO - ##### 22:09:35 INFO - ##### Finished populate-webroot step (success) 22:09:35 INFO - ##### 22:09:35 INFO - ##### 22:09:35 INFO - ##### Running create-virtualenv step. 22:09:35 INFO - ##### 22:09:35 INFO - Running pre-action listener: _resource_record_pre_action 22:09:35 INFO - Running main action method: create_virtualenv 22:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:09:35 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 22:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:09:35 INFO - Using real prefix '/usr' 22:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:09:37 INFO - Installing pip.................done. 22:09:37 INFO - Return code: 0 22:09:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:09:37 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')]} 22:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:37 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')]} 22:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:37 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:37 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 22:09:37 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 22:09:37 INFO - Using env: {'DISPLAY': ':0', 22:09:37 INFO - 'HOME': '/home/cltbld', 22:09:37 INFO - 'LANG': 'en_US.UTF-8', 22:09:37 INFO - 'LANGUAGE': 'en_US:en', 22:09:37 INFO - 'LOGNAME': 'cltbld', 22:09:37 INFO - 'MAIL': '/var/mail/cltbld', 22:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:37 INFO - 'MOZ_NO_REMOTE': '1', 22:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:37 INFO - 'NO_EM_RESTART': '1', 22:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:37 INFO - 'PWD': '/builds/slave/test', 22:09:37 INFO - 'SHELL': '/bin/bash', 22:09:37 INFO - 'SHLVL': '1', 22:09:37 INFO - 'TERM': 'linux', 22:09:37 INFO - 'TMOUT': '86400', 22:09:37 INFO - 'USER': 'cltbld', 22:09:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:37 INFO - '_': '/tools/buildbot/bin/python'} 22:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:37 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 22:09:37 INFO - Cleaning up... 22:09:37 INFO - Return code: 0 22:09:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:09:37 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')]} 22:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:37 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')]} 22:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:37 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:37 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 22:09:37 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 22:09:37 INFO - Using env: {'DISPLAY': ':0', 22:09:37 INFO - 'HOME': '/home/cltbld', 22:09:37 INFO - 'LANG': 'en_US.UTF-8', 22:09:37 INFO - 'LANGUAGE': 'en_US:en', 22:09:37 INFO - 'LOGNAME': 'cltbld', 22:09:37 INFO - 'MAIL': '/var/mail/cltbld', 22:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:37 INFO - 'MOZ_NO_REMOTE': '1', 22:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:37 INFO - 'NO_EM_RESTART': '1', 22:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:37 INFO - 'PWD': '/builds/slave/test', 22:09:37 INFO - 'SHELL': '/bin/bash', 22:09:37 INFO - 'SHLVL': '1', 22:09:37 INFO - 'TERM': 'linux', 22:09:37 INFO - 'TMOUT': '86400', 22:09:37 INFO - 'USER': 'cltbld', 22:09:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:37 INFO - '_': '/tools/buildbot/bin/python'} 22:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:38 INFO - Downloading/unpacking psutil>=3.1.1 22:09:38 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 22:09:38 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 22:09:38 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 22:09:38 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 22:09:38 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 22:09:38 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 22:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:40 INFO - Installing collected packages: psutil 22:09:40 INFO - Running setup.py install for psutil 22:09:40 INFO - building 'psutil._psutil_linux' extension 22:09:40 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 22:09:40 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 22:09:40 INFO - building 'psutil._psutil_posix' extension 22:09:40 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 22:09:40 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 22:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:40 INFO - Successfully installed psutil 22:09:40 INFO - Cleaning up... 22:09:40 INFO - Return code: 0 22:09:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:40 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:40 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 22:09:40 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 22:09:40 INFO - Using env: {'DISPLAY': ':0', 22:09:40 INFO - 'HOME': '/home/cltbld', 22:09:40 INFO - 'LANG': 'en_US.UTF-8', 22:09:40 INFO - 'LANGUAGE': 'en_US:en', 22:09:40 INFO - 'LOGNAME': 'cltbld', 22:09:40 INFO - 'MAIL': '/var/mail/cltbld', 22:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:40 INFO - 'MOZ_NO_REMOTE': '1', 22:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:40 INFO - 'NO_EM_RESTART': '1', 22:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:40 INFO - 'PWD': '/builds/slave/test', 22:09:40 INFO - 'SHELL': '/bin/bash', 22:09:40 INFO - 'SHLVL': '1', 22:09:40 INFO - 'TERM': 'linux', 22:09:40 INFO - 'TMOUT': '86400', 22:09:40 INFO - 'USER': 'cltbld', 22:09:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:40 INFO - '_': '/tools/buildbot/bin/python'} 22:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:09:40 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 22:09:40 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 22:09:40 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 22:09:40 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 22:09:40 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 22:09:40 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 22:09:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:09:42 INFO - Installing collected packages: mozsystemmonitor 22:09:42 INFO - Running setup.py install for mozsystemmonitor 22:09:42 INFO - Successfully installed mozsystemmonitor 22:09:42 INFO - Cleaning up... 22:09:42 INFO - Return code: 0 22:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:09:42 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')]} 22:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:42 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')]} 22:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:42 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:42 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 22:09:42 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 22:09:42 INFO - Using env: {'DISPLAY': ':0', 22:09:42 INFO - 'HOME': '/home/cltbld', 22:09:42 INFO - 'LANG': 'en_US.UTF-8', 22:09:42 INFO - 'LANGUAGE': 'en_US:en', 22:09:42 INFO - 'LOGNAME': 'cltbld', 22:09:42 INFO - 'MAIL': '/var/mail/cltbld', 22:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:42 INFO - 'MOZ_NO_REMOTE': '1', 22:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:42 INFO - 'NO_EM_RESTART': '1', 22:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:42 INFO - 'PWD': '/builds/slave/test', 22:09:42 INFO - 'SHELL': '/bin/bash', 22:09:42 INFO - 'SHLVL': '1', 22:09:42 INFO - 'TERM': 'linux', 22:09:42 INFO - 'TMOUT': '86400', 22:09:42 INFO - 'USER': 'cltbld', 22:09:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:42 INFO - '_': '/tools/buildbot/bin/python'} 22:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:09:43 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 22:09:43 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 22:09:43 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 22:09:43 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 22:09:43 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 22:09:43 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 22:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:09:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 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 22:09:45 INFO - Downloading docopt-0.6.1.tar.gz 22:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:09:45 INFO - Running setup.py install for blobuploader 22:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:09:45 INFO - Running setup.py install for requests 22:09:46 INFO - Running setup.py install for docopt 22:09:46 INFO - Successfully installed blobuploader requests docopt 22:09:46 INFO - Cleaning up... 22:09:46 INFO - Return code: 0 22:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:46 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:46 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 22:09:46 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 22:09:46 INFO - Using env: {'DISPLAY': ':0', 22:09:46 INFO - 'HOME': '/home/cltbld', 22:09:46 INFO - 'LANG': 'en_US.UTF-8', 22:09:46 INFO - 'LANGUAGE': 'en_US:en', 22:09:46 INFO - 'LOGNAME': 'cltbld', 22:09:46 INFO - 'MAIL': '/var/mail/cltbld', 22:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:46 INFO - 'MOZ_NO_REMOTE': '1', 22:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:46 INFO - 'NO_EM_RESTART': '1', 22:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:46 INFO - 'PWD': '/builds/slave/test', 22:09:46 INFO - 'SHELL': '/bin/bash', 22:09:46 INFO - 'SHLVL': '1', 22:09:46 INFO - 'TERM': 'linux', 22:09:46 INFO - 'TMOUT': '86400', 22:09:46 INFO - 'USER': 'cltbld', 22:09:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:46 INFO - '_': '/tools/buildbot/bin/python'} 22:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:46 INFO - Running setup.py (path:/tmp/pip-VvcrbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:46 INFO - Running setup.py (path:/tmp/pip-cSY2QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:46 INFO - Running setup.py (path:/tmp/pip-z0TZ8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:46 INFO - Running setup.py (path:/tmp/pip-8e3iRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:46 INFO - Running setup.py (path:/tmp/pip-8cA9rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:46 INFO - Running setup.py (path:/tmp/pip-qSCavg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:47 INFO - Running setup.py (path:/tmp/pip-b9tSbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:47 INFO - Running setup.py (path:/tmp/pip-zJhnj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:47 INFO - Running setup.py (path:/tmp/pip-VMFTzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:47 INFO - Running setup.py (path:/tmp/pip-bmZqop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:47 INFO - Running setup.py (path:/tmp/pip-7IIMjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:47 INFO - Running setup.py (path:/tmp/pip-01Bb2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:47 INFO - Running setup.py (path:/tmp/pip-mELnX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:47 INFO - Running setup.py (path:/tmp/pip-xkc1XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:47 INFO - Running setup.py (path:/tmp/pip-dEfGiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:47 INFO - Running setup.py (path:/tmp/pip-mFRnYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:47 INFO - Running setup.py (path:/tmp/pip-P8Zw1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:09:47 INFO - Running setup.py install for manifestparser 22:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:09:47 INFO - Running setup.py install for mozcrash 22:09:47 INFO - Running setup.py install for mozdebug 22:09:48 INFO - Running setup.py install for mozdevice 22:09:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for mozfile 22:09:48 INFO - Running setup.py install for mozhttpd 22:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for mozinfo 22:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for mozInstall 22:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for mozleak 22:09:48 INFO - Running setup.py install for mozlog 22:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for moznetwork 22:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:09:48 INFO - Running setup.py install for mozprocess 22:09:49 INFO - Running setup.py install for mozprofile 22:09:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:09:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:09:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:09:49 INFO - Running setup.py install for mozrunner 22:09:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:09:49 INFO - Running setup.py install for mozscreenshot 22:09:49 INFO - Running setup.py install for moztest 22:09:49 INFO - Running setup.py install for mozversion 22:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:09:49 INFO - Cleaning up... 22:09:49 INFO - Return code: 0 22:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:49 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:49 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 22:09:49 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 22:09:49 INFO - Using env: {'DISPLAY': ':0', 22:09:49 INFO - 'HOME': '/home/cltbld', 22:09:49 INFO - 'LANG': 'en_US.UTF-8', 22:09:49 INFO - 'LANGUAGE': 'en_US:en', 22:09:49 INFO - 'LOGNAME': 'cltbld', 22:09:49 INFO - 'MAIL': '/var/mail/cltbld', 22:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:49 INFO - 'MOZ_NO_REMOTE': '1', 22:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:49 INFO - 'NO_EM_RESTART': '1', 22:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:49 INFO - 'PWD': '/builds/slave/test', 22:09:49 INFO - 'SHELL': '/bin/bash', 22:09:49 INFO - 'SHLVL': '1', 22:09:49 INFO - 'TERM': 'linux', 22:09:49 INFO - 'TMOUT': '86400', 22:09:49 INFO - 'USER': 'cltbld', 22:09:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:49 INFO - '_': '/tools/buildbot/bin/python'} 22:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:49 INFO - Running setup.py (path:/tmp/pip-QqDLfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:49 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)) 22:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:49 INFO - Running setup.py (path:/tmp/pip-wUG8MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:49 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)) 22:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:49 INFO - Running setup.py (path:/tmp/pip-Ih_XTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:50 INFO - Running setup.py (path:/tmp/pip-WDlmBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:50 INFO - Running setup.py (path:/tmp/pip-rPe5IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:50 INFO - Running setup.py (path:/tmp/pip-0BaoEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:50 INFO - Running setup.py (path:/tmp/pip-3JWPia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:50 INFO - Running setup.py (path:/tmp/pip-7Tn4Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:50 INFO - Running setup.py (path:/tmp/pip-BEn_dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:50 INFO - Running setup.py (path:/tmp/pip-4DoiYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:50 INFO - Running setup.py (path:/tmp/pip-1mXdC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:50 INFO - Running setup.py (path:/tmp/pip-CvKVMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:50 INFO - Running setup.py (path:/tmp/pip-JnR4uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:50 INFO - Running setup.py (path:/tmp/pip-_PHP83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:50 INFO - Running setup.py (path:/tmp/pip-Jon4Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:50 INFO - Running setup.py (path:/tmp/pip-YJk6R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:50 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)) 22:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:50 INFO - Running setup.py (path:/tmp/pip-HT7RyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:51 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)) 22:09:51 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)) 22:09:51 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)) 22:09:51 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)) 22:09:51 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)) 22:09:51 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)) 22:09:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:52 INFO - Downloading blessings-1.6.tar.gz 22:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:09:52 INFO - Installing collected packages: blessings 22:09:52 INFO - Running setup.py install for blessings 22:09:53 INFO - Successfully installed blessings 22:09:53 INFO - Cleaning up... 22:09:53 INFO - Return code: 0 22:09:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:53 INFO - Reading from file tmpfile_stdout 22:09:53 INFO - Current package versions: 22:09:53 INFO - argparse == 1.2.1 22:09:53 INFO - blessings == 1.6 22:09:53 INFO - blobuploader == 1.2.4 22:09:53 INFO - docopt == 0.6.1 22:09:53 INFO - manifestparser == 1.1 22:09:53 INFO - mozInstall == 1.12 22:09:53 INFO - mozcrash == 0.17 22:09:53 INFO - mozdebug == 0.1 22:09:53 INFO - mozdevice == 0.48 22:09:53 INFO - mozfile == 1.2 22:09:53 INFO - mozhttpd == 0.7 22:09:53 INFO - mozinfo == 0.9 22:09:53 INFO - mozleak == 0.1 22:09:53 INFO - mozlog == 3.2 22:09:53 INFO - moznetwork == 0.27 22:09:53 INFO - mozprocess == 0.22 22:09:53 INFO - mozprofile == 0.28 22:09:53 INFO - mozrunner == 6.11 22:09:53 INFO - mozscreenshot == 0.1 22:09:53 INFO - mozsystemmonitor == 0.3 22:09:53 INFO - moztest == 0.7 22:09:53 INFO - mozversion == 1.4 22:09:53 INFO - psutil == 3.1.1 22:09:53 INFO - requests == 1.2.3 22:09:53 INFO - wsgiref == 0.1.2 22:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:53 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 22:09:53 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 22:09:53 INFO - Using env: {'DISPLAY': ':0', 22:09:53 INFO - 'HOME': '/home/cltbld', 22:09:53 INFO - 'LANG': 'en_US.UTF-8', 22:09:53 INFO - 'LANGUAGE': 'en_US:en', 22:09:53 INFO - 'LOGNAME': 'cltbld', 22:09:53 INFO - 'MAIL': '/var/mail/cltbld', 22:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:53 INFO - 'MOZ_NO_REMOTE': '1', 22:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:53 INFO - 'NO_EM_RESTART': '1', 22:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:53 INFO - 'PWD': '/builds/slave/test', 22:09:53 INFO - 'SHELL': '/bin/bash', 22:09:53 INFO - 'SHLVL': '1', 22:09:53 INFO - 'TERM': 'linux', 22:09:53 INFO - 'TMOUT': '86400', 22:09:53 INFO - 'USER': 'cltbld', 22:09:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:53 INFO - '_': '/tools/buildbot/bin/python'} 22:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 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)) 22:09:53 INFO - Cleaning up... 22:09:53 INFO - Return code: 0 22:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 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 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:53 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 22:09:53 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 22:09:53 INFO - Using env: {'DISPLAY': ':0', 22:09:53 INFO - 'HOME': '/home/cltbld', 22:09:53 INFO - 'LANG': 'en_US.UTF-8', 22:09:53 INFO - 'LANGUAGE': 'en_US:en', 22:09:53 INFO - 'LOGNAME': 'cltbld', 22:09:53 INFO - 'MAIL': '/var/mail/cltbld', 22:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:53 INFO - 'MOZ_NO_REMOTE': '1', 22:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:53 INFO - 'NO_EM_RESTART': '1', 22:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:53 INFO - 'PWD': '/builds/slave/test', 22:09:53 INFO - 'SHELL': '/bin/bash', 22:09:53 INFO - 'SHLVL': '1', 22:09:53 INFO - 'TERM': 'linux', 22:09:53 INFO - 'TMOUT': '86400', 22:09:53 INFO - 'USER': 'cltbld', 22:09:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:53 INFO - '_': '/tools/buildbot/bin/python'} 22:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:53 INFO - Downloading/unpacking jsonschema 22:09:53 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 22:09:53 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 22:09:53 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 22:09:53 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 22:09:53 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 22:09:53 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 22:09:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:09:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:09:55 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 22:09:55 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 22:09:55 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 22:09:55 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 22:09:55 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 22:09:55 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 22:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:09:55 INFO - warning: no files found matching '*.txt' 22:09:55 INFO - no previously-included directories found matching 'build' 22:09:55 INFO - no previously-included directories found matching 'dist' 22:09:55 INFO - no previously-included directories found matching '.git*' 22:09:55 INFO - Installing collected packages: jsonschema, functools32 22:09:55 INFO - Running setup.py install for functools32 22:09:56 INFO - warning: no files found matching '*.txt' 22:09:56 INFO - no previously-included directories found matching 'build' 22:09:56 INFO - no previously-included directories found matching 'dist' 22:09:56 INFO - no previously-included directories found matching '.git*' 22:09:56 INFO - Successfully installed jsonschema functools32 22:09:56 INFO - Cleaning up... 22:09:56 INFO - Return code: 0 22:09:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09: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')]} 22:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fb4b9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20dd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', '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 22:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:09:56 INFO - Using env: {'DISPLAY': ':0', 22:09:56 INFO - 'HOME': '/home/cltbld', 22:09:56 INFO - 'LANG': 'en_US.UTF-8', 22:09:56 INFO - 'LANGUAGE': 'en_US:en', 22:09:56 INFO - 'LOGNAME': 'cltbld', 22:09:56 INFO - 'MAIL': '/var/mail/cltbld', 22:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:56 INFO - 'MOZ_NO_REMOTE': '1', 22:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:56 INFO - 'NO_EM_RESTART': '1', 22:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:56 INFO - 'PWD': '/builds/slave/test', 22:09:56 INFO - 'SHELL': '/bin/bash', 22:09:56 INFO - 'SHLVL': '1', 22:09:56 INFO - 'TERM': 'linux', 22:09:56 INFO - 'TMOUT': '86400', 22:09:56 INFO - 'USER': 'cltbld', 22:09:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:56 INFO - '_': '/tools/buildbot/bin/python'} 22:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:56 INFO - Downloading/unpacking flake8 22:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:09:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:09:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:09:58 INFO - no previously-included directories found matching 'docs/_build' 22:09:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:09:59 INFO - Running setup.py install for pep8 22:09:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:09:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:09:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:09:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:09:59 INFO - no previously-included directories found matching 'docs/_build' 22:09:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:09:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:09:59 INFO - Cleaning up... 22:09:59 INFO - Return code: 0 22:09:59 INFO - Running post-action listener: _resource_record_post_action 22:09:59 INFO - Running post-action listener: _start_resource_monitoring 22:09:59 INFO - Starting resource monitoring. 22:09:59 INFO - ##### 22:09:59 INFO - ##### Finished create-virtualenv step (success) 22:09:59 INFO - ##### 22:09:59 INFO - ##### 22:09:59 INFO - ##### Running install step. 22:09:59 INFO - ##### 22:09:59 INFO - Running pre-action listener: _resource_record_pre_action 22:09:59 INFO - Running main action method: install 22:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:59 INFO - Reading from file tmpfile_stdout 22:09:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:09:59 INFO - Reading from file tmpfile_stdout 22:09:59 INFO - Output received: 22:09:59 INFO - Usage: mozinstall [options] installer 22:09:59 INFO - Options: 22:09:59 INFO - -h, --help show this help message and exit 22:09:59 INFO - -d DEST, --destination=DEST 22:09:59 INFO - Directory to install application into. [default: 22:09:59 INFO - "/builds/slave/test"] 22:09:59 INFO - --app=APP Application being installed. [default: firefox] 22:09:59 INFO - mkdir: /builds/slave/test/build/application 22:09:59 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'] 22:09:59 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 22:10:16 INFO - Reading from file tmpfile_stdout 22:10:16 INFO - Output received: 22:10:16 INFO - /builds/slave/test/build/application/firefox/firefox 22:10:16 INFO - Running post-action listener: _resource_record_post_action 22:10:16 INFO - ##### 22:10:16 INFO - ##### Finished install step (success) 22:10:16 INFO - ##### 22:10:16 INFO - ##### 22:10:16 INFO - ##### Running run-tests step. 22:10:16 INFO - ##### 22:10:16 INFO - Running pre-action listener: _resource_record_pre_action 22:10:16 INFO - Running main action method: run_tests 22:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:10:16 INFO - Python 2.7.3 22:10:16 INFO - Return code: 0 22:10:16 INFO - grabbing minidump binary from tooltool 22:10: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')]} 22:10:16 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 0x216c9c0>, '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 0x216d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:10:16 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 22:10:16 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 22:10:16 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 22:10:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:10:16 INFO - Return code: 0 22:10:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:10:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:10:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:10:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:10:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:10:17 INFO - Return code: 0 22:10:17 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/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 22:10:17 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/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 22:10:17 INFO - Using env: {'DISPLAY': ':0', 22:10:17 INFO - 'HOME': '/home/cltbld', 22:10:17 INFO - 'LANG': 'en_US.UTF-8', 22:10:17 INFO - 'LANGUAGE': 'en_US:en', 22:10:17 INFO - 'LOGNAME': 'cltbld', 22:10:17 INFO - 'MAIL': '/var/mail/cltbld', 22:10:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:10:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:17 INFO - 'MOZ_NO_REMOTE': '1', 22:10:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:17 INFO - 'NO_EM_RESTART': '1', 22:10:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:17 INFO - 'PWD': '/builds/slave/test', 22:10:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:10:17 INFO - 'SHELL': '/bin/bash', 22:10:17 INFO - 'SHLVL': '1', 22:10:17 INFO - 'TERM': 'linux', 22:10:17 INFO - 'TMOUT': '86400', 22:10:17 INFO - 'USER': 'cltbld', 22:10:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817', 22:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:17 INFO - '_': '/tools/buildbot/bin/python'} 22:10:17 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/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 22:10:17 INFO - mozversion application_buildid: 20160601193105 22:10:17 INFO - mozversion application_changeset: 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd 22:10:17 INFO - mozversion application_display_name: Nightly 22:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:10:17 INFO - mozversion application_name: Firefox 22:10:17 INFO - mozversion application_remotingname: firefox 22:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:10:17 INFO - mozversion application_vendor: Mozilla 22:10:17 INFO - mozversion application_version: 49.0a1 22:10:17 INFO - mozversion platform_buildid: 20160601193105 22:10:17 INFO - mozversion platform_changeset: 24bd574ecbf0c8630290fc81f76e6a928d3ee8dd 22:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:10:17 INFO - mozversion platform_version: 49.0a1 22:10:17 INFO - using testdate: 1464844217 22:10:17 INFO - actual date: 1464844217 22:10:17 INFO - starting webserver on 'localhost:57610' 22:10:17 INFO - SUITE-START | Running 2 tests 22:10:17 INFO - TEST-START | dromaeo_css 22:10:17 INFO - operating with platform_type : linux_ 22:10:17 INFO - Initialising browser for dromaeo_css test... 22:10:17 INFO - TEST-INFO | started process 8495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE__IS/profile http://localhost:57610/getInfo.html) 22:10:22 INFO - PROCESS | 8495 | __metrics Screen width/height:1600/1200 22:10:22 INFO - PROCESS | 8495 | colorDepth:24 22:10:22 INFO - PROCESS | 8495 | Browser inner width/height: 1024/697 22:10:22 INFO - PROCESS | 8495 | __metrics 22:10:23 ERROR - PROCESS | 8495 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:10:24 INFO - TEST-INFO | 8495: exit 0 22:10:24 INFO - Browser initialized. 22:10:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:10:24 INFO - TEST-INFO | started process 8615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE__IS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:35 INFO - PROCESS | 8615 | RSS: Main: 166948864 22:10:35 INFO - PROCESS | 8615 | 22:11:25 INFO - PROCESS | 8615 | 1464844285470 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] 22:13:33 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57610/tests/dromaeo/cssquery-ext.html) 22:13:34 INFO - PROCESS | 8615 | RSS: Main: 170356736 22:13:34 INFO - PROCESS | 8615 | 22:16:36 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-ext.html (next: http://localhost:57610/tests/dromaeo/cssquery-jquery.html) 22:16:36 INFO - PROCESS | 8615 | RSS: Main: 169201664 22:16:36 INFO - PROCESS | 8615 | 22:19:38 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57610/tests/dromaeo/cssquery-mootools.html) 22:19:39 INFO - PROCESS | 8615 | RSS: Main: 170901504 22:19:39 INFO - PROCESS | 8615 | 22:22:41 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57610/tests/dromaeo/cssquery-prototype.html) 22:22:41 INFO - PROCESS | 8615 | RSS: Main: 168726528 22:22:41 INFO - PROCESS | 8615 | 22:25:44 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57610/tests/dromaeo/cssquery-yui.html) 22:25:44 INFO - PROCESS | 8615 | RSS: Main: 170061824 22:25:44 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | Cycle 1(1): loaded http://localhost:57610/tests/dromaeo/cssquery-yui.html (next: http://localhost:57610/tests/dromaeo/cssquery-dojo.html) 22:28:47 INFO - PROCESS | 8615 | RSS: Main: 171675648 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | __start_tp_report 22:28:47 INFO - PROCESS | 8615 | _x_x_mozilla_page_load 22:28:47 INFO - PROCESS | 8615 | _x_x_mozilla_page_load_details 22:28:47 INFO - PROCESS | 8615 | |i|pagename|runs| 22:28:47 INFO - PROCESS | 8615 | |0;dojo.html;3126.4372412965663;3153.306272620024;3224.1617179533314;3246.805191688499;3253.9349213015753;5567.749451274693;5584.246126772884;5608.467195616415;5650.321961364642;5664.603477756558;5504.366997795255;5560.582956278275;5562.7774889004395;5564.248826408434;5597.104463285875;5011.298418221452;5076.517730815566;5185.818496352628;5232.843014709546;5247.685138891659;882.7092622528027;5032.622553308498;5102.234664800272;5156.716380599066;5181.0933086709865;5137.101007323722;5163.638545301812;5210.114280572312;5217.817376391827;5219.921701174486;5178.559822415099;5206.947930520722;5227.947720522784;5228.895422091575;5257.894842103175;5004.074246264453;5089.898202035975;5131.692098474104;5157.226416037587;5196.168613021899;5527.640703354269;5585.385607583163;5603.327600687903;5622.634528755659;5648.85877853057;5839.591228613998;6049.213602231725;6050.152978583002;6050.2437195350585;6069.605475644069;5997.550183736237;6059.969700151515;6107.144999700045;6156.3843615638525;6159.168512250833;5663.546916246691;5680.687562184078;5684.857878553028;5689.459501347365;5695.601307908407;6007.459328660441;6010.939890601126;6028.5478589106;6031.306399764083;6133.509319254449;5867.442592953663;5948.821535353946;5980.940190598125;5982.850428739316;6018.668973206516;5960.7019649017375;5978.133170690226;6035.969820150871;6048;6056.878862422727;5856.063029915278;5883.911741323884;5925.259342582177;5970.701464926737;6022.488088512526;6016.69916504173;6049.274087109487;6065.120557519135;6070.3929607038945;6072.51419886408;4515.2324104902245;4516.435445569304;4517.435320584927;4523.411956445641;4560.247559152769;3963.8612648557164;3976.8608098716986;4032.2540330039037;4044.2518134145275;4070.4911886014247;5621.269234999506;5706.457886500776;5726.513246374105;5749;5762.625429347079;6079.878402431927;6132.570720049643;6139.877202455926;6143.600665956698;6152.477039451696;5606.046972014768;5672.716364181774;5680.943190568041;5726.79956201531;5751.1373294006235;4989;5003.224500202475;5014.414693494169;5016.072026675077;5017.7491125443585;6272.466840318532;6288.811335659938;6306.684665766693;6313.337099604567;6327.240731112296;5868.970655146697;6043.576949613661;6084.14821924922;6088.6042407243385;6198.163247961467;6327.11420401135;6339.302676705466;6388;6409.679516024274;6411.198600174978;5873.853153671193;6042.939570604413;6073.514118870391;6086.3000754913755;6086.452219300107;5961.7615295387695;6012.278526576839;6058.697065146813;6088.3911608840535;6107.938920610737;5894;5907.379725128972;5914.467697907209;5932.851678708067;5937.614055086406;5696.060150075357;5849.64902105875;5898.144769008384;5909.143174239797;5934.9406505934385;5757.65454072757;5820.82537523858;5841;5881.470667639933;5882.382349853375;5927.14056461802;5938.376470470538;5963.612365196248;5966.522678185822;5982.820515384546;5673.744681489426;5731.828045158652;5776.797812076557;5832.387599302182;5880.294364676266 22:28:47 INFO - PROCESS | 8615 | |1;ext.html;588.9322727886295;611.2634275697784;613.1232337757006;630.508203601191;648.3969907985578;38827;43451;43573.78213108934;43645.290150337256;43677.34483982739;44619.33071003937;45405.318920216225;45426.09147817042;45578.54421455784;45672.77163614177;8680.088590697964;8813.823723525526;8815.118488151165;8858.202761751441;8871.334649901251;8620.525871077089;8714.694985675502;8779.692710755126;8805.95597022014;8806.427582207136;8741.868871966893;8804.075572064938;8863.069377715343;8895.68865089722;8904.465732056098;8785.472871627691;8814.603342849587;8824.249938755149;8833.646654133827;8855.203031727111;8663.220310172052;8747.16901894319;8761.7809554761;8771.78070548235;8782.47305161686;41494.1701165978;41755;41797.37303940413;42118.789406052776;42336.36495452571;3572.9285414291567;3684.5394325709285;3779.6031416701126;3832.693384529231;4016.5581786003518;32210.677893221236;32647.347053058806;32796.18009549756;32901;32912.506312405334;4411.779411029435;4571.542845715435;4664.5335466453425;4680.648951328664;4695.7886895089805;338240;338528;339644;340442;340952.2952385247;33795.32409351799;34770.130746731025;34958.47562286568;36816;60377.09434358488;36881.44677829781;37024;37104.25791484155;37112.25775484475;37126.44310335347;15397.692046159238;15481;15528.844711552965;15535.844641553665;15578.84421155774;12975.286359250144;13079.476820927057;13085.280309583064;13097.083204175808;13103.803442948363;8352.12302708219;8375.790605234917;8431.57842107892;8480.15198480147;8491.95754021226;3249.333886553251;3269.6076470823655;3278.131295206772;3284.3267130238246;3308.4871844864083;997.217184510156;1070.5075665194097;1118.1948996722347;1126.2566705974018;1190.7142285851332;29918.252043698645;32347.191320216712;32536.511952320736;32606.34787304288;32712.34575308528;1144.822552504363;1149.0979581028853;1174.747429302687;1235.1539195651008;1281.9551315704093;16796.16019199035;17186.140692965302;17341.7398739019;17352.913235433996;17459.56351091233;557586;561865;562875;563825;565967;60103.69948150231;60653.69673151606;60822.39177608167;60864.69567652133;60934.085988710205;1352.5198554513204;1377.1805775563523;1383.75784237758;1397.322298685137;1403.1230480949407;30787;31968.52047219247;31976.68023319737;32115;32690.346193076482;52029.479705202466;53070.73464632652;53139.734301328244;53194;53236.4676353247;436106;446879;449030;450416;451123;28074.2981425466;28076.43847123087;28282;28416.289592760346;28471.572926406534;48258.758706206245;48919.26621100615;49379;50293.497065030344;50743;41437.378439322834;41443.37834932418;42149.789251053546;42990.78504607457;42996.57003430051;41760.16479670451;42153.36769948392;42292.154156916076;42298.15403691847;42868.571314286455;41291.1741765157;41568.168636627706;42000.789996049825;42466.36300455434;42469.787651061546;34490.48264276088;37173.442398363506;38128.809355953046;39718.80140599279;40098.79950600345;29214.56178157287;29299.41401171922;29403.558946616246;29666.703332966394;29750 22:28:47 INFO - PROCESS | 8615 | |2;jquery.html;395.64787339268037;398.9740666856653;400.46537871940956;408.5281499867653;416.8645190313147;13537.59387218385;18303.816961830376;18342.908285458554;19282;19362.51593710156;15752.448664296751;15811.683766324695;15966.521004369859;19360.515987100294;19513.90243048783;5369.973150134263;5516.503514683678;5645.689487078209;5696.060150075233;5703.17303990921;5362.1420572708375;5661.915071273934;5669.574781891354;5715.657060576358;5719.571032172604;5673.6879471629045;5737.426257374271;5747.626404283729;5766.509846663039;5774.480296773289;5787.33445653751;6124.418180272867;6152.907706384408;6212.81361559154;6217.036359364306;5380.515753582196;5708.058170401879;5708.97145514274;5726.599138060337;5728.369879313273;13418.127821691558;13623.18260904339;13710.314484275847;13772.10481318711;13886.09740366883;2178.2593918067932;2223.3663405929397;2250.3586477853733;2316.5366926614743;2395.149721848736;9774.804503909952;10110.44392558409;10294.485275736184;11231.943840280828;13817.240051797147;1956.6184594004176;1987.483254353864;1987.5528006198633;1997.9100940457715;2019.545602239499;77359;80240;80707;80932.19067809306;83115.5844220775;10669.253152279265;11053.668389948314;11473.598424055119;11537.134714896416;11942.641720748392;15394;15437.84562154364;15481.922590387201;15517.612059698598;15539.5338139856;8263.586820658944;8264.421490495608;8394.748157555283;8516.318694504425;8536.914630853737;8129.309008734205;8140.877886831702;8176.3867709922;8332.291755200877;8360.832783344298;4550.817967281338;4707.364505791743;4800.831970881002;4805.231163013901;4816.566509014206;1842.7420161177447;1850.6206227723285;1866.477386331802;1879.3234435603172;1900.225670521027;457.82373786091927;467.8596421073664;477.05304969635245;958.6387329991429;1117.2570240789785;11694.47374868133;12212.389380530938;12403;12404.937975310246;12441.191322564186;468.14563421755435;472.5015109059906;485.2963203355149;492.9580985616263;512.7538781384956;6494.220693516808;6657.567258128206;6663.500237482208;6675.232348279913;6827.69275382609;489052;502984;508667;513113;517380;97514.51242743741;98638.5068074655;98905.50547247217;99670;100906.4954675222;485.06382681424486;489.9755012249373;493.09270941467156;493.6914428482199;495.9479254678207;11138.610148644759;11150.052245559218;11512.712182195512;11603.941980290045;11704.765904682028;39734.80132599318;41022.179556409304;41525.169496610506;41891.371629424975;42027;52709.47290527199;52876.735616321675;53942.73028634832;60188.69905650444;61567.69216153891;8255.958720206361;8311.6675332986;8347.499150051017;8512.787180320542;8804.075572064841;9202.953985230031;13074.215547067206;13471.906463137539;13648.385822638204;13726.65683357924;11471.770564588494;11779.116566257393;12049.518019279481;12082.214656047681;12139.453724582238;11576.826347604625;11607;11741.647750567497;12232.571859984857;12274.570390036306;11948.940255298668;12018.819717704417;12036.217645852992;12124.030077593596;12232.877671223174;8062.7581172564915;8429.4942303462;8482.066972632882;8520.36097292718;8670.91329086701;8240.13478584764;10878.448413331358;11609.187356884937;11751.353675547927;11775.470103845177 22:28:47 INFO - PROCESS | 8615 | |3;mootools.html;1508.6530098077446;1535.5470136309789;1695.5930576661597;1850.1396850464532;1855.8422534084593;7983.760487185379;8604.784880377994;8680.826383472328;9179.632814687413;9246.214071803905;8746.037935827055;9029.32280078995;9032.277417806576;9069.274458043357;9093.727188184348;2377;2416.3355077353694;2421;2428.8056955443612;2432.416220107179;2329.8369114162015;2363.3028256664325;2410.650455683925;2429.9149529766373;2443.7556244375596;2403.0387844862107;2416.516696660666;2418.7702168293986;2448.571499987495;2451.1298489036403;2348.6829278047417;2368.834181607288;2371.750966148547;2385.296337580418;2385.6421536769535;2346.1905642553293;2349.917752878641;2363.4564050268536;2373.2880135959317;2386.4869053153657;8960.686375976875;9014.098590140999;9030.683926062622;9054.456732596065;9077.500737459437;5236.764345604419;5377.166539186433;5433.049216387117;5448;5461.9453805461835;3290.7038366547126;3317.6350601433824;3329.816860072695;3350.5141754445713;3524.7356448266482;1141.8458508101382;1208.9032877369789;1216.574199030341;1236.931968741719;2073.170731707314;12544.560940367044;12577.371131443391;12673.493060277578;12718.872811271862;12723.363831808465;4549.886252843706;4564.6348292136545;4619.769011549409;4734.692245004064;4895;9770.804583908282;9825.852612210823;9846.901530984742;9886.258530610234;9929.30494865367;5271;5278.9472105278455;5285.418603953639;5305.389880163831;5312.893742125136;4314.201872653569;4687.835925742583;4844.975775121102;4858.82994095205;4923.77842997066;3656.597774244831;3732.328180927405;3766.472693822867;3782.6406491383273;3815.4086116651965;1130.5873356224918;1152.8904754048351;1163.8836116388293;1167.3287859480834;1170.0697945133638;837.5560952695081;875.3259989807813;953.3040880157524;1001.5342865567546;1007.7379881230933;6157.907631385533;6270.717817698214;6329.208848893888;6369.20384951881;6389.648569328639;945.3004776465366;994.5773046455228;1031.8804097554087;1034.912032477248;1053.4048262731533;4096.569860164699;4124.072083781125;4178.101708132766;4206.642435392964;4254.617084462351;11002.559897604006;11368.317900925971;11382.94308528452;11385.08919286455;11417.942910285561;10622.309549879388;11001.559937602566;11062.557497700001;11311.490982905789;11319.094472442184;8358;8402.537860417735;8483.490990540588;8485.787855303543;8523.275521580612;6202.906956395748;6395.456386207225;6422.389872962061;6435.292117867125;6478.578892371981;10158.339707918962;10186.643467478603;10321.329113607591;10379.702537182851;10473.581056757948;10509.421981791074;10544.947275263574;10591.947040265057;10621.044106030495;10623;7512.699492020477;7743.5353878767455;7934.20657934202;8052.637631306488;8141.22658347456;8836.602352894006;8846.46921184731;8882.467051976902;8930.062343453843;8944.105589441004;7488.850222995618;7625.389968802371;7726.806829829299;7813.804654883674;8066.153053929253;7510.774676759706;7848.489848160079;7880.960595196987;7941.801454963441;8046.879296810435;7013.859722805618;7066.57600543969;7095.538789978635;7108.644567771694;7157.105361829771;5208.218767184952;5469.699166545878;5544.223808666709;5552.111662134039;5573.1918871762555;5459.890802183854;5578.30271216098;5582.748776304995;5631.0427227372265;5812.680302583399 22:28:47 INFO - PROCESS | 8615 | |4;prototype.html;332.3983589702638;333.9949900751488;334.45149954075333;335.87572598138684;346.0362889353152;5589.217509548666;5632.295963004624;5633.943660563398;5682.210103817305;5685.800996965107;5516.255305533752;5532.640378375413;5578.330600327967;5578.693171875545;5653.519450846673;3975.522937247534;4320.719153255044;4331.350297455376;4343.78281085946;4357.542458041908;4300.397944287803;4308.138372325532;4345.130973805251;4362.738235705868;4394.296912494002;4309.095090031082;4339.698090572815;4386.539413361599;4403.735775853459;4418.315161150027;4230.957690423103;4310.849120280775;4335.84824531143;4353.67347448941;4380.167768124078;3810;3836.6547010768886;3845.4231865220163;3849.191669749356;3866.7873266970305;5291.841244762663;5328.44051374604;5331.653442526223;5397.4062853086125;5399.433059528771;4741.739204343759;4990.900181996376;4999.575036121934;5002.074616195979;5002.774875130628;5796.2464879565805;5796.913046304308;5802.663468505626;5818.5926985111055;5827.825165245049;4193.867655732965;4207.296045101739;4228.513720922103;4236.51280102789;4251.256030194703;5804.477597016289;5964.598319394939;5973.058755904349;6006.189164462785;6047.516198704093;4281.272183728774;4285.97857010713;4305.698601097955;4324;4324.8486302979245;4316.201502722007;4368.453943257093;4373.431453910971;4376.3654270130655;4381.956180438218;4567.36056952027;4840.7337596432535;4856.4415092264135;4989.775460104304;5022.648414611015;5774.451427114417;5780.971095144581;5786.623869448473;5859.736311865976;5864.618799778001;1447.5440236325524;1480.533631905946;1481.3778213150288;1483.8738707209793;1493.7004805819006;957.6879674845507;969.345691658128;969.6376590889811;999.5855863952426;1007.3401921741271;5569.749361278752;5570.387257401682;5574.498295153456;5574.888502229933;5599.32808063035;5883.852903677357;5914.6746928918465;5959.344472108065;5970.552208584373;5993.280806303272;5366.168243922199;5571.498565129158;5640.661560306395;5701.144828275792;5708.743106560131;3196.712295893334;3208.9197770055935;3220.4525230710838;3228.5480032795426;3232.288896442779;6048.304444988883;6090.878182436327;6199.442050215503;6306.747730090745;6325.335839736854;6137.171481849893;6142.385761423822;6143.416375444325;6153;6159.722812473449;6113.786017489278;6204.541932645825;6209.813705588839;6216.285127210338;6224.1597384352535;5940.46535811779;6050.667213303311;6056.424639659225;6063.211782468427;6077.574569780073;5970.940290597212;5983.670898100646;5991.820245392645;6012.579119461596;6022.638641681513;6056.45491905713;6109.106177085117;6167.352427994996;6234.345393733593;6257.5932564383165;4308.46144231971;4374.825006999685;4386.363977223221;4397;4414;5886.323072846506;5889.322727886348;6037.9094313584455;6085.847853803691;6105.877882442237;5805.709714514342;5870.911936320873;5872;5874.765009399576;5896.941030589639;5748.597598168255;5771.595988280948;5775.653460792366;5776.451237132465;5794.217780599565;5432.794651155837;5627;5696.088625819849;5696.829095127153;5709.65742055478;5794.391588883275;5827.883442331215;5863.384344643751;5901.881962360814;5917.615355002084;5471.398146203835;5759.996802222415;5763.077907534942;5788.768449262151;5838.591298609056 22:28:47 INFO - PROCESS | 8615 | |5;yui.html;747.8616455955648;775.786658668866;778.4200770426033;812.910579836218;832.1137988042736;14859;14861.925690371532;14903.40386384546;14944.327505262248;15266.389344426223;14571.19858407787;14732.26338683067;15083.170425626586;15691.60770980726;15709.371625134982;835.6824406725451;837.4598384042289;840.5629072882098;842.7345386203357;844.5988155626089;805.5327909812295;822.6503735912244;826.6280173921759;834.9248567628912;839.8236370362231;857.4897935728263;857.4940784936886;857.661223816592;857.7898414888361;859.1194026123243;844.4131328726537;852.47146769003;852.7015544559416;853.2704537620369;854.8162145138763;616.6022915219659;619.7737825693634;619.950403967686;622.0948519903529;622.2346513788066;15952.920235398864;15991.520254392386;16017.839821601869;16053.357865685359;16061.91969040159;14133.575992720132;14275.714485710332;14348.28258587077;14392.64018399538;14430.278486075758;12261.386930653433;12267.754644907052;12526.77192807683;12566.81149782754;12590.496380144783;3835.789031603261;3869.787161706105;3878.4957955465893;3880.825362858678;4018.698597605162;79184.60407697983;79277.20722792756;79917.99999999942;80435.59782201052;80470.59764701198;10969.945150274198;11028.779424411467;11164.051055660197;11281.548738050551;11416.31502109876;21936;22061.558768824532;22158.88920555419;22168.445788855406;22175.223867164896;8076.581210238844;8155.755327340189;8252.83494330122;8338.666453341919;8694.826103477895;4716.858494245178;4717.976410117927;4730.858074257778;4735.692180008288;4785.186518291899;3605.2428989912414;3721.1627383838963;3730.570984336836;3732.5147730795366;3740.8690695825517;633.7591715148214;634.6826586706646;648.2771709543824;648.4585371215088;658.2200092889941;736.3115487019654;740.9962950185322;743.7434085240583;761.1171041591728;763.904511936008;9386.85919711205;9512.476813775309;9601.519924003773;9763.26775491841;9794.862317501353;594.5124997502094;748.618204715599;756.7805336452367;758.3808568705742;762.8283636181815;4140.833911062704;4193.454850869368;4279.957200427956;4299.935500967488;4331.7834108294455;67690.66154669294;86728;108483.45758271316;116956;117140;59786.70106649439;80629;91790.54104729567;94461.5276923611;97608;82300;82396.58801705953;82993;83673.16326836654;84594;8370.832583348178;8473.5339556325;8497.362697797565;8516.381887441366;8610.913890861262;51275.48724512856;51496.48503515067;51729;51966.48033519767;53162;66018;73715;76283.61858190673;76782.2321776775;78241.60879195567;10814.45927703596;11352.886471135183;11924.642260732191;12122.393880306126;12255.142140050111;11855.76288474243;11900.226485278428;11907.464164112462;11928.940355298168;12188.57339993096;10399.596558766012;10596.682099537025;10921.123555129589;11135.83296250573;11240.269382490113;11646.883531164918;11691.707707307385;11965.820512692142;12266.448009839758;12282.385880706108;10747.925207479502;10941.124710023338;10953.890461095287;11044.447777611247;11669.708257293636;9254.953725231331;9358.859617105885;9777.266704997011;9781.217502599633;9982.850257246002;9187.77030574241;9853.901460985298;9938.751531211778;9979.251556133175;10016.098551130433 22:28:47 INFO - PROCESS | 8615 | __end_tp_report 22:28:47 INFO - PROCESS | 8615 | __start_cc_report 22:28:47 INFO - PROCESS | 8615 | _x_x_mozilla_cycle_collect,343 22:28:47 INFO - PROCESS | 8615 | __end_cc_report 22:28:47 INFO - PROCESS | 8615 | __startTimestamp1464845327546__endTimestamp 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | ------- Summary: start ------- 22:28:47 INFO - PROCESS | 8615 | Number of tests: 6 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#0] dojo.html Cycles:165 Average:5574.39 Median:5841.00 stddev:757.61 (13.0%) stddev-sans-first:735.19 22:28:47 INFO - PROCESS | 8615 | Values: 3126.4 3153.3 3224.2 3246.8 3253.9 5567.7 5584.2 5608.5 5650.3 5664.6 5504.4 5560.6 5562.8 5564.2 5597.1 5011.3 5076.5 5185.8 5232.8 5247.7 882.7 5032.6 5102.2 5156.7 5181.1 5137.1 5163.6 5210.1 5217.8 5219.9 5178.6 5206.9 5227.9 5228.9 5257.9 5004.1 5089.9 5131.7 5157.2 5196.2 5527.6 5585.4 5603.3 5622.6 5648.9 5839.6 6049.2 6050.2 6050.2 6069.6 5997.6 6060.0 6107.1 6156.4 6159.2 5663.5 5680.7 5684.9 5689.5 5695.6 6007.5 6010.9 6028.5 6031.3 6133.5 5867.4 5948.8 5980.9 5982.9 6018.7 5960.7 5978.1 6036.0 6048.0 6056.9 5856.1 5883.9 5925.3 5970.7 6022.5 6016.7 6049.3 6065.1 6070.4 6072.5 4515.2 4516.4 4517.4 4523.4 4560.2 3963.9 3976.9 4032.3 4044.3 4070.5 5621.3 5706.5 5726.5 5749.0 5762.6 6079.9 6132.6 6139.9 6143.6 6152.5 5606.0 5672.7 5680.9 5726.8 5751.1 4989.0 5003.2 5014.4 5016.1 5017.7 6272.5 6288.8 6306.7 6313.3 6327.2 5869.0 6043.6 6084.1 6088.6 6198.2 6327.1 6339.3 6388.0 6409.7 6411.2 5873.9 6042.9 6073.5 6086.3 6086.5 5961.8 6012.3 6058.7 6088.4 6107.9 5894.0 5907.4 5914.5 5932.9 5937.6 5696.1 5849.6 5898.1 5909.1 5934.9 5757.7 5820.8 5841.0 5881.5 5882.4 5927.1 5938.4 5963.6 5966.5 5982.8 5673.7 5731.8 5776.8 5832.4 5880.3 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#1] ext.html Cycles:180 Average:59771.02 Median:41778.77 stddev:122020.49 (292.1%) stddev-sans-first:122281.88 22:28:47 INFO - PROCESS | 8615 | Values: 588.9 611.3 613.1 630.5 648.4 38827.0 43451.0 43573.8 43645.3 43677.3 44619.3 45405.3 45426.1 45578.5 45672.8 8680.1 8813.8 8815.1 8858.2 8871.3 8620.5 8714.7 8779.7 8806.0 8806.4 8741.9 8804.1 8863.1 8895.7 8904.5 8785.5 8814.6 8824.2 8833.6 8855.2 8663.2 8747.2 8761.8 8771.8 8782.5 41494.2 41755.0 41797.4 42118.8 42336.4 3572.9 3684.5 3779.6 3832.7 4016.6 32210.7 32647.3 32796.2 32901.0 32912.5 4411.8 4571.5 4664.5 4680.6 4695.8 338240.0 338528.0 339644.0 340442.0 340952.3 33795.3 34770.1 34958.5 36816.0 60377.1 36881.4 37024.0 37104.3 37112.3 37126.4 15397.7 15481.0 15528.8 15535.8 15578.8 12975.3 13079.5 13085.3 13097.1 13103.8 8352.1 8375.8 8431.6 8480.2 8492.0 3249.3 3269.6 3278.1 3284.3 3308.5 997.2 1070.5 1118.2 1126.3 1190.7 29918.3 32347.2 32536.5 32606.3 32712.3 1144.8 1149.1 1174.7 1235.2 1282.0 16796.2 17186.1 17341.7 17352.9 17459.6 557586.0 561865.0 562875.0 563825.0 565967.0 60103.7 60653.7 60822.4 60864.7 60934.1 1352.5 1377.2 1383.8 1397.3 1403.1 30787.0 31968.5 31976.7 32115.0 32690.3 52029.5 53070.7 53139.7 53194.0 53236.5 436106.0 446879.0 449030.0 450416.0 451123.0 28074.3 28076.4 28282.0 28416.3 28471.6 48258.8 48919.3 49379.0 50293.5 50743.0 41437.4 41443.4 42149.8 42990.8 42996.6 41760.2 42153.4 42292.2 42298.2 42868.6 41291.2 41568.2 42000.8 42466.4 42469.8 34490.5 37173.4 38128.8 39718.8 40098.8 29214.6 29299.4 29403.6 29666.7 29750.0 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#2] jquery.html Cycles:180 Average:28742.28 Median:462.84 stddev:83672.81 (18078.1%) stddev-sans-first:83880.46 22:28:47 INFO - PROCESS | 8615 | Values: 395.6 399.0 400.5 408.5 416.9 13537.6 18303.8 18342.9 19282.0 19362.5 15752.4 15811.7 15966.5 19360.5 19513.9 5370.0 5516.5 5645.7 5696.1 5703.2 5362.1 5661.9 5669.6 5715.7 5719.6 5673.7 5737.4 5747.6 5766.5 5774.5 5787.3 6124.4 6152.9 6212.8 6217.0 5380.5 5708.1 5709.0 5726.6 5728.4 13418.1 13623.2 13710.3 13772.1 13886.1 2178.3 2223.4 2250.4 2316.5 2395.1 9774.8 10110.4 10294.5 11231.9 13817.2 1956.6 1987.5 1987.6 1997.9 2019.5 77359.0 80240.0 80707.0 80932.2 83115.6 10669.3 11053.7 11473.6 11537.1 11942.6 15394.0 15437.8 15481.9 15517.6 15539.5 8263.6 8264.4 8394.7 8516.3 8536.9 8129.3 8140.9 8176.4 8332.3 8360.8 4550.8 4707.4 4800.8 4805.2 4816.6 1842.7 1850.6 1866.5 1879.3 1900.2 457.8 467.9 477.1 958.6 1117.3 11694.5 12212.4 12403.0 12404.9 12441.2 468.1 472.5 485.3 493.0 512.8 6494.2 6657.6 6663.5 6675.2 6827.7 489052.0 502984.0 508667.0 513113.0 517380.0 97514.5 98638.5 98905.5 99670.0 100906.5 485.1 490.0 493.1 493.7 495.9 11138.6 11150.1 11512.7 11603.9 11704.8 39734.8 41022.2 41525.2 41891.4 42027.0 52709.5 52876.7 53942.7 60188.7 61567.7 8256.0 8311.7 8347.5 8512.8 8804.1 9203.0 13074.2 13471.9 13648.4 13726.7 11471.8 11779.1 12049.5 12082.2 12139.5 11576.8 11607.0 11741.6 12232.6 12274.6 11948.9 12018.8 12036.2 12124.0 12232.9 8062.8 8429.5 8482.1 8520.4 8670.9 8240.1 10878.4 11609.2 11751.4 11775.5 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#3] mootools.html Cycles:180 Average:5935.90 Median:4789.83 stddev:3356.53 (70.1%) stddev-sans-first:3349.46 22:28:47 INFO - PROCESS | 8615 | Values: 1508.7 1535.5 1695.6 1850.1 1855.8 7983.8 8604.8 8680.8 9179.6 9246.2 8746.0 9029.3 9032.3 9069.3 9093.7 2377.0 2416.3 2421.0 2428.8 2432.4 2329.8 2363.3 2410.7 2429.9 2443.8 2403.0 2416.5 2418.8 2448.6 2451.1 2348.7 2368.8 2371.8 2385.3 2385.6 2346.2 2349.9 2363.5 2373.3 2386.5 8960.7 9014.1 9030.7 9054.5 9077.5 5236.8 5377.2 5433.0 5448.0 5461.9 3290.7 3317.6 3329.8 3350.5 3524.7 1141.8 1208.9 1216.6 1236.9 2073.2 12544.6 12577.4 12673.5 12718.9 12723.4 4549.9 4564.6 4619.8 4734.7 4895.0 9770.8 9825.9 9846.9 9886.3 9929.3 5271.0 5278.9 5285.4 5305.4 5312.9 4314.2 4687.8 4845.0 4858.8 4923.8 3656.6 3732.3 3766.5 3782.6 3815.4 1130.6 1152.9 1163.9 1167.3 1170.1 837.6 875.3 953.3 1001.5 1007.7 6157.9 6270.7 6329.2 6369.2 6389.6 945.3 994.6 1031.9 1034.9 1053.4 4096.6 4124.1 4178.1 4206.6 4254.6 11002.6 11368.3 11382.9 11385.1 11417.9 10622.3 11001.6 11062.6 11311.5 11319.1 8358.0 8402.5 8483.5 8485.8 8523.3 6202.9 6395.5 6422.4 6435.3 6478.6 10158.3 10186.6 10321.3 10379.7 10473.6 10509.4 10544.9 10591.9 10621.0 10623.0 7512.7 7743.5 7934.2 8052.6 8141.2 8836.6 8846.5 8882.5 8930.1 8944.1 7488.9 7625.4 7726.8 7813.8 8066.2 7510.8 7848.5 7881.0 7941.8 8046.9 7013.9 7066.6 7095.5 7108.6 7157.1 5208.2 5469.7 5544.2 5552.1 5573.2 5459.9 5578.3 5582.7 5631.0 5812.7 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#4] prototype.html Cycles:180 Average:4918.96 Median:5629.65 stddev:1445.23 (25.7%) stddev-sans-first:1407.69 22:28:47 INFO - PROCESS | 8615 | Values: 332.4 334.0 334.5 335.9 346.0 5589.2 5632.3 5633.9 5682.2 5685.8 5516.3 5532.6 5578.3 5578.7 5653.5 3975.5 4320.7 4331.4 4343.8 4357.5 4300.4 4308.1 4345.1 4362.7 4394.3 4309.1 4339.7 4386.5 4403.7 4418.3 4231.0 4310.8 4335.8 4353.7 4380.2 3810.0 3836.7 3845.4 3849.2 3866.8 5291.8 5328.4 5331.7 5397.4 5399.4 4741.7 4990.9 4999.6 5002.1 5002.8 5796.2 5796.9 5802.7 5818.6 5827.8 4193.9 4207.3 4228.5 4236.5 4251.3 5804.5 5964.6 5973.1 6006.2 6047.5 4281.3 4286.0 4305.7 4324.0 4324.8 4316.2 4368.5 4373.4 4376.4 4382.0 4567.4 4840.7 4856.4 4989.8 5022.6 5774.5 5781.0 5786.6 5859.7 5864.6 1447.5 1480.5 1481.4 1483.9 1493.7 957.7 969.3 969.6 999.6 1007.3 5569.7 5570.4 5574.5 5574.9 5599.3 5883.9 5914.7 5959.3 5970.6 5993.3 5366.2 5571.5 5640.7 5701.1 5708.7 3196.7 3208.9 3220.5 3228.5 3232.3 6048.3 6090.9 6199.4 6306.7 6325.3 6137.2 6142.4 6143.4 6153.0 6159.7 6113.8 6204.5 6209.8 6216.3 6224.2 5940.5 6050.7 6056.4 6063.2 6077.6 5970.9 5983.7 5991.8 6012.6 6022.6 6056.5 6109.1 6167.4 6234.3 6257.6 4308.5 4374.8 4386.4 4397.0 4414.0 5886.3 5889.3 6037.9 6085.8 6105.9 5805.7 5870.9 5872.0 5874.8 5896.9 5748.6 5771.6 5775.7 5776.5 5794.2 5432.8 5627.0 5696.1 5696.8 5709.7 5794.4 5827.9 5863.4 5901.9 5917.6 5471.4 5760.0 5763.1 5788.8 5838.6 22:28:47 INFO - PROCESS | 8615 | 22:28:47 INFO - PROCESS | 8615 | [#5] yui.html Cycles:180 Average:19624.64 Median:30201.65 stddev:28039.59 (92.8%) stddev-sans-first:28082.42 22:28:47 INFO - PROCESS | 8615 | Values: 747.9 775.8 778.4 812.9 832.1 14859.0 14861.9 14903.4 14944.3 15266.4 14571.2 14732.3 15083.2 15691.6 15709.4 835.7 837.5 840.6 842.7 844.6 805.5 822.7 826.6 834.9 839.8 857.5 857.5 857.7 857.8 859.1 844.4 852.5 852.7 853.3 854.8 616.6 619.8 620.0 622.1 622.2 15952.9 15991.5 16017.8 16053.4 16061.9 14133.6 14275.7 14348.3 14392.6 14430.3 12261.4 12267.8 12526.8 12566.8 12590.5 3835.8 3869.8 3878.5 3880.8 4018.7 79184.6 79277.2 79918.0 80435.6 80470.6 10969.9 11028.8 11164.1 11281.5 11416.3 21936.0 22061.6 22158.9 22168.4 22175.2 8076.6 8155.8 8252.8 8338.7 8694.8 4716.9 4718.0 4730.9 4735.7 4785.2 3605.2 3721.2 3730.6 3732.5 3740.9 633.8 634.7 648.3 648.5 658.2 736.3 741.0 743.7 761.1 763.9 9386.9 9512.5 9601.5 9763.3 9794.9 594.5 748.6 756.8 758.4 762.8 4140.8 4193.5 4280.0 4299.9 4331.8 67690.7 86728.0 108483.5 116956.0 117140.0 59786.7 80629.0 91790.5 94461.5 97608.0 82300.0 82396.6 82993.0 83673.2 84594.0 8370.8 8473.5 8497.4 8516.4 8610.9 51275.5 51496.5 51729.0 51966.5 53162.0 66018.0 73715.0 76283.6 76782.2 78241.6 10814.5 11352.9 11924.6 12122.4 12255.1 11855.8 11900.2 11907.5 11928.9 12188.6 10399.6 10596.7 10921.1 11135.8 11240.3 11646.9 11691.7 11965.8 12266.4 12282.4 10747.9 10941.1 10953.9 11044.4 11669.7 9255.0 9358.9 9777.3 9781.2 9982.9 9187.8 9853.9 9938.8 9979.3 10016.1 22:28:47 INFO - PROCESS | 8615 | -------- Summary: end -------- 22:28:47 INFO - PROCESS | 8615 | 22:28:48 INFO - TEST-INFO | 8615: exit 0 22:28:48 INFO - TEST-OK | dromaeo_css | took 1110805ms 22:28:48 INFO - TEST-START | kraken 22:28:48 INFO - operating with platform_type : linux_ 22:28:48 INFO - Initialising browser for kraken test... 22:28:48 INFO - TEST-INFO | started process 8852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPQJPt/profile http://localhost:57610/getInfo.html) 22:28:53 INFO - PROCESS | 8852 | __metrics Screen width/height:1600/1200 22:28:53 INFO - PROCESS | 8852 | colorDepth:24 22:28:53 INFO - PROCESS | 8852 | Browser inner width/height: 1024/697 22:28:53 INFO - PROCESS | 8852 | __metrics 22:28:53 ERROR - PROCESS | 8852 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:28:54 INFO - TEST-INFO | 8852: exit 0 22:28:54 INFO - Browser initialized. 22:28:54 INFO - Running cycle 1/1 for kraken test... 22:28:54 INFO - TEST-INFO | started process 8971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPQJPt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:06 INFO - PROCESS | 8971 | RSS: Main: 166965248 22:29:06 INFO - PROCESS | 8971 | 22:29:08 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57610/tests/kraken/driver.html?testName=audio-beat-detection) 22:29:09 INFO - PROCESS | 8971 | RSS: Main: 172048384 22:29:09 INFO - PROCESS | 8971 | 22:29:12 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57610/tests/kraken/driver.html?testName=audio-dft) 22:29:13 INFO - PROCESS | 8971 | RSS: Main: 171724800 22:29:13 INFO - PROCESS | 8971 | 22:29:15 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57610/tests/kraken/driver.html?testName=audio-fft) 22:29:16 INFO - PROCESS | 8971 | RSS: Main: 166649856 22:29:16 INFO - PROCESS | 8971 | 22:29:18 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57610/tests/kraken/driver.html?testName=audio-oscillator) 22:29:19 INFO - PROCESS | 8971 | RSS: Main: 167120896 22:29:19 INFO - PROCESS | 8971 | 22:29:21 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:29:22 INFO - PROCESS | 8971 | RSS: Main: 167395328 22:29:22 INFO - PROCESS | 8971 | 22:29:25 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57610/tests/kraken/driver.html?testName=imaging-darkroom) 22:29:25 INFO - PROCESS | 8971 | RSS: Main: 167120896 22:29:25 INFO - PROCESS | 8971 | 22:29:29 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57610/tests/kraken/driver.html?testName=imaging-desaturate) 22:29:29 INFO - PROCESS | 8971 | RSS: Main: 165400576 22:29:29 INFO - PROCESS | 8971 | 22:29:32 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57610/tests/kraken/driver.html?testName=json-parse-financial) 22:29:33 INFO - PROCESS | 8971 | RSS: Main: 167096320 22:29:33 INFO - PROCESS | 8971 | 22:29:34 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:29:35 INFO - PROCESS | 8971 | RSS: Main: 167186432 22:29:35 INFO - PROCESS | 8971 | 22:29:37 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:29:38 INFO - PROCESS | 8971 | RSS: Main: 167256064 22:29:38 INFO - PROCESS | 8971 | 22:29:40 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:29:40 INFO - PROCESS | 8971 | RSS: Main: 167948288 22:29:40 INFO - PROCESS | 8971 | 22:29:43 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:29:43 INFO - PROCESS | 8971 | RSS: Main: 168177664 22:29:43 INFO - PROCESS | 8971 | 22:29:46 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:29:47 INFO - PROCESS | 8971 | RSS: Main: 168267776 22:29:47 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:57610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57610/tests/kraken/driver.html?testName=ai-astar) 22:29:49 INFO - PROCESS | 8971 | RSS: Main: 168591360 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | __start_tp_report 22:29:49 INFO - PROCESS | 8971 | _x_x_mozilla_page_load 22:29:49 INFO - PROCESS | 8971 | _x_x_mozilla_page_load_details 22:29:49 INFO - PROCESS | 8971 | |i|pagename|runs| 22:29:49 INFO - PROCESS | 8971 | |0;ai-astar;112;107;110;112;112;113;112;111;112;111 22:29:49 INFO - PROCESS | 8971 | |1;audio-beat-detection;152;132;154;179;128;153;157;128;176;126 22:29:49 INFO - PROCESS | 8971 | |2;audio-dft;161;161;163;162;163;166;173;161;160;162 22:29:49 INFO - PROCESS | 8971 | |3;audio-fft;75;75;74;162;76;75;73;75;167;75 22:29:49 INFO - PROCESS | 8971 | |4;audio-oscillator;83;86;150;85;83;84;137;83;83;140 22:29:49 INFO - PROCESS | 8971 | |5;imaging-gaussian-blur;117;117;117;117;122;118;117;118;118;117 22:29:49 INFO - PROCESS | 8971 | |6;imaging-darkroom;146;148;146;146;146;149;148;147;147;148 22:29:49 INFO - PROCESS | 8971 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;95;96 22:29:49 INFO - PROCESS | 8971 | |8;json-parse-financial;55;55;55;54;55;54;55;53;55;55 22:29:49 INFO - PROCESS | 8971 | |9;json-stringify-tinderbox;61;61;62;61;62;61;61;63;62;61 22:29:49 INFO - PROCESS | 8971 | |10;stanford-crypto-aes;82;84;83;80;80;81;84;84;106;81 22:29:49 INFO - PROCESS | 8971 | |11;stanford-crypto-ccm;125;125;122;121;122;121;128;126;125;132 22:29:49 INFO - PROCESS | 8971 | |12;stanford-crypto-pbkdf2;164;168;168;165;168;168;167;163;162;170 22:29:49 INFO - PROCESS | 8971 | |13;stanford-crypto-sha256-iterative;64;65;64;66;65;63;62;63;63;63 22:29:49 INFO - PROCESS | 8971 | __end_tp_report 22:29:49 INFO - PROCESS | 8971 | __start_cc_report 22:29:49 INFO - PROCESS | 8971 | _x_x_mozilla_cycle_collect,837 22:29:49 INFO - PROCESS | 8971 | __end_cc_report 22:29:49 INFO - PROCESS | 8971 | __startTimestamp1464845389272__endTimestamp 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | ------- Summary: start ------- 22:29:49 INFO - PROCESS | 8971 | Number of tests: 14 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.69 (1.5%) stddev-sans-first:1.76 22:29:49 INFO - PROCESS | 8971 | Values: 112.0 107.0 110.0 112.0 112.0 113.0 112.0 111.0 112.0 111.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:19.55 (12.7%) stddev-sans-first:20.70 22:29:49 INFO - PROCESS | 8971 | Values: 152.0 132.0 154.0 179.0 128.0 153.0 157.0 128.0 176.0 126.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.82 (2.4%) stddev-sans-first:3.97 22:29:49 INFO - PROCESS | 8971 | Values: 161.0 161.0 163.0 162.0 163.0 166.0 173.0 161.0 160.0 162.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:37.87 (50.5%) stddev-sans-first:39.62 22:29:49 INFO - PROCESS | 8971 | Values: 75.0 75.0 74.0 162.0 76.0 75.0 73.0 75.0 167.0 75.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.00 stddev:28.45 (34.3%) stddev-sans-first:29.38 22:29:49 INFO - PROCESS | 8971 | Values: 83.0 86.0 150.0 85.0 83.0 84.0 137.0 83.0 83.0 140.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.55 (1.3%) stddev-sans-first:1.62 22:29:49 INFO - PROCESS | 8971 | Values: 117.0 117.0 117.0 117.0 122.0 118.0 117.0 118.0 118.0 117.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 22:29:49 INFO - PROCESS | 8971 | Values: 146.0 148.0 146.0 146.0 146.0 149.0 148.0 147.0 147.0 148.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:29:49 INFO - PROCESS | 8971 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 22:29:49 INFO - PROCESS | 8971 | Values: 55.0 55.0 55.0 54.0 55.0 54.0 55.0 53.0 55.0 55.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 22:29:49 INFO - PROCESS | 8971 | Values: 61.0 61.0 62.0 61.0 62.0 61.0 61.0 63.0 62.0 61.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.50 stddev:7.72 (9.4%) stddev-sans-first:8.14 22:29:49 INFO - PROCESS | 8971 | Values: 82.0 84.0 83.0 80.0 80.0 81.0 84.0 84.0 106.0 81.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:125.00 stddev:3.47 (2.8%) stddev-sans-first:3.67 22:29:49 INFO - PROCESS | 8971 | Values: 125.0 125.0 122.0 121.0 122.0 121.0 128.0 126.0 125.0 132.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:168.00 stddev:2.63 (1.6%) stddev-sans-first:2.65 22:29:49 INFO - PROCESS | 8971 | Values: 164.0 168.0 168.0 165.0 168.0 168.0 167.0 163.0 162.0 170.0 22:29:49 INFO - PROCESS | 8971 | 22:29:49 INFO - PROCESS | 8971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 22:29:49 INFO - PROCESS | 8971 | Values: 64.0 65.0 64.0 66.0 65.0 63.0 62.0 63.0 63.0 63.0 22:29:49 INFO - PROCESS | 8971 | -------- Summary: end -------- 22:29:49 INFO - PROCESS | 8971 | 22:29:50 INFO - TEST-INFO | 8971: exit 0 22:29:50 INFO - TEST-OK | kraken | took 62003ms 22:29:50 INFO - SUITE-END | took 1172s 22:29:50 INFO - Completed test suite (00:19:32) 22:29:50 INFO - javascript benchmark 22:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7168.619042548348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.4372412965663, 3153.306272620024, 3224.1617179533314, 3246.805191688499, 3253.9349213015753, 5567.749451274693, 5584.246126772884, 5608.467195616415, 5650.321961364642, 5664.603477756558, 5504.366997795255, 5560.582956278275, 5562.7774889004395, 5564.248826408434, 5597.104463285875, 5011.298418221452, 5076.517730815566, 5185.818496352628, 5232.843014709546, 5247.685138891659, 882.7092622528027, 5032.622553308498, 5102.234664800272, 5156.716380599066, 5181.0933086709865, 5137.101007323722, 5163.638545301812, 5210.114280572312, 5217.817376391827, 5219.921701174486, 5178.559822415099, 5206.947930520722, 5227.947720522784, 5228.895422091575, 5257.894842103175, 5004.074246264453, 5089.898202035975, 5131.692098474104, 5157.226416037587, 5196.168613021899, 5527.640703354269, 5585.385607583163, 5603.327600687903, 5622.634528755659, 5648.85877853057, 5839.591228613998, 6049.213602231725, 6050.152978583002, 6050.2437195350585, 6069.605475644069, 5997.550183736237, 6059.969700151515, 6107.144999700045, 6156.3843615638525, 6159.168512250833, 5663.546916246691, 5680.687562184078, 5684.857878553028, 5689.459501347365, 5695.601307908407, 6007.459328660441, 6010.939890601126, 6028.5478589106, 6031.306399764083, 6133.509319254449, 5867.442592953663, 5948.821535353946, 5980.940190598125, 5982.850428739316, 6018.668973206516, 5960.7019649017375, 5978.133170690226, 6035.969820150871, 6048.0, 6056.878862422727, 5856.063029915278, 5883.911741323884, 5925.259342582177, 5970.701464926737, 6022.488088512526, 6016.69916504173, 6049.274087109487, 6065.120557519135, 6070.3929607038945, 6072.51419886408, 4515.2324104902245, 4516.435445569304, 4517.435320584927, 4523.411956445641, 4560.247559152769, 3963.8612648557164, 3976.8608098716986, 4032.2540330039037, 4044.2518134145275, 4070.4911886014247, 5621.269234999506, 5706.457886500776, 5726.513246374105, 5749.0, 5762.625429347079, 6079.878402431927, 6132.570720049643, 6139.877202455926, 6143.600665956698, 6152.477039451696, 5606.046972014768, 5672.716364181774, 5680.943190568041, 5726.79956201531, 5751.1373294006235, 4989.0, 5003.224500202475, 5014.414693494169, 5016.072026675077, 5017.7491125443585, 6272.466840318532, 6288.811335659938, 6306.684665766693, 6313.337099604567, 6327.240731112296, 5868.970655146697, 6043.576949613661, 6084.14821924922, 6088.6042407243385, 6198.163247961467, 6327.11420401135, 6339.302676705466, 6388.0, 6409.679516024274, 6411.198600174978, 5873.853153671193, 6042.939570604413, 6073.514118870391, 6086.3000754913755, 6086.452219300107, 5961.7615295387695, 6012.278526576839, 6058.697065146813, 6088.3911608840535, 6107.938920610737, 5894.0, 5907.379725128972, 5914.467697907209, 5932.851678708067, 5937.614055086406, 5696.060150075357, 5849.64902105875, 5898.144769008384, 5909.143174239797, 5934.9406505934385, 5757.65454072757, 5820.82537523858, 5841.0, 5881.470667639933, 5882.382349853375, 5927.14056461802, 5938.376470470538, 5963.612365196248, 5966.522678185822, 5982.820515384546, 5673.744681489426, 5731.828045158652, 5776.797812076557, 5832.387599302182, 5880.294364676266], "value": 5522.666186258221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9322727886295, 611.2634275697784, 613.1232337757006, 630.508203601191, 648.3969907985578, 38827.0, 43451.0, 43573.78213108934, 43645.290150337256, 43677.34483982739, 44619.33071003937, 45405.318920216225, 45426.09147817042, 45578.54421455784, 45672.77163614177, 8680.088590697964, 8813.823723525526, 8815.118488151165, 8858.202761751441, 8871.334649901251, 8620.525871077089, 8714.694985675502, 8779.692710755126, 8805.95597022014, 8806.427582207136, 8741.868871966893, 8804.075572064938, 8863.069377715343, 8895.68865089722, 8904.465732056098, 8785.472871627691, 8814.603342849587, 8824.249938755149, 8833.646654133827, 8855.203031727111, 8663.220310172052, 8747.16901894319, 8761.7809554761, 8771.78070548235, 8782.47305161686, 41494.1701165978, 41755.0, 41797.37303940413, 42118.789406052776, 42336.36495452571, 3572.9285414291567, 3684.5394325709285, 3779.6031416701126, 3832.693384529231, 4016.5581786003518, 32210.677893221236, 32647.347053058806, 32796.18009549756, 32901.0, 32912.506312405334, 4411.779411029435, 4571.542845715435, 4664.5335466453425, 4680.648951328664, 4695.7886895089805, 338240.0, 338528.0, 339644.0, 340442.0, 340952.2952385247, 33795.32409351799, 34770.130746731025, 34958.47562286568, 36816.0, 60377.09434358488, 36881.44677829781, 37024.0, 37104.25791484155, 37112.25775484475, 37126.44310335347, 15397.692046159238, 15481.0, 15528.844711552965, 15535.844641553665, 15578.84421155774, 12975.286359250144, 13079.476820927057, 13085.280309583064, 13097.083204175808, 13103.803442948363, 8352.12302708219, 8375.790605234917, 8431.57842107892, 8480.15198480147, 8491.95754021226, 3249.333886553251, 3269.6076470823655, 3278.131295206772, 3284.3267130238246, 3308.4871844864083, 997.217184510156, 1070.5075665194097, 1118.1948996722347, 1126.2566705974018, 1190.7142285851332, 29918.252043698645, 32347.191320216712, 32536.511952320736, 32606.34787304288, 32712.34575308528, 1144.822552504363, 1149.0979581028853, 1174.747429302687, 1235.1539195651008, 1281.9551315704093, 16796.16019199035, 17186.140692965302, 17341.7398739019, 17352.913235433996, 17459.56351091233, 557586.0, 561865.0, 562875.0, 563825.0, 565967.0, 60103.69948150231, 60653.69673151606, 60822.39177608167, 60864.69567652133, 60934.085988710205, 1352.5198554513204, 1377.1805775563523, 1383.75784237758, 1397.322298685137, 1403.1230480949407, 30787.0, 31968.52047219247, 31976.68023319737, 32115.0, 32690.346193076482, 52029.479705202466, 53070.73464632652, 53139.734301328244, 53194.0, 53236.4676353247, 436106.0, 446879.0, 449030.0, 450416.0, 451123.0, 28074.2981425466, 28076.43847123087, 28282.0, 28416.289592760346, 28471.572926406534, 48258.758706206245, 48919.26621100615, 49379.0, 50293.497065030344, 50743.0, 41437.378439322834, 41443.37834932418, 42149.789251053546, 42990.78504607457, 42996.57003430051, 41760.16479670451, 42153.36769948392, 42292.154156916076, 42298.15403691847, 42868.571314286455, 41291.1741765157, 41568.168636627706, 42000.789996049825, 42466.36300455434, 42469.787651061546, 34490.48264276088, 37173.442398363506, 38128.809355953046, 39718.80140599279, 40098.79950600345, 29214.56178157287, 29299.41401171922, 29403.558946616246, 29666.703332966394, 29750.0], "value": 19090.873662966762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.64787339268037, 398.9740666856653, 400.46537871940956, 408.5281499867653, 416.8645190313147, 13537.59387218385, 18303.816961830376, 18342.908285458554, 19282.0, 19362.51593710156, 15752.448664296751, 15811.683766324695, 15966.521004369859, 19360.515987100294, 19513.90243048783, 5369.973150134263, 5516.503514683678, 5645.689487078209, 5696.060150075233, 5703.17303990921, 5362.1420572708375, 5661.915071273934, 5669.574781891354, 5715.657060576358, 5719.571032172604, 5673.6879471629045, 5737.426257374271, 5747.626404283729, 5766.509846663039, 5774.480296773289, 5787.33445653751, 6124.418180272867, 6152.907706384408, 6212.81361559154, 6217.036359364306, 5380.515753582196, 5708.058170401879, 5708.97145514274, 5726.599138060337, 5728.369879313273, 13418.127821691558, 13623.18260904339, 13710.314484275847, 13772.10481318711, 13886.09740366883, 2178.2593918067932, 2223.3663405929397, 2250.3586477853733, 2316.5366926614743, 2395.149721848736, 9774.804503909952, 10110.44392558409, 10294.485275736184, 11231.943840280828, 13817.240051797147, 1956.6184594004176, 1987.483254353864, 1987.5528006198633, 1997.9100940457715, 2019.545602239499, 77359.0, 80240.0, 80707.0, 80932.19067809306, 83115.5844220775, 10669.253152279265, 11053.668389948314, 11473.598424055119, 11537.134714896416, 11942.641720748392, 15394.0, 15437.84562154364, 15481.922590387201, 15517.612059698598, 15539.5338139856, 8263.586820658944, 8264.421490495608, 8394.748157555283, 8516.318694504425, 8536.914630853737, 8129.309008734205, 8140.877886831702, 8176.3867709922, 8332.291755200877, 8360.832783344298, 4550.817967281338, 4707.364505791743, 4800.831970881002, 4805.231163013901, 4816.566509014206, 1842.7420161177447, 1850.6206227723285, 1866.477386331802, 1879.3234435603172, 1900.225670521027, 457.82373786091927, 467.8596421073664, 477.05304969635245, 958.6387329991429, 1117.2570240789785, 11694.47374868133, 12212.389380530938, 12403.0, 12404.937975310246, 12441.191322564186, 468.14563421755435, 472.5015109059906, 485.2963203355149, 492.9580985616263, 512.7538781384956, 6494.220693516808, 6657.567258128206, 6663.500237482208, 6675.232348279913, 6827.69275382609, 489052.0, 502984.0, 508667.0, 513113.0, 517380.0, 97514.51242743741, 98638.5068074655, 98905.50547247217, 99670.0, 100906.4954675222, 485.06382681424486, 489.9755012249373, 493.09270941467156, 493.6914428482199, 495.9479254678207, 11138.610148644759, 11150.052245559218, 11512.712182195512, 11603.941980290045, 11704.765904682028, 39734.80132599318, 41022.179556409304, 41525.169496610506, 41891.371629424975, 42027.0, 52709.47290527199, 52876.735616321675, 53942.73028634832, 60188.69905650444, 61567.69216153891, 8255.958720206361, 8311.6675332986, 8347.499150051017, 8512.787180320542, 8804.075572064841, 9202.953985230031, 13074.215547067206, 13471.906463137539, 13648.385822638204, 13726.65683357924, 11471.770564588494, 11779.116566257393, 12049.518019279481, 12082.214656047681, 12139.453724582238, 11576.826347604625, 11607.0, 11741.647750567497, 12232.571859984857, 12274.570390036306, 11948.940255298668, 12018.819717704417, 12036.217645852992, 12124.030077593596, 12232.877671223174, 8062.7581172564915, 8429.4942303462, 8482.066972632882, 8520.36097292718, 8670.91329086701, 8240.13478584764, 10878.448413331358, 11609.187356884937, 11751.353675547927, 11775.470103845177], "value": 8327.716509448022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.6530098077446, 1535.5470136309789, 1695.5930576661597, 1850.1396850464532, 1855.8422534084593, 7983.760487185379, 8604.784880377994, 8680.826383472328, 9179.632814687413, 9246.214071803905, 8746.037935827055, 9029.32280078995, 9032.277417806576, 9069.274458043357, 9093.727188184348, 2377.0, 2416.3355077353694, 2421.0, 2428.8056955443612, 2432.416220107179, 2329.8369114162015, 2363.3028256664325, 2410.650455683925, 2429.9149529766373, 2443.7556244375596, 2403.0387844862107, 2416.516696660666, 2418.7702168293986, 2448.571499987495, 2451.1298489036403, 2348.6829278047417, 2368.834181607288, 2371.750966148547, 2385.296337580418, 2385.6421536769535, 2346.1905642553293, 2349.917752878641, 2363.4564050268536, 2373.2880135959317, 2386.4869053153657, 8960.686375976875, 9014.098590140999, 9030.683926062622, 9054.456732596065, 9077.500737459437, 5236.764345604419, 5377.166539186433, 5433.049216387117, 5448.0, 5461.9453805461835, 3290.7038366547126, 3317.6350601433824, 3329.816860072695, 3350.5141754445713, 3524.7356448266482, 1141.8458508101382, 1208.9032877369789, 1216.574199030341, 1236.931968741719, 2073.170731707314, 12544.560940367044, 12577.371131443391, 12673.493060277578, 12718.872811271862, 12723.363831808465, 4549.886252843706, 4564.6348292136545, 4619.769011549409, 4734.692245004064, 4895.0, 9770.804583908282, 9825.852612210823, 9846.901530984742, 9886.258530610234, 9929.30494865367, 5271.0, 5278.9472105278455, 5285.418603953639, 5305.389880163831, 5312.893742125136, 4314.201872653569, 4687.835925742583, 4844.975775121102, 4858.82994095205, 4923.77842997066, 3656.597774244831, 3732.328180927405, 3766.472693822867, 3782.6406491383273, 3815.4086116651965, 1130.5873356224918, 1152.8904754048351, 1163.8836116388293, 1167.3287859480834, 1170.0697945133638, 837.5560952695081, 875.3259989807813, 953.3040880157524, 1001.5342865567546, 1007.7379881230933, 6157.907631385533, 6270.717817698214, 6329.208848893888, 6369.20384951881, 6389.648569328639, 945.3004776465366, 994.5773046455228, 1031.8804097554087, 1034.912032477248, 1053.4048262731533, 4096.569860164699, 4124.072083781125, 4178.101708132766, 4206.642435392964, 4254.617084462351, 11002.559897604006, 11368.317900925971, 11382.94308528452, 11385.08919286455, 11417.942910285561, 10622.309549879388, 11001.559937602566, 11062.557497700001, 11311.490982905789, 11319.094472442184, 8358.0, 8402.537860417735, 8483.490990540588, 8485.787855303543, 8523.275521580612, 6202.906956395748, 6395.456386207225, 6422.389872962061, 6435.292117867125, 6478.578892371981, 10158.339707918962, 10186.643467478603, 10321.329113607591, 10379.702537182851, 10473.581056757948, 10509.421981791074, 10544.947275263574, 10591.947040265057, 10621.044106030495, 10623.0, 7512.699492020477, 7743.5353878767455, 7934.20657934202, 8052.637631306488, 8141.22658347456, 8836.602352894006, 8846.46921184731, 8882.467051976902, 8930.062343453843, 8944.105589441004, 7488.850222995618, 7625.389968802371, 7726.806829829299, 7813.804654883674, 8066.153053929253, 7510.774676759706, 7848.489848160079, 7880.960595196987, 7941.801454963441, 8046.879296810435, 7013.859722805618, 7066.57600543969, 7095.538789978635, 7108.644567771694, 7157.105361829771, 5208.218767184952, 5469.699166545878, 5544.223808666709, 5552.111662134039, 5573.1918871762555, 5459.890802183854, 5578.30271216098, 5582.748776304995, 5631.0427227372265, 5812.680302583399], "value": 4762.74125176812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3983589702638, 333.9949900751488, 334.45149954075333, 335.87572598138684, 346.0362889353152, 5589.217509548666, 5632.295963004624, 5633.943660563398, 5682.210103817305, 5685.800996965107, 5516.255305533752, 5532.640378375413, 5578.330600327967, 5578.693171875545, 5653.519450846673, 3975.522937247534, 4320.719153255044, 4331.350297455376, 4343.78281085946, 4357.542458041908, 4300.397944287803, 4308.138372325532, 4345.130973805251, 4362.738235705868, 4394.296912494002, 4309.095090031082, 4339.698090572815, 4386.539413361599, 4403.735775853459, 4418.315161150027, 4230.957690423103, 4310.849120280775, 4335.84824531143, 4353.67347448941, 4380.167768124078, 3810.0, 3836.6547010768886, 3845.4231865220163, 3849.191669749356, 3866.7873266970305, 5291.841244762663, 5328.44051374604, 5331.653442526223, 5397.4062853086125, 5399.433059528771, 4741.739204343759, 4990.900181996376, 4999.575036121934, 5002.074616195979, 5002.774875130628, 5796.2464879565805, 5796.913046304308, 5802.663468505626, 5818.5926985111055, 5827.825165245049, 4193.867655732965, 4207.296045101739, 4228.513720922103, 4236.51280102789, 4251.256030194703, 5804.477597016289, 5964.598319394939, 5973.058755904349, 6006.189164462785, 6047.516198704093, 4281.272183728774, 4285.97857010713, 4305.698601097955, 4324.0, 4324.8486302979245, 4316.201502722007, 4368.453943257093, 4373.431453910971, 4376.3654270130655, 4381.956180438218, 4567.36056952027, 4840.7337596432535, 4856.4415092264135, 4989.775460104304, 5022.648414611015, 5774.451427114417, 5780.971095144581, 5786.623869448473, 5859.736311865976, 5864.618799778001, 1447.5440236325524, 1480.533631905946, 1481.3778213150288, 1483.8738707209793, 1493.7004805819006, 957.6879674845507, 969.345691658128, 969.6376590889811, 999.5855863952426, 1007.3401921741271, 5569.749361278752, 5570.387257401682, 5574.498295153456, 5574.888502229933, 5599.32808063035, 5883.852903677357, 5914.6746928918465, 5959.344472108065, 5970.552208584373, 5993.280806303272, 5366.168243922199, 5571.498565129158, 5640.661560306395, 5701.144828275792, 5708.743106560131, 3196.712295893334, 3208.9197770055935, 3220.4525230710838, 3228.5480032795426, 3232.288896442779, 6048.304444988883, 6090.878182436327, 6199.442050215503, 6306.747730090745, 6325.335839736854, 6137.171481849893, 6142.385761423822, 6143.416375444325, 6153.0, 6159.722812473449, 6113.786017489278, 6204.541932645825, 6209.813705588839, 6216.285127210338, 6224.1597384352535, 5940.46535811779, 6050.667213303311, 6056.424639659225, 6063.211782468427, 6077.574569780073, 5970.940290597212, 5983.670898100646, 5991.820245392645, 6012.579119461596, 6022.638641681513, 6056.45491905713, 6109.106177085117, 6167.352427994996, 6234.345393733593, 6257.5932564383165, 4308.46144231971, 4374.825006999685, 4386.363977223221, 4397.0, 4414.0, 5886.323072846506, 5889.322727886348, 6037.9094313584455, 6085.847853803691, 6105.877882442237, 5805.709714514342, 5870.911936320873, 5872.0, 5874.765009399576, 5896.941030589639, 5748.597598168255, 5771.595988280948, 5775.653460792366, 5776.451237132465, 5794.217780599565, 5432.794651155837, 5627.0, 5696.088625819849, 5696.829095127153, 5709.65742055478, 5794.391588883275, 5827.883442331215, 5863.384344643751, 5901.881962360814, 5917.615355002084, 5471.398146203835, 5759.996802222415, 5763.077907534942, 5788.768449262151, 5838.591298609056], "value": 4452.660373588724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.8616455955648, 775.786658668866, 778.4200770426033, 812.910579836218, 832.1137988042736, 14859.0, 14861.925690371532, 14903.40386384546, 14944.327505262248, 15266.389344426223, 14571.19858407787, 14732.26338683067, 15083.170425626586, 15691.60770980726, 15709.371625134982, 835.6824406725451, 837.4598384042289, 840.5629072882098, 842.7345386203357, 844.5988155626089, 805.5327909812295, 822.6503735912244, 826.6280173921759, 834.9248567628912, 839.8236370362231, 857.4897935728263, 857.4940784936886, 857.661223816592, 857.7898414888361, 859.1194026123243, 844.4131328726537, 852.47146769003, 852.7015544559416, 853.2704537620369, 854.8162145138763, 616.6022915219659, 619.7737825693634, 619.950403967686, 622.0948519903529, 622.2346513788066, 15952.920235398864, 15991.520254392386, 16017.839821601869, 16053.357865685359, 16061.91969040159, 14133.575992720132, 14275.714485710332, 14348.28258587077, 14392.64018399538, 14430.278486075758, 12261.386930653433, 12267.754644907052, 12526.77192807683, 12566.81149782754, 12590.496380144783, 3835.789031603261, 3869.787161706105, 3878.4957955465893, 3880.825362858678, 4018.698597605162, 79184.60407697983, 79277.20722792756, 79917.99999999942, 80435.59782201052, 80470.59764701198, 10969.945150274198, 11028.779424411467, 11164.051055660197, 11281.548738050551, 11416.31502109876, 21936.0, 22061.558768824532, 22158.88920555419, 22168.445788855406, 22175.223867164896, 8076.581210238844, 8155.755327340189, 8252.83494330122, 8338.666453341919, 8694.826103477895, 4716.858494245178, 4717.976410117927, 4730.858074257778, 4735.692180008288, 4785.186518291899, 3605.2428989912414, 3721.1627383838963, 3730.570984336836, 3732.5147730795366, 3740.8690695825517, 633.7591715148214, 634.6826586706646, 648.2771709543824, 648.4585371215088, 658.2200092889941, 736.3115487019654, 740.9962950185322, 743.7434085240583, 761.1171041591728, 763.904511936008, 9386.85919711205, 9512.476813775309, 9601.519924003773, 9763.26775491841, 9794.862317501353, 594.5124997502094, 748.618204715599, 756.7805336452367, 758.3808568705742, 762.8283636181815, 4140.833911062704, 4193.454850869368, 4279.957200427956, 4299.935500967488, 4331.7834108294455, 67690.66154669294, 86728.0, 108483.45758271316, 116956.0, 117140.0, 59786.70106649439, 80629.0, 91790.54104729567, 94461.5276923611, 97608.0, 82300.0, 82396.58801705953, 82993.0, 83673.16326836654, 84594.0, 8370.832583348178, 8473.5339556325, 8497.362697797565, 8516.381887441366, 8610.913890861262, 51275.48724512856, 51496.48503515067, 51729.0, 51966.48033519767, 53162.0, 66018.0, 73715.0, 76283.61858190673, 76782.2321776775, 78241.60879195567, 10814.45927703596, 11352.886471135183, 11924.642260732191, 12122.393880306126, 12255.142140050111, 11855.76288474243, 11900.226485278428, 11907.464164112462, 11928.940355298168, 12188.57339993096, 10399.596558766012, 10596.682099537025, 10921.123555129589, 11135.83296250573, 11240.269382490113, 11646.883531164918, 11691.707707307385, 11965.820512692142, 12266.448009839758, 12282.385880706108, 10747.925207479502, 10941.124710023338, 10953.890461095287, 11044.447777611247, 11669.708257293636, 9254.953725231331, 9358.859617105885, 9777.266704997011, 9781.217502599633, 9982.850257246002, 9187.77030574241, 9853.901460985298, 9938.751531211778, 9979.251556133175, 10016.098551130433], "value": 7287.818969565396, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 110.0, 112.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 154.0, 179.0, 128.0, 153.0, 157.0, 128.0, 176.0, 126.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 163.0, 166.0, 173.0, 161.0, 160.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 162.0, 76.0, 75.0, 73.0, 75.0, 167.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 150.0, 85.0, 83.0, 84.0, 137.0, 83.0, 83.0, 140.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 122.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 149.0, 148.0, 147.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 53.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 80.0, 80.0, 81.0, 84.0, 84.0, 106.0, 81.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 122.0, 121.0, 122.0, 121.0, 128.0, 126.0, 125.0, 132.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 168.0, 165.0, 168.0, 168.0, 167.0, 163.0, 162.0, 170.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}]}]} 22:29:50 INFO - Return code: 0 22:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:29:50 ERROR - # TBPL SUCCESS # 22:29:50 INFO - Running post-action listener: _resource_record_post_action 22:29:50 INFO - ##### 22:29:50 INFO - ##### Finished run-tests step (success) 22:29:50 INFO - ##### 22:29:50 INFO - Running post-run listener: _resource_record_post_run 22:29:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539357184; Read time: 16; Write time: 569816 22:29:50 INFO - TinderboxPrint: CPU usage
13.5% 22:29:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:29:50 INFO - TinderboxPrint: I/O write bytes / time
539,357,184 / 569,816 22:29:50 INFO - TinderboxPrint: CPU idle
8,223.5 (86.5%) 22:29:50 INFO - TinderboxPrint: CPU user
1,223.0 (12.9%) 22:29:50 INFO - TinderboxPrint: Swap in / out
0 / 0 22:29:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247676928; Read time: 0; Write time: 344304 22:29:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291680256; Read time: 16; Write time: 225512 22:29:51 INFO - Running post-run listener: _upload_blobber_files 22:29:51 INFO - Blob upload gear active. 22:29:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:29:51 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 22:29:51 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'] 22:29:51 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 22:29:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:29:52 INFO - (blobuploader) - INFO - Done attempting. 22:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:29:56 INFO - (blobuploader) - INFO - Done attempting. 22:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:29:57 INFO - (blobuploader) - INFO - Done attempting. 22:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 22:29:57 INFO - Return code: 0 22:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/727181a27ebc89a5fc550ce90a5cf6702eb8cc2412e89aac3de516182e684507cea89be58266390964b4b796af59c903d8766e98756a6b34aac3c9e0ed05b0c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86680f511694501c1412db8f07c6cfbb4938bbc16ed67a7b72b7e9f6ff0b116209c387e96ac68bb2d964204192c6d59470ec862fd04acdf01c3514e2d24f1d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5918e1d38dea306a772fce3ecd28920712b77c7562ad2d5fce713382815059eb6f87ab2acf5c736074644dec91d6ffb153299cedc352efdb5a545dd10dacc35"} 22:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:29:57 INFO - Contents: 22:29:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/727181a27ebc89a5fc550ce90a5cf6702eb8cc2412e89aac3de516182e684507cea89be58266390964b4b796af59c903d8766e98756a6b34aac3c9e0ed05b0c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86680f511694501c1412db8f07c6cfbb4938bbc16ed67a7b72b7e9f6ff0b116209c387e96ac68bb2d964204192c6d59470ec862fd04acdf01c3514e2d24f1d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5918e1d38dea306a772fce3ecd28920712b77c7562ad2d5fce713382815059eb6f87ab2acf5c736074644dec91d6ffb153299cedc352efdb5a545dd10dacc35"} 22:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 22:29:57 INFO - Copying logs to upload dir... 22:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 22:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.348762 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-01 22:29:57.222110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 22:29:57.226012) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 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/727181a27ebc89a5fc550ce90a5cf6702eb8cc2412e89aac3de516182e684507cea89be58266390964b4b796af59c903d8766e98756a6b34aac3c9e0ed05b0c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86680f511694501c1412db8f07c6cfbb4938bbc16ed67a7b72b7e9f6ff0b116209c387e96ac68bb2d964204192c6d59470ec862fd04acdf01c3514e2d24f1d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5918e1d38dea306a772fce3ecd28920712b77c7562ad2d5fce713382815059eb6f87ab2acf5c736074644dec91d6ffb153299cedc352efdb5a545dd10dacc35"} build_url:https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/T_cCMZZmQbiDJi10WIzdtg/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/727181a27ebc89a5fc550ce90a5cf6702eb8cc2412e89aac3de516182e684507cea89be58266390964b4b796af59c903d8766e98756a6b34aac3c9e0ed05b0c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/86680f511694501c1412db8f07c6cfbb4938bbc16ed67a7b72b7e9f6ff0b116209c387e96ac68bb2d964204192c6d59470ec862fd04acdf01c3514e2d24f1d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5918e1d38dea306a772fce3ecd28920712b77c7562ad2d5fce713382815059eb6f87ab2acf5c736074644dec91d6ffb153299cedc352efdb5a545dd10dacc35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 22:29:57.251709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:29:57.252058) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464842371.585323-864090817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 22:29:57.339373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 22:29:57.340329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 22:29:57.341143) ========= ========= Total master_lag: 0.20 =========