builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1464317903.94 results: success (0) buildid: 20160526184452 builduid: af5b319b8ada4c61bbc831eeaeb525da revision: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:23.936344) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:23.937191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:23.937600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:23.954015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:23.954351) ========= 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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 19:58:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-05-26 19:58:24 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.071253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.071583) ========= 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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018090 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.121356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.121731) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 --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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 19:58:24,456 truncating revision to first 12 chars 2016-05-26 19:58:24,457 Setting DEBUG logging. 2016-05-26 19:58:24,457 attempt 1/10 2016-05-26 19:58:24,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34ac60e5b29c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 19:58:24,762 unpacking tar archive at: mozilla-central-34ac60e5b29c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.784688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.785025) ========= script_repo_revision: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.785429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.785711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 19:58:24.794760) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-26 19:58:24.795116) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:25 INFO - MultiFileLogger online at 20160526 19:58:25 in /builds/slave/test 19:58:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:58:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:25 INFO - {'append_to_log': False, 19:58:25 INFO - 'base_work_dir': '/builds/slave/test', 19:58:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:25 INFO - 'branch': 'Firefox-Non-PGO', 19:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:25 INFO - 'config_files': ('talos/linux_config.py',), 19:58:25 INFO - 'default_actions': ('clobber', 19:58:25 INFO - 'read-buildbot-config', 19:58:25 INFO - 'download-and-extract', 19:58:25 INFO - 'populate-webroot', 19:58:25 INFO - 'create-virtualenv', 19:58:25 INFO - 'install', 19:58:25 INFO - 'run-tests'), 19:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:25 INFO - 'download_minidump_stackwalk': True, 19:58:25 INFO - 'download_symbols': 'ondemand', 19:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:25 INFO - 'installer_path': 'installer.exe', 19:58:25 INFO - 'log_level': 'info', 19:58:25 INFO - 'log_name': 'talos', 19:58:25 INFO - 'log_to_console': True, 19:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:25 INFO - 'opt_config_files': (), 19:58:25 INFO - 'pip_index': False, 19:58:25 INFO - 'sps_profile': False, 19:58:25 INFO - 'sps_profile_interval': 0, 19:58:25 INFO - 'suite': 'dromaeojs', 19:58:25 INFO - 'system_bits': '32', 19:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:25 INFO - 'title': 'talos-linux64-ix-026', 19:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:25 INFO - 'use_talos_json': True, 19:58:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:25 INFO - 'work_dir': 'build'} 19:58:25 INFO - ##### 19:58:25 INFO - ##### Running clobber step. 19:58:25 INFO - ##### 19:58:25 INFO - Running pre-action listener: _resource_record_pre_action 19:58:25 INFO - Running main action method: clobber 19:58:25 INFO - rmtree: /builds/slave/test/build 19:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:25 INFO - Running post-action listener: _resource_record_post_action 19:58:25 INFO - ##### 19:58:25 INFO - ##### Finished clobber step (success) 19:58:25 INFO - ##### 19:58:25 INFO - ##### 19:58:25 INFO - ##### Running read-buildbot-config step. 19:58:25 INFO - ##### 19:58:25 INFO - Running pre-action listener: _resource_record_pre_action 19:58:25 INFO - Running main action method: read_buildbot_config 19:58:25 INFO - Using buildbot properties: 19:58:25 INFO - { 19:58:25 INFO - "project": "", 19:58:25 INFO - "product": "firefox", 19:58:25 INFO - "script_repo_revision": "production", 19:58:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:58:25 INFO - "repository": "", 19:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:58:25 INFO - "buildid": "20160526184452", 19:58:25 INFO - "pgo_build": "False", 19:58:25 INFO - "basedir": "/builds/slave/test", 19:58:25 INFO - "buildnumber": 515, 19:58:25 INFO - "slavename": "talos-linux64-ix-026", 19:58:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:25 INFO - "platform": "ubuntu64_hw", 19:58:25 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:58:25 INFO - "branch": "mozilla-central", 19:58:25 INFO - "repo_path": "mozilla-central", 19:58:25 INFO - "revision": "34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321", 19:58:25 INFO - "stage_platform": "linux64", 19:58:25 INFO - "builduid": "af5b319b8ada4c61bbc831eeaeb525da", 19:58:25 INFO - "slavebuilddir": "test" 19:58:25 INFO - } 19:58:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:58:25 INFO - Running post-action listener: _resource_record_post_action 19:58:25 INFO - ##### 19:58:25 INFO - ##### Finished read-buildbot-config step (success) 19:58:25 INFO - ##### 19:58:25 INFO - ##### 19:58:25 INFO - ##### Running download-and-extract step. 19:58:25 INFO - ##### 19:58:25 INFO - Running pre-action listener: _resource_record_pre_action 19:58:25 INFO - Running main action method: download_and_extract 19:58:25 INFO - mkdir: /builds/slave/test/build/tests 19:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:25 INFO - https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:26 INFO - Downloaded 1361 bytes. 19:58:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:26 INFO - Using the following test package requirements: 19:58:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:58:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'jsshell-linux-x86_64.zip'], 19:58:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:26 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')]} 19:58:26 INFO - https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:27 INFO - Downloaded 22835565 bytes. 19:58:27 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'] 19:58:27 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 19:58:28 INFO - Return code: 0 19:58:28 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 19:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:28 INFO - https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:29 INFO - Downloaded 22835565 bytes. 19:58: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'] 19:58: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 19:58:31 INFO - Return code: 0 19:58: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')]} 19:58:31 INFO - https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:32 INFO - Downloaded 10834034 bytes. 19:58: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'] 19:58: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 19:58:32 INFO - Return code: 0 19:58: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')]} 19:58:32 INFO - https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J2sjs728Qgm_oQekp9uUEQ/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 19:58:33 INFO - Downloaded 54823509 bytes. 19:58:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:33 INFO - mkdir: /builds/slave/test/properties 19:58:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:58:33 INFO - Writing to file /builds/slave/test/properties/build_url 19:58:33 INFO - Contents: 19:58:33 INFO - build_url:https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - Running post-action listener: set_extra_try_arguments 19:58:34 INFO - ##### 19:58:34 INFO - ##### Finished download-and-extract step (success) 19:58:34 INFO - ##### 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running populate-webroot step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: populate_webroot 19:58:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:34 INFO - '--tppagecycles', 19:58:34 INFO - '7'], 19:58:34 INFO - 'tests': ['tsvgm']}}, 19:58:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:58:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:58:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:58:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['damp', 'tps']}, 19:58:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['damp', 'tps']}, 19:58:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['dromaeo_dom']}, 19:58:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore', 19:58:34 INFO - 'tabpaint']}, 19:58:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['tsvgx', 19:58:34 INFO - 'tsvgr_opacity', 19:58:34 INFO - 'tart', 19:58:34 INFO - 'tscrollx', 19:58:34 INFO - 'cart']}, 19:58:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:58:34 INFO - 'tsvgr_opacity', 19:58:34 INFO - 'tart', 19:58:34 INFO - 'tscrollx', 19:58:34 INFO - 'cart']}, 19:58:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--disable-e10s'], 19:58:34 INFO - 'tests': ['tp5o']}, 19:58:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['tp5o']}, 19:58:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--disable-e10s', 19:58:34 INFO - '--xperf_path', 19:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:34 INFO - 'tests': ['tp5n']}, 19:58:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--xperf_path', 19:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:34 INFO - 'tests': ['tp5n']}}, 19:58:34 INFO - 'talos.zip': {'path': '', 19:58:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - ##### 19:58:34 INFO - ##### Finished populate-webroot step (success) 19:58:34 INFO - ##### 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running create-virtualenv step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: create_virtualenv 19:58:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:58:34 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 19:58:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:58:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:34 INFO - Using real prefix '/usr' 19:58:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:58:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:37 INFO - Installing pip.................done. 19:58:37 INFO - Return code: 0 19:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:37 INFO - Using env: {'DISPLAY': ':0', 19:58:37 INFO - 'HOME': '/home/cltbld', 19:58:37 INFO - 'LANG': 'en_US.UTF-8', 19:58:37 INFO - 'LANGUAGE': 'en_US:en', 19:58:37 INFO - 'LOGNAME': 'cltbld', 19:58:37 INFO - 'MAIL': '/var/mail/cltbld', 19:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:37 INFO - 'MOZ_NO_REMOTE': '1', 19:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:37 INFO - 'NO_EM_RESTART': '1', 19:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:37 INFO - 'PWD': '/builds/slave/test', 19:58:37 INFO - 'SHELL': '/bin/bash', 19:58:37 INFO - 'SHLVL': '1', 19:58:37 INFO - 'TERM': 'linux', 19:58:37 INFO - 'TMOUT': '86400', 19:58:37 INFO - 'USER': 'cltbld', 19:58:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:37 INFO - '_': '/tools/buildbot/bin/python'} 19:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58: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 19:58:37 INFO - Cleaning up... 19:58:37 INFO - Return code: 0 19:58:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:37 INFO - Using env: {'DISPLAY': ':0', 19:58:37 INFO - 'HOME': '/home/cltbld', 19:58:37 INFO - 'LANG': 'en_US.UTF-8', 19:58:37 INFO - 'LANGUAGE': 'en_US:en', 19:58:37 INFO - 'LOGNAME': 'cltbld', 19:58:37 INFO - 'MAIL': '/var/mail/cltbld', 19:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:37 INFO - 'MOZ_NO_REMOTE': '1', 19:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:37 INFO - 'NO_EM_RESTART': '1', 19:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:37 INFO - 'PWD': '/builds/slave/test', 19:58:37 INFO - 'SHELL': '/bin/bash', 19:58:37 INFO - 'SHLVL': '1', 19:58:37 INFO - 'TERM': 'linux', 19:58:37 INFO - 'TMOUT': '86400', 19:58:37 INFO - 'USER': 'cltbld', 19:58:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:37 INFO - '_': '/tools/buildbot/bin/python'} 19:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:37 INFO - Downloading/unpacking psutil>=3.1.1 19:58:37 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 19:58:37 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 19:58:37 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 19:58:37 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 19:58:37 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 19:58:37 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 19:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:39 INFO - Installing collected packages: psutil 19:58:39 INFO - Running setup.py install for psutil 19:58:39 INFO - building 'psutil._psutil_linux' extension 19:58:39 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 19:58: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 19:58:40 INFO - building 'psutil._psutil_posix' extension 19:58: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 19:58: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 19:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:40 INFO - Successfully installed psutil 19:58:40 INFO - Cleaning up... 19:58:40 INFO - Return code: 0 19:58:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:40 INFO - Using env: {'DISPLAY': ':0', 19:58:40 INFO - 'HOME': '/home/cltbld', 19:58:40 INFO - 'LANG': 'en_US.UTF-8', 19:58:40 INFO - 'LANGUAGE': 'en_US:en', 19:58:40 INFO - 'LOGNAME': 'cltbld', 19:58:40 INFO - 'MAIL': '/var/mail/cltbld', 19:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:40 INFO - 'MOZ_NO_REMOTE': '1', 19:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:40 INFO - 'NO_EM_RESTART': '1', 19:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:40 INFO - 'PWD': '/builds/slave/test', 19:58:40 INFO - 'SHELL': '/bin/bash', 19:58:40 INFO - 'SHLVL': '1', 19:58:40 INFO - 'TERM': 'linux', 19:58:40 INFO - 'TMOUT': '86400', 19:58:40 INFO - 'USER': 'cltbld', 19:58:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:40 INFO - '_': '/tools/buildbot/bin/python'} 19:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:58:42 INFO - Installing collected packages: mozsystemmonitor 19:58:42 INFO - Running setup.py install for mozsystemmonitor 19:58:42 INFO - Successfully installed mozsystemmonitor 19:58:42 INFO - Cleaning up... 19:58:42 INFO - Return code: 0 19:58:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:42 INFO - Using env: {'DISPLAY': ':0', 19:58:42 INFO - 'HOME': '/home/cltbld', 19:58:42 INFO - 'LANG': 'en_US.UTF-8', 19:58:42 INFO - 'LANGUAGE': 'en_US:en', 19:58:42 INFO - 'LOGNAME': 'cltbld', 19:58:42 INFO - 'MAIL': '/var/mail/cltbld', 19:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:42 INFO - 'MOZ_NO_REMOTE': '1', 19:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:42 INFO - 'NO_EM_RESTART': '1', 19:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:42 INFO - 'PWD': '/builds/slave/test', 19:58:42 INFO - 'SHELL': '/bin/bash', 19:58:42 INFO - 'SHLVL': '1', 19:58:42 INFO - 'TERM': 'linux', 19:58:42 INFO - 'TMOUT': '86400', 19:58:42 INFO - 'USER': 'cltbld', 19:58:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:42 INFO - '_': '/tools/buildbot/bin/python'} 19:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:44 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 19:58:44 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 19:58:44 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 19:58:44 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 19:58:44 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 19:58:44 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 19:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:45 INFO - Downloading docopt-0.6.1.tar.gz 19:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:45 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:45 INFO - Running setup.py install for blobuploader 19:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:45 INFO - Running setup.py install for requests 19:58:45 INFO - Running setup.py install for docopt 19:58:46 INFO - Successfully installed blobuploader requests docopt 19:58:46 INFO - Cleaning up... 19:58:46 INFO - Return code: 0 19:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:46 INFO - Using env: {'DISPLAY': ':0', 19:58:46 INFO - 'HOME': '/home/cltbld', 19:58:46 INFO - 'LANG': 'en_US.UTF-8', 19:58:46 INFO - 'LANGUAGE': 'en_US:en', 19:58:46 INFO - 'LOGNAME': 'cltbld', 19:58:46 INFO - 'MAIL': '/var/mail/cltbld', 19:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:46 INFO - 'MOZ_NO_REMOTE': '1', 19:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:46 INFO - 'NO_EM_RESTART': '1', 19:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:46 INFO - 'PWD': '/builds/slave/test', 19:58:46 INFO - 'SHELL': '/bin/bash', 19:58:46 INFO - 'SHLVL': '1', 19:58:46 INFO - 'TERM': 'linux', 19:58:46 INFO - 'TMOUT': '86400', 19:58:46 INFO - 'USER': 'cltbld', 19:58:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:46 INFO - '_': '/tools/buildbot/bin/python'} 19:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:46 INFO - Running setup.py (path:/tmp/pip-4twnJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:46 INFO - Running setup.py (path:/tmp/pip-Ub7n6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:46 INFO - Running setup.py (path:/tmp/pip-O6s_X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:46 INFO - Running setup.py (path:/tmp/pip-QmaaUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:46 INFO - Running setup.py (path:/tmp/pip-j0c7LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:46 INFO - Running setup.py (path:/tmp/pip-Dx7whG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:46 INFO - Running setup.py (path:/tmp/pip-QNQNPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:46 INFO - Running setup.py (path:/tmp/pip-MRpRfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:46 INFO - Running setup.py (path:/tmp/pip-xbu_6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:46 INFO - Running setup.py (path:/tmp/pip-TTS8N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:47 INFO - Running setup.py (path:/tmp/pip-IkrbvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:47 INFO - Running setup.py (path:/tmp/pip-IdGiiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:47 INFO - Running setup.py (path:/tmp/pip-mzx_DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:47 INFO - Running setup.py (path:/tmp/pip-5wPMJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:47 INFO - Running setup.py (path:/tmp/pip-iw7YqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:47 INFO - Running setup.py (path:/tmp/pip-saUboK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:47 INFO - Running setup.py (path:/tmp/pip-zJmELB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:47 INFO - Running setup.py install for manifestparser 19:58:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:47 INFO - Running setup.py install for mozcrash 19:58:47 INFO - Running setup.py install for mozdebug 19:58:47 INFO - Running setup.py install for mozdevice 19:58:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:47 INFO - Running setup.py install for mozfile 19:58:48 INFO - Running setup.py install for mozhttpd 19:58:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for mozinfo 19:58:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for mozInstall 19:58:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for mozleak 19:58:48 INFO - Running setup.py install for mozlog 19:58:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for moznetwork 19:58:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for mozprocess 19:58:48 INFO - Running setup.py install for mozprofile 19:58:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:58:48 INFO - Running setup.py install for mozrunner 19:58:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:58:49 INFO - Running setup.py install for mozscreenshot 19:58:49 INFO - Running setup.py install for moztest 19:58:49 INFO - Running setup.py install for mozversion 19:58:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:58:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:49 INFO - Cleaning up... 19:58:49 INFO - Return code: 0 19:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:49 INFO - Using env: {'DISPLAY': ':0', 19:58:49 INFO - 'HOME': '/home/cltbld', 19:58:49 INFO - 'LANG': 'en_US.UTF-8', 19:58:49 INFO - 'LANGUAGE': 'en_US:en', 19:58:49 INFO - 'LOGNAME': 'cltbld', 19:58:49 INFO - 'MAIL': '/var/mail/cltbld', 19:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:49 INFO - 'MOZ_NO_REMOTE': '1', 19:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:49 INFO - 'NO_EM_RESTART': '1', 19:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:49 INFO - 'PWD': '/builds/slave/test', 19:58:49 INFO - 'SHELL': '/bin/bash', 19:58:49 INFO - 'SHLVL': '1', 19:58:49 INFO - 'TERM': 'linux', 19:58:49 INFO - 'TMOUT': '86400', 19:58:49 INFO - 'USER': 'cltbld', 19:58:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:49 INFO - '_': '/tools/buildbot/bin/python'} 19:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:49 INFO - Running setup.py (path:/tmp/pip-aUJb1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58: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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:49 INFO - Running setup.py (path:/tmp/pip-rvitjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58: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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:49 INFO - Running setup.py (path:/tmp/pip-N4Gz0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:49 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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:49 INFO - Running setup.py (path:/tmp/pip-dirOAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:49 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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:49 INFO - Running setup.py (path:/tmp/pip-zN14wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:49 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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:49 INFO - Running setup.py (path:/tmp/pip-vXQ9wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:49 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)) 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:49 INFO - Running setup.py (path:/tmp/pip-i2_Tmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:50 INFO - Running setup.py (path:/tmp/pip-JdBgRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:50 INFO - Running setup.py (path:/tmp/pip-934xKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:50 INFO - Running setup.py (path:/tmp/pip-Vp9Yqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:50 INFO - Running setup.py (path:/tmp/pip-dtyxnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:50 INFO - Running setup.py (path:/tmp/pip-z4aDag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:50 INFO - Running setup.py (path:/tmp/pip-CNPi7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:50 INFO - Running setup.py (path:/tmp/pip-r326t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:50 INFO - Running setup.py (path:/tmp/pip-alxqLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:50 INFO - Running setup.py (path:/tmp/pip-fwiEks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58: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)) 19:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:50 INFO - Running setup.py (path:/tmp/pip-hT8lSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 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)) 19:58:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:52 INFO - Downloading blessings-1.6.tar.gz 19:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:52 INFO - Installing collected packages: blessings 19:58:52 INFO - Running setup.py install for blessings 19:58:52 INFO - Successfully installed blessings 19:58:52 INFO - Cleaning up... 19:58:52 INFO - Return code: 0 19:58:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:53 INFO - Reading from file tmpfile_stdout 19:58:53 INFO - Current package versions: 19:58:53 INFO - argparse == 1.2.1 19:58:53 INFO - blessings == 1.6 19:58:53 INFO - blobuploader == 1.2.4 19:58:53 INFO - docopt == 0.6.1 19:58:53 INFO - manifestparser == 1.1 19:58:53 INFO - mozInstall == 1.12 19:58:53 INFO - mozcrash == 0.17 19:58:53 INFO - mozdebug == 0.1 19:58:53 INFO - mozdevice == 0.48 19:58:53 INFO - mozfile == 1.2 19:58:53 INFO - mozhttpd == 0.7 19:58:53 INFO - mozinfo == 0.9 19:58:53 INFO - mozleak == 0.1 19:58:53 INFO - mozlog == 3.2 19:58:53 INFO - moznetwork == 0.27 19:58:53 INFO - mozprocess == 0.22 19:58:53 INFO - mozprofile == 0.28 19:58:53 INFO - mozrunner == 6.11 19:58:53 INFO - mozscreenshot == 0.1 19:58:53 INFO - mozsystemmonitor == 0.3 19:58:53 INFO - moztest == 0.7 19:58:53 INFO - mozversion == 1.4 19:58:53 INFO - psutil == 3.1.1 19:58:53 INFO - requests == 1.2.3 19:58:53 INFO - wsgiref == 0.1.2 19:58:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:53 INFO - Using env: {'DISPLAY': ':0', 19:58:53 INFO - 'HOME': '/home/cltbld', 19:58:53 INFO - 'LANG': 'en_US.UTF-8', 19:58:53 INFO - 'LANGUAGE': 'en_US:en', 19:58:53 INFO - 'LOGNAME': 'cltbld', 19:58:53 INFO - 'MAIL': '/var/mail/cltbld', 19:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:53 INFO - 'MOZ_NO_REMOTE': '1', 19:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:53 INFO - 'NO_EM_RESTART': '1', 19:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:53 INFO - 'PWD': '/builds/slave/test', 19:58:53 INFO - 'SHELL': '/bin/bash', 19:58:53 INFO - 'SHLVL': '1', 19:58:53 INFO - 'TERM': 'linux', 19:58:53 INFO - 'TMOUT': '86400', 19:58:53 INFO - 'USER': 'cltbld', 19:58:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:53 INFO - '_': '/tools/buildbot/bin/python'} 19:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58: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)) 19:58:53 INFO - Cleaning up... 19:58:53 INFO - Return code: 0 19:58:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58: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 19:58: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 19:58:53 INFO - Using env: {'DISPLAY': ':0', 19:58:53 INFO - 'HOME': '/home/cltbld', 19:58:53 INFO - 'LANG': 'en_US.UTF-8', 19:58:53 INFO - 'LANGUAGE': 'en_US:en', 19:58:53 INFO - 'LOGNAME': 'cltbld', 19:58:53 INFO - 'MAIL': '/var/mail/cltbld', 19:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:53 INFO - 'MOZ_NO_REMOTE': '1', 19:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:53 INFO - 'NO_EM_RESTART': '1', 19:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:53 INFO - 'PWD': '/builds/slave/test', 19:58:53 INFO - 'SHELL': '/bin/bash', 19:58:53 INFO - 'SHLVL': '1', 19:58:53 INFO - 'TERM': 'linux', 19:58:53 INFO - 'TMOUT': '86400', 19:58:53 INFO - 'USER': 'cltbld', 19:58:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:53 INFO - '_': '/tools/buildbot/bin/python'} 19:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:53 INFO - Downloading/unpacking jsonschema 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:55 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:55 INFO - warning: no files found matching '*.txt' 19:58:55 INFO - no previously-included directories found matching 'build' 19:58:55 INFO - no previously-included directories found matching 'dist' 19:58:55 INFO - no previously-included directories found matching '.git*' 19:58:55 INFO - Installing collected packages: jsonschema, functools32 19:58:55 INFO - Running setup.py install for functools32 19:58:55 INFO - warning: no files found matching '*.txt' 19:58:55 INFO - no previously-included directories found matching 'build' 19:58:55 INFO - no previously-included directories found matching 'dist' 19:58:55 INFO - no previously-included directories found matching '.git*' 19:58:55 INFO - Successfully installed jsonschema functools32 19:58:55 INFO - Cleaning up... 19:58:55 INFO - Return code: 0 19:58:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa537e33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2064770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, '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': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', '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 19:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:58:55 INFO - Using env: {'DISPLAY': ':0', 19:58:55 INFO - 'HOME': '/home/cltbld', 19:58:55 INFO - 'LANG': 'en_US.UTF-8', 19:58:55 INFO - 'LANGUAGE': 'en_US:en', 19:58:55 INFO - 'LOGNAME': 'cltbld', 19:58:55 INFO - 'MAIL': '/var/mail/cltbld', 19:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:55 INFO - 'MOZ_NO_REMOTE': '1', 19:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:55 INFO - 'NO_EM_RESTART': '1', 19:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:55 INFO - 'PWD': '/builds/slave/test', 19:58:55 INFO - 'SHELL': '/bin/bash', 19:58:55 INFO - 'SHLVL': '1', 19:58:55 INFO - 'TERM': 'linux', 19:58:55 INFO - 'TMOUT': '86400', 19:58:55 INFO - 'USER': 'cltbld', 19:58:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:55 INFO - '_': '/tools/buildbot/bin/python'} 19:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:56 INFO - Downloading/unpacking flake8 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:58:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:58:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:58 INFO - no previously-included directories found matching 'docs/_build' 19:58:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:58:58 INFO - Running setup.py install for pep8 19:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:58 INFO - no previously-included directories found matching 'docs/_build' 19:58:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:58:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:58:58 INFO - Cleaning up... 19:58:59 INFO - Return code: 0 19:58:59 INFO - Running post-action listener: _resource_record_post_action 19:58:59 INFO - Running post-action listener: _start_resource_monitoring 19:58:59 INFO - Starting resource monitoring. 19:58:59 INFO - ##### 19:58:59 INFO - ##### Finished create-virtualenv step (success) 19:58:59 INFO - ##### 19:58:59 INFO - ##### 19:58:59 INFO - ##### Running install step. 19:58:59 INFO - ##### 19:58:59 INFO - Running pre-action listener: _resource_record_pre_action 19:58:59 INFO - Running main action method: install 19:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:59 INFO - Reading from file tmpfile_stdout 19:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:58:59 INFO - Reading from file tmpfile_stdout 19:58:59 INFO - Output received: 19:58:59 INFO - Usage: mozinstall [options] installer 19:58:59 INFO - Options: 19:58:59 INFO - -h, --help show this help message and exit 19:58:59 INFO - -d DEST, --destination=DEST 19:58:59 INFO - Directory to install application into. [default: 19:58:59 INFO - "/builds/slave/test"] 19:58:59 INFO - --app=APP Application being installed. [default: firefox] 19:58:59 INFO - mkdir: /builds/slave/test/build/application 19:58: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'] 19:58: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 19:59:15 INFO - Reading from file tmpfile_stdout 19:59:15 INFO - Output received: 19:59:15 INFO - /builds/slave/test/build/application/firefox/firefox 19:59:15 INFO - Running post-action listener: _resource_record_post_action 19:59:15 INFO - ##### 19:59:15 INFO - ##### Finished install step (success) 19:59:15 INFO - ##### 19:59:15 INFO - ##### 19:59:15 INFO - ##### Running run-tests step. 19:59:15 INFO - ##### 19:59:15 INFO - Running pre-action listener: _resource_record_pre_action 19:59:15 INFO - Running main action method: run_tests 19:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:15 INFO - Python 2.7.3 19:59:15 INFO - Return code: 0 19:59:15 INFO - grabbing minidump binary from tooltool 19:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:15 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 0x20f39c0>, '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 0x20f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:15 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 19:59:15 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 19:59:15 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 19:59:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:15 INFO - Return code: 0 19:59:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:59:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:59:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:59:16 INFO - Return code: 0 19:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:59:16 INFO - Using env: {'DISPLAY': ':0', 19:59:16 INFO - 'HOME': '/home/cltbld', 19:59:16 INFO - 'LANG': 'en_US.UTF-8', 19:59:16 INFO - 'LANGUAGE': 'en_US:en', 19:59:16 INFO - 'LOGNAME': 'cltbld', 19:59:16 INFO - 'MAIL': '/var/mail/cltbld', 19:59:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:16 INFO - 'MOZ_NO_REMOTE': '1', 19:59:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:16 INFO - 'NO_EM_RESTART': '1', 19:59:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:16 INFO - 'PWD': '/builds/slave/test', 19:59:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:16 INFO - 'SHELL': '/bin/bash', 19:59:16 INFO - 'SHLVL': '1', 19:59:16 INFO - 'TERM': 'linux', 19:59:16 INFO - 'TMOUT': '86400', 19:59:16 INFO - 'USER': 'cltbld', 19:59:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447', 19:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:16 INFO - '_': '/tools/buildbot/bin/python'} 19:59:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:59:16 INFO - mozversion application_buildid: 20160526184452 19:59:16 INFO - mozversion application_changeset: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 19:59:16 INFO - mozversion application_display_name: Nightly 19:59:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:16 INFO - mozversion application_name: Firefox 19:59:16 INFO - mozversion application_remotingname: firefox 19:59:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:59:16 INFO - mozversion application_vendor: Mozilla 19:59:16 INFO - mozversion application_version: 49.0a1 19:59:16 INFO - mozversion platform_buildid: 20160526184452 19:59:16 INFO - mozversion platform_changeset: 34ac60e5b29c55eba69ab7e769dbc3b2eb7d5321 19:59:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:59:16 INFO - mozversion platform_version: 49.0a1 19:59:16 INFO - using testdate: 1464317956 19:59:16 INFO - actual date: 1464317956 19:59:16 INFO - starting webserver on 'localhost:59148' 19:59:16 INFO - SUITE-START | Running 2 tests 19:59:16 INFO - TEST-START | dromaeo_css 19:59:16 INFO - operating with platform_type : linux_ 19:59:16 INFO - Initialising browser for dromaeo_css test... 19:59:16 INFO - TEST-INFO | started process 2403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkbLu5w/profile http://localhost:59148/getInfo.html) 19:59:20 INFO - PROCESS | 2403 | __metrics Screen width/height:1600/1200 19:59:20 INFO - PROCESS | 2403 | colorDepth:24 19:59:20 INFO - PROCESS | 2403 | Browser inner width/height: 1024/697 19:59:20 INFO - PROCESS | 2403 | __metrics 19:59:21 ERROR - PROCESS | 2403 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:59:22 INFO - TEST-INFO | 2403: exit 0 19:59:22 INFO - Browser initialized. 19:59:22 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:22 INFO - TEST-INFO | started process 2504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkbLu5w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:34 INFO - PROCESS | 2504 | RSS: Main: 156848128 19:59:34 INFO - PROCESS | 2504 | 20:00:25 INFO - PROCESS | 2504 | 1464318025300 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] 20:02:37 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59148/tests/dromaeo/cssquery-ext.html) 20:02:38 INFO - PROCESS | 2504 | RSS: Main: 239661056 20:02:38 INFO - PROCESS | 2504 | 20:05:41 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-ext.html (next: http://localhost:59148/tests/dromaeo/cssquery-jquery.html) 20:05:42 INFO - PROCESS | 2504 | RSS: Main: 244322304 20:05:42 INFO - PROCESS | 2504 | 20:08:44 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59148/tests/dromaeo/cssquery-mootools.html) 20:08:45 INFO - PROCESS | 2504 | RSS: Main: 246837248 20:08:45 INFO - PROCESS | 2504 | 20:11:47 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59148/tests/dromaeo/cssquery-prototype.html) 20:11:47 INFO - PROCESS | 2504 | RSS: Main: 243732480 20:11:47 INFO - PROCESS | 2504 | 20:14:50 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59148/tests/dromaeo/cssquery-yui.html) 20:14:51 INFO - PROCESS | 2504 | RSS: Main: 218820608 20:14:51 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | Cycle 1(1): loaded http://localhost:59148/tests/dromaeo/cssquery-yui.html (next: http://localhost:59148/tests/dromaeo/cssquery-dojo.html) 20:17:54 INFO - PROCESS | 2504 | RSS: Main: 302641152 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | __start_tp_report 20:17:54 INFO - PROCESS | 2504 | _x_x_mozilla_page_load 20:17:54 INFO - PROCESS | 2504 | _x_x_mozilla_page_load_details 20:17:54 INFO - PROCESS | 2504 | |i|pagename|runs| 20:17:54 INFO - PROCESS | 2504 | |0;dojo.html;2669.2259244819;2682.4232789950156;2710.132757517595;2718.6737591489023;2730.713275106113;4613.446386433633;4659.3709849170355;4666.416697912761;4669.976650116753;4748.857534273973;4664.906701865961;4686.601638860701;4740.620750339973;4742.739149346785;4789.928151077736;4256.723312984662;4276.636485898703;4312.784360781949;4333.523312435629;4491;4414.470263568361;4456.977715111436;4495.033567782926;4512.977435112836;4513.954860451403;4242.193983143193;4256.106217694288;4287.48550173978;4332.913341733148;4339.544347843478;4320.805563749639;4331.7184383015;4346.826126954918;4349.151915376503;4349.804258808361;4307.741535507848;4310.978445107786;4315.697901146921;4321.65426765858;4322.50291216511;4527.117212143633;4556.179887620227;4573.222552166139;4616.838410655611;4633.050224703928;5003.149464591028;5047.066292735855;5049.4950504949575;5110.488951104897;5134.589232861362;4865.075635629254;5120;5159.277701121809;5159.5614372778355;5172.405173405069;4707.29390591414;4741.312509686076;4752.1921273383605;4797.56821886032;4806.182948898696;5196.428392876781;5234.502722241381;5238.790448382022;5249.947500524946;5251.816186433456;4838.080764654705;4896.902061958741;5017.774200161001;5043.495650435;5048.899022019539;5000.899982000413;5014.07239660664;5033.144365457881;5036.84889453317;5074.644774865797;4943.9258411123865;4976.2038073908;4977.626677999165;4981.153203955337;5019.949800502021;4826.758662066883;4965.751712414365;4984.476629953875;5018.673786203885;5019.42276638184;4320.200762858881;4326.2645350289895;4326.697131200785;4345.065810850619;4350;3760.8495660173835;3777.3956167013694;3789.6778773803985;3811.8094095295123;3825.9043523912123;4225.049363893161;4265.317549192115;4309.698321117555;4345.130973805189;4361.563843615677;5073.16292811682;5093.592512598983;5116.718580478035;5117.053345131163;5157.277981082651;4353.542877997828;4358.019445624773;4361.542038086019;4390.560943905584;4411.536788637211;4417.668674849335;4507.098580283956;4539.205639013159;4559.840405585788;4563.338315944169;4802.447718512416;4812.711237325701;4817.0606731686985;4822.855314340575;4877.5366340197625;5102.132637451717;5108.846734597968;5109.1059064662795;5110.828884964252;5159.329287192641;4661.580457758818;4697.0840686065885;4704.647151463585;4759.476457589593;4763.237881938873;4935.087008903364;4945.455999840086;4945.921027847346;4948.455669876383;5007.198848184419;5032.119379108714;5043.5712964398435;5046.571041461517;5047.697138171721;5098.923516147187;4746.762661866962;4846.588040016497;4852.272159176152;4864.513548645107;4915.5330243626795;4837.467878533429;4866.294387313749;4869.926951095807;4875.43932447773;4925.261210818263;4684.7891844867745;4833.3958255218095;4843.2250839865455;4889.511048895082;4897.730624815669;4834.830780922792;4861.295112208781;4869.610431165427;4884.951150488591;4888.315635810918;4768.356271903387;4804.735739534359;4805.399325084364;4825.420949486084;4867.5132486751045 20:17:54 INFO - PROCESS | 2504 | |1;ext.html;581.8080033588916;593.7001814083887;598.4195330529385;605.9636421814691;609.5763444406134;39638;41166.17667646649;41180.588194118085;44892.3266151008;44974.775126124405;42053.36919946203;42620;42663.14673706524;42727.572724272744;42728.35907461391;7589.848203035936;7692.615369231544;7852.607369631524;7865.606719664022;10070.79858402835;9697;10112.089911907928;10115.291929564934;10119.696409107739;10122.089011988919;10119.291649584533;10119.595216191343;10124;10193.439360835151;10194.337368071088;7622.885656715126;7751.22487751226;7756.263155000266;9920.503974801231;10067.899321006806;9679.951600242024;9994.550245238981;9997.350172238781;9997.400155990592;10003.249756268237;38194.42708359377;38511.22977540433;38529.61470385316;38544.22911541782;38709.419358709645;3040.4831178699674;3188.6651901550467;3479.2867462170193;3607.981960090209;3675.7794532328144;29370;29411.558826617616;29451.41097178066;29986;31065;3390.2880395117054;3390.8304584770663;3405.455127179664;3411.2665776858094;3486.041338631871;254623;255354;255729;255757;255781;31790;52405.737971310664;52465;52741.47258527366;52801.47198528043;32190.83904580462;34032;34056.82971585176;34068.31863362719;34083.65916340805;11457.54169833214;11594.826077608843;11607.76784464306;11608.941955290169;11609.709757256136;7500.737474188377;9091.31815113869;9292.117248861347;9305.813883722423;9311.208547273558;7889.250521200477;7923.881141782877;7929.1277959424415;7985.041794984639;7988.201179882081;3091.9536206956914;3153.369326134782;3164.683531646863;3167.255694911694;3182.0453863840753;870.5864714260675;877.7322916510526;922.4880191493651;1003.247564326755;1016.6136867990116;27641.674956136238;28217.576736348972;28220.85889570539;28281.57825138861;28347.858260708563;939.3236869453982;960.9663661771805;991.8908920018793;1033.6588925654517;1041.234692501011;14804.259787010606;14931.925340373446;15081.472148474752;15232.238388080774;15292;419491;423129;423742;423848;425778;33819.492707608915;33860.66139338575;33988.49017264743;34031.489527657104;34082.48876266858;1109.5949978257877;1134.880837512066;1183.7573297473998;1221.450347343699;1224.161449407159;26335;28644;29077.563836542045;29498.705012949595;29519;40974.1805163901;41402.378964316165;41407.792961035004;41441.1711765769;41470.58529414667;288065;291895;292520;292950.70492950536;293526;20740.92590740914;20747.273845415337;25343.36641583975;25389.492210156062;26407.33981650474;41836.37245441382;42117.1576568473;42203.788981054895;42601.147977040906;42602.57397425986;35413;35929.46105808467;36230.818845905604;36564.81717591395;36650.266994659425;35562.28875422529;36101.458478122324;36247.63752362443;36528.81735591305;36549.26901461903;35944.820275898455;36198.27603447969;36313.45529817108;37319;37441.25117497689;29859.850700746356;31555.36889262248;32087;32111;32308.83845580851;24578.385540361633;24618.261452156465;24628;24870.37824054413;24910.252692419257 20:17:54 INFO - PROCESS | 2504 | |2;jquery.html;358.87439396211323;359.5846796949524;366.17793054592426;379.6260683227023;385.1622720582732;16467.50597482076;16564.585885352873;16777.916110419446;17028.914855425737;17189.656206875872;16487.67024659509;16488;16924.4076457324;17301.91349043253;17328.480145595622;4984.651074424792;5143.12566863634;5144.717040562768;5183.53348198662;5183.663061900965;3721.1999420124666;3848.9037774055732;5097.3373461449955;5615.213870058195;5907.320658124328;5909.7340619672;5912.615679980788;5926.822195334147;5938.228030356047;5945.613535120204;5779.162021506858;5832.329282132546;5946.940530594682;5958.672273024982;5959.135925290852;3374;4807.783649735736;5069.06222348863;5074.949250507521;5153.2270159476;19709.310174143837;20372;20415;20562;20626.58746825055;1916.0802814648907;2077.6987336836223;2102.4323432673245;2106.9157233710785;2555.731648176933;12562.057845661611;12740.872591274061;12909.483620655163;12985.805212921814;13448.798268025987;1682.2513981278337;1749.08173209065;1754.7894252689632;1759.498542915263;1765.5321339844822;64251.678741605996;65225.67387163081;65748.6712566439;65764.67117664429;67426.66286668535;8132.674693012332;8360.707375241838;8598.914010859937;8630.784230394165;8715.869261961076;11539.76920461586;11548.538058477734;11589.478473468715;11594.47824847867;11618.535258589562;6251.531135164881;6321.65230912295;6331.493480521547;6338.968305158444;6495.1231583736535;6053.303870055;6116.8776624468155;6186.752529898844;6206.844828879314;6220.657863817443;3387.187075101958;3555.288942211568;3567.090391950036;3609.4224924012033;3659.597444281127;1602.070798936614;1683.2173039536674;1714.4685147604282;1735.1411051529321;1790.3375750972223;831.3930830493653;831.821158450936;839.8740188971581;845.8181490979468;906.2115959115612;16036.518904432885;16845;16863.91568042152;16869.746953795704;17129.914350428167;803.5781214862244;822.1696086952221;858.3262139220682;859.9054104048549;892.4779004282567;8989.309287896527;9155.908440915638;9377.1091746284;9377.812443751087;9450.52747362629;355077;380399;381555;381734;383375;71783;71822.64088679523;72374;72672;73272.63363683148;913.0777914306598;915.6062892956093;923.1783712495884;954.0125969621408;971.4025874087386;14480.927595362376;14618.561443156723;15149.469768558047;15167.91984951841;15315.61710957235;33219.40671801645;33387.33225335431;33477.49783753197;33879.32241355209;34215;41189.58810411858;47304.29043564418;47796;47958.76020619875;47968.760156198994;6918.757843475454;7014.123234595676;7053.329933656294;7154.177269613853;7183.748568800067;9623.951880240555;10461.947690261804;10482.37105773656;10488.68533943983;10607;9132.315076369166;9143.13140251675;9372.906270937203;9480.810383792148;9533.332666713264;9204.861927071233;9277.907220927704;9304.302177336862;9327.207187389147;9365.812683746151;9207.953960230425;9353.906460935303;9433.151016408556;9506.572204250688;9686.806263874823;6962.860742785015;6976.860462790614;7058.71765129389;7167.7132914682825;7254.238304977901;8385.32917366597;9300.906990930003;9305.813883722152;9396.812063758549;9635.084666956627 20:17:54 INFO - PROCESS | 2504 | |3;mootools.html;1274.9362531873403;1366.6515038665138;1438.9424423023079;1525.946591869284;1815.3101821307894;6731.73073077077;7681.807954801133;7918.524888506694;7930.563818989954;8112.837743245146;7904.96047519763;8039.316658084055;8045.718399856006;8046.316063134641;8051.396145289097;1886.6226754649126;1936.9612607747836;1940.185122248659;2211.071350032986;2241.0251540579898;1986.4239370582513;2189.211883721859;2256.7630398808137;2259.2205689037337;2276.1350686739015;2073.8029887160696;2095.6332641787703;2096.4654013226605;2098.58028394321;2105.536781907978;1838.1820090059928;2140.1332460353583;2142.335875878467;2145.570885822842;2148.3662319615596;2007.096806437109;2071;2073.2743539761113;2086.2176683743596;2087.279888438486;7817.257360550739;7893.763187104396;7896.80257993549;7900.486468379537;7903.920960790376;4588.609968152711;4727.763611819395;4733.242681170997;4734.360861283752;4735.266033764772;2789.623400840881;2862.2128914548666;2936.412717456496;2988.8655010524362;2999.5650630658433;941.8351788436996;1647.4069335039376;1686.1147897353865;1741.0772290685957;1748.1783561725968;10705.892941070568;10819.891801081967;10830.67507974762;10832.458377081193;10835.67492975212;4082.7550346978683;4121.62905338515;4148.751074935513;4150.605692459211;4185.916281674349;8200.466969646954;8201.425900187049;8210.548419836967;8214.794630134294;8221.958890205511;4706.247000479907;4708.364370809897;4712.2224832902875;4713.670043097019;4718.4809670936165;3623.7825730456257;3690.409534474471;4305.138972205571;4356.825726970886;4358.825646974149;3407.557017587698;3426.0749597608506;3513.4202856528896;3565.6969157621375;3658.158623516606;1020.6937918624383;1021.4637315409469;1038.787048655024;1039.3763741755038;1051.1118105201092;683.6205905722372;711.4450728431832;719.8596273726678;848.7708318753902;864.9135086491301;5161.122609156452;5221.885136519715;5354.143337066051;5438.45615438453;5513.145462453326;828.3828547731857;837.1461109668226;840.3487297344607;876.509154873273;886.9201771840436;3616.3309787689363;3688.280785246851;3759.661630453272;3875.806209689504;3897;9214.170724634814;9459.716208513755;9502.192313653279;9520.333576649567;9525.761855953519;8984.281257499384;9316.580753865957;9454.905450945402;9522.523873806282;9524.04759524056;7295.452841036943;7311.524750891175;7470.813229669193;7485.5508669480005;7505.737299194502;5385.38068122171;5606.495415412633;5638.4925356718095;5668.869956182874;5777.537796976148;8927.508987005518;9155.267578593563;9163.175314221486;9170.082991700776;9179.862302065341;9117.498537580497;9206.953965230132;9235.26117910579;9272.211861991806;9348.53257337144;6774.356436138559;6827.658617069226;6897.2757860423935;6908.758193463405;6913.2049814272;7485.625718714152;7515.173330933702;7533.585652789149;7576.204498527575;7576.81057973533;6671.866562668816;6796.83007924786;6924.203716572659;6955.8608827822145;6977.232504424611;6674.365935236145;6738.629375384401;6762.797116086525;6820.113385259884;6984.965075174591;6518.413342799171;6539.051837483443;6543.574667646588;6551.082848401133;6557.639329836905;4543.6365090792;4560.771961401851;4653.286029721939;4655.427594695738;4715.78778954941;4839.758012099452;4904.166291730486;4917.729524876167;4932.28481870134;4992.475790041994 20:17:54 INFO - PROCESS | 2504 | |4;prototype.html;287.2488442722281;288.59452469280666;291.5117178725634;293.2244214053827;295.11171374163786;4773.761311934402;4809.663323567347;4812.085703716291;4839.53183876223;4865.343178670878;4736.123817093831;4760.500147484508;4791.257355109955;4793;4805.807767689288;3574.6246644102384;3603.4414665726854;3682.576503702082;3704.5184126063573;3735;3616.981915090421;3681.815909204529;3714.9071273218115;3728.6271372862766;3729.254149170177;3533.575970883485;3666.853325866962;3680.263947210555;3685.299793039314;3688.3729765939856;3585.551806024247;3733.1787006858585;3752.7185461090526;3756.7370284080125;3764.9623503764888;3324.1191084362663;3325.6840600142946;3336.916577085568;3347.2134048498583;3358.596968363812;4606.401167848158;4616.8614941551805;4642.51253618372;4672.579467847876;4674.78455601546;4184.246835569596;4246.787660616957;4264.658827293809;4285.97857010713;4301.935470967938;4976.975115124437;5011.84964451067;5015.648904576681;5016.824411145629;5055.5702765265;3611.1152767571853;3627.455881617752;3628.183658676803;3635.3456377851976;3635.963640363589;5029.949700502984;5243.842684719464;5250.396204436501;5297.602679799031;5327.840164795062;3686.8156592170285;3695.371786796251;3698.4665504129757;3725.5529336479253;3726.720495962814;3690.870819521304;3725.1990821973404;3763.247350529905;3773.8677647129284;3776.3013842439236;4266.274733295348;4295.140971805651;4296.892577685583;4298.817825098123;4326.502452217972;4868.95131048692;4988.451270360258;5011.57401620859;5022.096022715873;5088.898222035538;1251.837261156044;1253.7555176740448;1261.4323554400557;1276.4702648400996;1279.9680007999875;828.6271177969937;830.6469750356074;846.5005646668495;875.9605817738217;880.8854848869606;4370.803313850821;4380.9780951095045;4398.362237475548;4474.865754027384;4481.932771008437;5074.8835256243565;5089.251804025785;5142.51146141116;5216.634835561475;5217.2695822584865;4226.915461690749;4377.562243775597;4379.605835474759;4412.933805992912;4420.292753159479;2704.445588654321;2734.8632568371504;2739.6028025707033;2756;2761.558150695879;4854.927176092361;4860.055977608914;4872.049950259736;4873.463918968911;4881.707097574157;5031.8426761844985;5205.687658740488;5217.321748172713;5258.421573626898;5266.603041038586;4831.565159135765;4837.758112094381;4843.975780121147;4847.079054979543;4857.587105096107;5082.923756143735;5094.223648111714;5116.9744151279;5163.483651634807;5173.198154286091;4954.405471343462;4997.5002499749735;5042.823501177441;5065.214891691794;5090.160123579568;4809.254565542346;4815.590674792542;4862.586680132228;4863.635227357891;4880.609551235963;3642.5628924528164;3649.9270014600093;3670.22925185714;3677.1542545215284;3692.7968961707365;4926.413632842786;5089.745512724423;5118.3090282811345;5129.615278854027;5159.535641792257;4848;4857.295692124693;4919.262110683283;4920.450058231646;4926.5073492650445;4931.852044438672;4934.087193869145;4965.386249468865;4970.502949705001;4982.75086245679;4668.253079507263;4883.95116048835;4891.486393928729;4903.651495838673;4905.386826646669;4795.880102997314;4876.756162191805;5018.4730603286125;5024.723640199824;5033.295338652665;4945.554900059012;4948.851534453972;4951.2078067510465;4995.575376093073;5001.549860512426 20:17:54 INFO - PROCESS | 2504 | |5;yui.html;663.7875879718489;679.7858674517527;697.7589098636835;707.9663691011124;737.8044818123199;12093.939530302347;12509.562165324216;12667.4799024117;12676.683082922931;12707.809382859265;13069.803952940714;13521.661958451044;13575.117617354865;13663.521776737816;13678.726425471485;642.0497663458085;787.8306164174701;820.8030072782519;823.6293667849462;828.391132517602;810.6838333050115;824.5671022713094;824.5877061469265;824.5918270456133;824.8226631274275;842.2377748137915;845.1590667286059;847.995760021199;848.9702860399888;849.4181485682327;660.7224965514496;829.2619568583905;842.1283971089923;843.4306842881031;848.3806821020628;622.2315440431064;623.2458724942825;623.6569886562418;623.8378021714342;624.1667374055642;12431.502739890393;12434.689132771662;12446.439910204062;12450.128491005542;12472.376381180995;11428.885711142866;11666.358350290731;11678.299302041905;11884.465199066062;12016.879831201752;11102.833457498144;11110.722231944184;11114.555417783278;11223;11337.206395552315;4028.979855100735;4042.353223484258;4071.2671719090554;4084.244414783275;4134.689898257643;47753.761231193625;47851.52148478505;48230.75884620554;48245.517544824455;48570.75714621404;9678.17735492477;9721.222302215805;9757.756056098513;9816.509174541245;9819.06718861707;16448.588785280463;17276.65446691059;17408.39070632522;17438.91280543589;17463.21415536304;6482.837929051811;6527.118838956775;6554.737810487527;6726.8654626908165;6851.760188393382;3562.679358857715;3673.412254039394;3688.6495782900583;3707.9814600926825;3838.5201849768778;2846.957295640567;2928.546075358323;2937.618109645775;2941.205874413939;2941.382309714941;499.6028157614705;513.2609042978099;516.0092622165452;522.1775703267369;523.0898237067476;450.3964687319008;464.7281340415827;616.3589866538749;659.3472462262325;661.163628010567;7993.160718124629;8221.095679475253;8334.66661333552;8368.205020523163;8371.748847534584;549.3599956051156;596.5108610938988;609.9613823150842;635.0854769132435;646.5506473001219;3587.712982961409;3658.506101676293;3720.144366795598;3722.590515043343;3736.663700266989;55532.72233638887;57501;57553.13670294949;57588;58490.70754646199;48866;49043.75478122586;49595;50095;52909.47090529122;42125.789371052946;45247.77376113164;45287;45668.314975275396;46355.76822115868;7975.723884178504;8321.667133314842;8472.44929079608;8486.74539763808;8539.274161696325;30467.542986855657;30993;31609.36781264316;32009;32240.355192895542;39059.41410878782;41097;41210.79394603008;41569.1686166281;42016.36975445432;10924.453777311262;11151.219414640897;11626.476808543466;11681.941590291994;12166.635000949986;12127.939360303142;12129.878701213227;12188.939055304667;12330;13000.804987925378;11388.37363944991;11634.592789252336;11745.060395168195;11759.60532217066;12043.397830108635;11104.222704410937;11460.19778615489;11748.530058797553;11758.118141139277;11766.823497647714;10961.177911656498;11835.11236657237;12145.514179432723;12205.084618653815;12223.57217497419;9425.970444918923;9704.805903882025;9770.218382529523;9773;9921.25590580695;9186.265098791948;9419.387739797165;9616.278779091455;9845.60617575289;9957.601695932082 20:17:54 INFO - PROCESS | 2504 | __end_tp_report 20:17:54 INFO - PROCESS | 2504 | __start_cc_report 20:17:54 INFO - PROCESS | 2504 | _x_x_mozilla_cycle_collect,941 20:17:54 INFO - PROCESS | 2504 | __end_cc_report 20:17:54 INFO - PROCESS | 2504 | __startTimestamp1464319074570__endTimestamp 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | ------- Summary: start ------- 20:17:54 INFO - PROCESS | 2504 | Number of tests: 6 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#0] dojo.html Cycles:165 Average:4663.00 Median:4802.45 stddev:477.71 (9.9%) stddev-sans-first:452.84 20:17:54 INFO - PROCESS | 2504 | Values: 2669.2 2682.4 2710.1 2718.7 2730.7 4613.4 4659.4 4666.4 4670.0 4748.9 4664.9 4686.6 4740.6 4742.7 4789.9 4256.7 4276.6 4312.8 4333.5 4491.0 4414.5 4457.0 4495.0 4513.0 4514.0 4242.2 4256.1 4287.5 4332.9 4339.5 4320.8 4331.7 4346.8 4349.2 4349.8 4307.7 4311.0 4315.7 4321.7 4322.5 4527.1 4556.2 4573.2 4616.8 4633.1 5003.1 5047.1 5049.5 5110.5 5134.6 4865.1 5120.0 5159.3 5159.6 5172.4 4707.3 4741.3 4752.2 4797.6 4806.2 5196.4 5234.5 5238.8 5249.9 5251.8 4838.1 4896.9 5017.8 5043.5 5048.9 5000.9 5014.1 5033.1 5036.8 5074.6 4943.9 4976.2 4977.6 4981.2 5019.9 4826.8 4965.8 4984.5 5018.7 5019.4 4320.2 4326.3 4326.7 4345.1 4350.0 3760.8 3777.4 3789.7 3811.8 3825.9 4225.0 4265.3 4309.7 4345.1 4361.6 5073.2 5093.6 5116.7 5117.1 5157.3 4353.5 4358.0 4361.5 4390.6 4411.5 4417.7 4507.1 4539.2 4559.8 4563.3 4802.4 4812.7 4817.1 4822.9 4877.5 5102.1 5108.8 5109.1 5110.8 5159.3 4661.6 4697.1 4704.6 4759.5 4763.2 4935.1 4945.5 4945.9 4948.5 5007.2 5032.1 5043.6 5046.6 5047.7 5098.9 4746.8 4846.6 4852.3 4864.5 4915.5 4837.5 4866.3 4869.9 4875.4 4925.3 4684.8 4833.4 4843.2 4889.5 4897.7 4834.8 4861.3 4869.6 4885.0 4888.3 4768.4 4804.7 4805.4 4825.4 4867.5 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#1] ext.html Cycles:180 Average:46481.05 Median:34083.07 stddev:87588.34 (257.0%) stddev-sans-first:87766.26 20:17:54 INFO - PROCESS | 2504 | Values: 581.8 593.7 598.4 606.0 609.6 39638.0 41166.2 41180.6 44892.3 44974.8 42053.4 42620.0 42663.1 42727.6 42728.4 7589.8 7692.6 7852.6 7865.6 10070.8 9697.0 10112.1 10115.3 10119.7 10122.1 10119.3 10119.6 10124.0 10193.4 10194.3 7622.9 7751.2 7756.3 9920.5 10067.9 9680.0 9994.6 9997.4 9997.4 10003.2 38194.4 38511.2 38529.6 38544.2 38709.4 3040.5 3188.7 3479.3 3608.0 3675.8 29370.0 29411.6 29451.4 29986.0 31065.0 3390.3 3390.8 3405.5 3411.3 3486.0 254623.0 255354.0 255729.0 255757.0 255781.0 31790.0 52405.7 52465.0 52741.5 52801.5 32190.8 34032.0 34056.8 34068.3 34083.7 11457.5 11594.8 11607.8 11608.9 11609.7 7500.7 9091.3 9292.1 9305.8 9311.2 7889.3 7923.9 7929.1 7985.0 7988.2 3092.0 3153.4 3164.7 3167.3 3182.0 870.6 877.7 922.5 1003.2 1016.6 27641.7 28217.6 28220.9 28281.6 28347.9 939.3 961.0 991.9 1033.7 1041.2 14804.3 14931.9 15081.5 15232.2 15292.0 419491.0 423129.0 423742.0 423848.0 425778.0 33819.5 33860.7 33988.5 34031.5 34082.5 1109.6 1134.9 1183.8 1221.5 1224.2 26335.0 28644.0 29077.6 29498.7 29519.0 40974.2 41402.4 41407.8 41441.2 41470.6 288065.0 291895.0 292520.0 292950.7 293526.0 20740.9 20747.3 25343.4 25389.5 26407.3 41836.4 42117.2 42203.8 42601.1 42602.6 35413.0 35929.5 36230.8 36564.8 36650.3 35562.3 36101.5 36247.6 36528.8 36549.3 35944.8 36198.3 36313.5 37319.0 37441.3 29859.9 31555.4 32087.0 32111.0 32308.8 24578.4 24618.3 24628.0 24870.4 24910.3 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#2] jquery.html Cycles:180 Average:23207.91 Median:5183.60 stddev:62091.32 (1197.8%) stddev-sans-first:62241.80 20:17:54 INFO - PROCESS | 2504 | Values: 358.9 359.6 366.2 379.6 385.2 16467.5 16564.6 16777.9 17028.9 17189.7 16487.7 16488.0 16924.4 17301.9 17328.5 4984.7 5143.1 5144.7 5183.5 5183.7 3721.2 3848.9 5097.3 5615.2 5907.3 5909.7 5912.6 5926.8 5938.2 5945.6 5779.2 5832.3 5946.9 5958.7 5959.1 3374.0 4807.8 5069.1 5074.9 5153.2 19709.3 20372.0 20415.0 20562.0 20626.6 1916.1 2077.7 2102.4 2106.9 2555.7 12562.1 12740.9 12909.5 12985.8 13448.8 1682.3 1749.1 1754.8 1759.5 1765.5 64251.7 65225.7 65748.7 65764.7 67426.7 8132.7 8360.7 8598.9 8630.8 8715.9 11539.8 11548.5 11589.5 11594.5 11618.5 6251.5 6321.7 6331.5 6339.0 6495.1 6053.3 6116.9 6186.8 6206.8 6220.7 3387.2 3555.3 3567.1 3609.4 3659.6 1602.1 1683.2 1714.5 1735.1 1790.3 831.4 831.8 839.9 845.8 906.2 16036.5 16845.0 16863.9 16869.7 17129.9 803.6 822.2 858.3 859.9 892.5 8989.3 9155.9 9377.1 9377.8 9450.5 355077.0 380399.0 381555.0 381734.0 383375.0 71783.0 71822.6 72374.0 72672.0 73272.6 913.1 915.6 923.2 954.0 971.4 14480.9 14618.6 15149.5 15167.9 15315.6 33219.4 33387.3 33477.5 33879.3 34215.0 41189.6 47304.3 47796.0 47958.8 47968.8 6918.8 7014.1 7053.3 7154.2 7183.7 9624.0 10461.9 10482.4 10488.7 10607.0 9132.3 9143.1 9372.9 9480.8 9533.3 9204.9 9277.9 9304.3 9327.2 9365.8 9208.0 9353.9 9433.2 9506.6 9686.8 6962.9 6976.9 7058.7 7167.7 7254.2 8385.3 9300.9 9305.8 9396.8 9635.1 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#3] mootools.html Cycles:180 Average:5173.68 Median:5288.01 stddev:2868.07 (54.2%) stddev-sans-first:2861.15 20:17:54 INFO - PROCESS | 2504 | Values: 1274.9 1366.7 1438.9 1525.9 1815.3 6731.7 7681.8 7918.5 7930.6 8112.8 7905.0 8039.3 8045.7 8046.3 8051.4 1886.6 1937.0 1940.2 2211.1 2241.0 1986.4 2189.2 2256.8 2259.2 2276.1 2073.8 2095.6 2096.5 2098.6 2105.5 1838.2 2140.1 2142.3 2145.6 2148.4 2007.1 2071.0 2073.3 2086.2 2087.3 7817.3 7893.8 7896.8 7900.5 7903.9 4588.6 4727.8 4733.2 4734.4 4735.3 2789.6 2862.2 2936.4 2988.9 2999.6 941.8 1647.4 1686.1 1741.1 1748.2 10705.9 10819.9 10830.7 10832.5 10835.7 4082.8 4121.6 4148.8 4150.6 4185.9 8200.5 8201.4 8210.5 8214.8 8222.0 4706.2 4708.4 4712.2 4713.7 4718.5 3623.8 3690.4 4305.1 4356.8 4358.8 3407.6 3426.1 3513.4 3565.7 3658.2 1020.7 1021.5 1038.8 1039.4 1051.1 683.6 711.4 719.9 848.8 864.9 5161.1 5221.9 5354.1 5438.5 5513.1 828.4 837.1 840.3 876.5 886.9 3616.3 3688.3 3759.7 3875.8 3897.0 9214.2 9459.7 9502.2 9520.3 9525.8 8984.3 9316.6 9454.9 9522.5 9524.0 7295.5 7311.5 7470.8 7485.6 7505.7 5385.4 5606.5 5638.5 5668.9 5777.5 8927.5 9155.3 9163.2 9170.1 9179.9 9117.5 9207.0 9235.3 9272.2 9348.5 6774.4 6827.7 6897.3 6908.8 6913.2 7485.6 7515.2 7533.6 7576.2 7576.8 6671.9 6796.8 6924.2 6955.9 6977.2 6674.4 6738.6 6762.8 6820.1 6985.0 6518.4 6539.1 6543.6 6551.1 6557.6 4543.6 4560.8 4653.3 4655.4 4715.8 4839.8 4904.2 4917.7 4932.3 4992.5 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#4] prototype.html Cycles:180 Average:4153.88 Median:4794.44 stddev:1200.80 (25.0%) stddev-sans-first:1168.57 20:17:54 INFO - PROCESS | 2504 | Values: 287.2 288.6 291.5 293.2 295.1 4773.8 4809.7 4812.1 4839.5 4865.3 4736.1 4760.5 4791.3 4793.0 4805.8 3574.6 3603.4 3682.6 3704.5 3735.0 3617.0 3681.8 3714.9 3728.6 3729.3 3533.6 3666.9 3680.3 3685.3 3688.4 3585.6 3733.2 3752.7 3756.7 3765.0 3324.1 3325.7 3336.9 3347.2 3358.6 4606.4 4616.9 4642.5 4672.6 4674.8 4184.2 4246.8 4264.7 4286.0 4301.9 4977.0 5011.8 5015.6 5016.8 5055.6 3611.1 3627.5 3628.2 3635.3 3636.0 5029.9 5243.8 5250.4 5297.6 5327.8 3686.8 3695.4 3698.5 3725.6 3726.7 3690.9 3725.2 3763.2 3773.9 3776.3 4266.3 4295.1 4296.9 4298.8 4326.5 4869.0 4988.5 5011.6 5022.1 5088.9 1251.8 1253.8 1261.4 1276.5 1280.0 828.6 830.6 846.5 876.0 880.9 4370.8 4381.0 4398.4 4474.9 4481.9 5074.9 5089.3 5142.5 5216.6 5217.3 4226.9 4377.6 4379.6 4412.9 4420.3 2704.4 2734.9 2739.6 2756.0 2761.6 4854.9 4860.1 4872.0 4873.5 4881.7 5031.8 5205.7 5217.3 5258.4 5266.6 4831.6 4837.8 4844.0 4847.1 4857.6 5082.9 5094.2 5117.0 5163.5 5173.2 4954.4 4997.5 5042.8 5065.2 5090.2 4809.3 4815.6 4862.6 4863.6 4880.6 3642.6 3649.9 3670.2 3677.2 3692.8 4926.4 5089.7 5118.3 5129.6 5159.5 4848.0 4857.3 4919.3 4920.5 4926.5 4931.9 4934.1 4965.4 4970.5 4982.8 4668.3 4884.0 4891.5 4903.7 4905.4 4795.9 4876.8 5018.5 5024.7 5033.3 4945.6 4948.9 4951.2 4995.6 5001.5 20:17:54 INFO - PROCESS | 2504 | 20:17:54 INFO - PROCESS | 2504 | [#5] yui.html Cycles:180 Average:13431.79 Median:23410.25 stddev:15487.74 (66.2%) stddev-sans-first:15501.51 20:17:54 INFO - PROCESS | 2504 | Values: 663.8 679.8 697.8 708.0 737.8 12093.9 12509.6 12667.5 12676.7 12707.8 13069.8 13521.7 13575.1 13663.5 13678.7 642.0 787.8 820.8 823.6 828.4 810.7 824.6 824.6 824.6 824.8 842.2 845.2 848.0 849.0 849.4 660.7 829.3 842.1 843.4 848.4 622.2 623.2 623.7 623.8 624.2 12431.5 12434.7 12446.4 12450.1 12472.4 11428.9 11666.4 11678.3 11884.5 12016.9 11102.8 11110.7 11114.6 11223.0 11337.2 4029.0 4042.4 4071.3 4084.2 4134.7 47753.8 47851.5 48230.8 48245.5 48570.8 9678.2 9721.2 9757.8 9816.5 9819.1 16448.6 17276.7 17408.4 17438.9 17463.2 6482.8 6527.1 6554.7 6726.9 6851.8 3562.7 3673.4 3688.6 3708.0 3838.5 2847.0 2928.5 2937.6 2941.2 2941.4 499.6 513.3 516.0 522.2 523.1 450.4 464.7 616.4 659.3 661.2 7993.2 8221.1 8334.7 8368.2 8371.7 549.4 596.5 610.0 635.1 646.6 3587.7 3658.5 3720.1 3722.6 3736.7 55532.7 57501.0 57553.1 57588.0 58490.7 48866.0 49043.8 49595.0 50095.0 52909.5 42125.8 45247.8 45287.0 45668.3 46355.8 7975.7 8321.7 8472.4 8486.7 8539.3 30467.5 30993.0 31609.4 32009.0 32240.4 39059.4 41097.0 41210.8 41569.2 42016.4 10924.5 11151.2 11626.5 11681.9 12166.6 12127.9 12129.9 12188.9 12330.0 13000.8 11388.4 11634.6 11745.1 11759.6 12043.4 11104.2 11460.2 11748.5 11758.1 11766.8 10961.2 11835.1 12145.5 12205.1 12223.6 9426.0 9704.8 9770.2 9773.0 9921.3 9186.3 9419.4 9616.3 9845.6 9957.6 20:17:54 INFO - PROCESS | 2504 | -------- Summary: end -------- 20:17:54 INFO - PROCESS | 2504 | 20:17:55 INFO - TEST-INFO | 2504: exit 0 20:17:55 INFO - TEST-OK | dromaeo_css | took 1119070ms 20:17:55 INFO - TEST-START | kraken 20:17:55 INFO - operating with platform_type : linux_ 20:17:55 INFO - Initialising browser for kraken test... 20:17:55 INFO - TEST-INFO | started process 2737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQnpwjx/profile http://localhost:59148/getInfo.html) 20:17:59 INFO - PROCESS | 2737 | __metrics Screen width/height:1600/1200 20:17:59 INFO - PROCESS | 2737 | colorDepth:24 20:17:59 INFO - PROCESS | 2737 | Browser inner width/height: 1024/697 20:17:59 INFO - PROCESS | 2737 | __metrics 20:18:00 ERROR - PROCESS | 2737 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:18:01 INFO - TEST-INFO | 2737: exit 0 20:18:01 INFO - Browser initialized. 20:18:01 INFO - Running cycle 1/1 for kraken test... 20:18:01 INFO - TEST-INFO | started process 2867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQnpwjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:13 INFO - PROCESS | 2867 | RSS: Main: 156598272 20:18:13 INFO - PROCESS | 2867 | 20:18:15 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59148/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:16 INFO - PROCESS | 2867 | RSS: Main: 212934656 20:18:16 INFO - PROCESS | 2867 | 20:18:19 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59148/tests/kraken/driver.html?testName=audio-dft) 20:18:20 INFO - PROCESS | 2867 | RSS: Main: 201285632 20:18:20 INFO - PROCESS | 2867 | 20:18:23 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59148/tests/kraken/driver.html?testName=audio-fft) 20:18:24 INFO - PROCESS | 2867 | RSS: Main: 268959744 20:18:24 INFO - PROCESS | 2867 | 20:18:26 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59148/tests/kraken/driver.html?testName=audio-oscillator) 20:18:26 INFO - PROCESS | 2867 | RSS: Main: 178397184 20:18:26 INFO - PROCESS | 2867 | 20:18:29 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:29 INFO - PROCESS | 2867 | RSS: Main: 182337536 20:18:29 INFO - PROCESS | 2867 | 20:18:32 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59148/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:33 INFO - PROCESS | 2867 | RSS: Main: 219103232 20:18:33 INFO - PROCESS | 2867 | 20:18:36 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59148/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:37 INFO - PROCESS | 2867 | RSS: Main: 217214976 20:18:37 INFO - PROCESS | 2867 | 20:18:40 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59148/tests/kraken/driver.html?testName=json-parse-financial) 20:18:41 INFO - PROCESS | 2867 | RSS: Main: 217632768 20:18:41 INFO - PROCESS | 2867 | 20:18:42 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:43 INFO - PROCESS | 2867 | RSS: Main: 205660160 20:18:43 INFO - PROCESS | 2867 | 20:18:45 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:45 INFO - PROCESS | 2867 | RSS: Main: 207806464 20:18:45 INFO - PROCESS | 2867 | 20:18:48 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:48 INFO - PROCESS | 2867 | RSS: Main: 218980352 20:18:48 INFO - PROCESS | 2867 | 20:18:51 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:52 INFO - PROCESS | 2867 | RSS: Main: 226807808 20:18:52 INFO - PROCESS | 2867 | 20:18:55 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:55 INFO - PROCESS | 2867 | RSS: Main: 223854592 20:18:55 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | Cycle 1(1): loaded http://localhost:59148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59148/tests/kraken/driver.html?testName=ai-astar) 20:18:57 INFO - PROCESS | 2867 | RSS: Main: 271306752 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | __start_tp_report 20:18:57 INFO - PROCESS | 2867 | _x_x_mozilla_page_load 20:18:57 INFO - PROCESS | 2867 | _x_x_mozilla_page_load_details 20:18:57 INFO - PROCESS | 2867 | |i|pagename|runs| 20:18:57 INFO - PROCESS | 2867 | |0;ai-astar;115;110;113;113;113;112;113;111;114;113 20:18:57 INFO - PROCESS | 2867 | |1;audio-beat-detection;156;140;132;175;139;150;155;134;186;129 20:18:57 INFO - PROCESS | 2867 | |2;audio-dft;160;161;161;162;162;161;161;162;161;162 20:18:57 INFO - PROCESS | 2867 | |3;audio-fft;76;77;75;109;75;77;75;75;100;76 20:18:57 INFO - PROCESS | 2867 | |4;audio-oscillator;85;83;117;84;84;84;122;84;84;119 20:18:57 INFO - PROCESS | 2867 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;117;116;117 20:18:57 INFO - PROCESS | 2867 | |6;imaging-darkroom;146;147;147;147;147;146;146;146;146;146 20:18:57 INFO - PROCESS | 2867 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 20:18:57 INFO - PROCESS | 2867 | |8;json-parse-financial;66;65;65;66;65;66;67;85;63;62 20:18:57 INFO - PROCESS | 2867 | |9;json-stringify-tinderbox;66;65;64;65;64;64;65;65;64;68 20:18:57 INFO - PROCESS | 2867 | |10;stanford-crypto-aes;89;86;89;88;86;84;84;84;84;83 20:18:57 INFO - PROCESS | 2867 | |11;stanford-crypto-ccm;141;132;127;128;129;128;134;138;169;131 20:18:57 INFO - PROCESS | 2867 | |12;stanford-crypto-pbkdf2;171;171;177;172;172;168;171;172;180;169 20:18:57 INFO - PROCESS | 2867 | |13;stanford-crypto-sha256-iterative;65;65;66;66;71;66;65;66;66;65 20:18:57 INFO - PROCESS | 2867 | __end_tp_report 20:18:57 INFO - PROCESS | 2867 | __start_cc_report 20:18:57 INFO - PROCESS | 2867 | _x_x_mozilla_cycle_collect,1893 20:18:57 INFO - PROCESS | 2867 | __end_cc_report 20:18:57 INFO - PROCESS | 2867 | __startTimestamp1464319137685__endTimestamp 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | ------- Summary: start ------- 20:18:57 INFO - PROCESS | 2867 | Number of tests: 14 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.42 (1.3%) stddev-sans-first:1.24 20:18:57 INFO - PROCESS | 2867 | Values: 115.0 110.0 113.0 113.0 113.0 112.0 113.0 111.0 114.0 113.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:152.50 stddev:18.92 (12.4%) stddev-sans-first:19.93 20:18:57 INFO - PROCESS | 2867 | Values: 156.0 140.0 132.0 175.0 139.0 150.0 155.0 134.0 186.0 129.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.53 20:18:57 INFO - PROCESS | 2867 | Values: 160.0 161.0 161.0 162.0 162.0 161.0 161.0 162.0 161.0 162.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.33 (16.3%) stddev-sans-first:12.92 20:18:57 INFO - PROCESS | 2867 | Values: 76.0 77.0 75.0 109.0 75.0 77.0 75.0 75.0 100.0 76.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:17.12 (20.4%) stddev-sans-first:17.80 20:18:57 INFO - PROCESS | 2867 | Values: 85.0 83.0 117.0 84.0 84.0 84.0 122.0 84.0 84.0 119.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:18:57 INFO - PROCESS | 2867 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:18:57 INFO - PROCESS | 2867 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:18:57 INFO - PROCESS | 2867 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:6.50 (9.8%) stddev-sans-first:6.88 20:18:57 INFO - PROCESS | 2867 | Values: 66.0 65.0 65.0 66.0 65.0 66.0 67.0 85.0 63.0 62.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 20:18:57 INFO - PROCESS | 2867 | Values: 66.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 68.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:2.26 (2.6%) stddev-sans-first:2.06 20:18:57 INFO - PROCESS | 2867 | Values: 89.0 86.0 89.0 88.0 86.0 84.0 84.0 84.0 84.0 83.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:133.00 stddev:12.56 (9.4%) stddev-sans-first:13.18 20:18:57 INFO - PROCESS | 2867 | Values: 141.0 132.0 127.0 128.0 129.0 128.0 134.0 138.0 169.0 131.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.00 stddev:3.59 (2.1%) stddev-sans-first:3.78 20:18:57 INFO - PROCESS | 2867 | Values: 171.0 171.0 177.0 172.0 172.0 168.0 171.0 172.0 180.0 169.0 20:18:57 INFO - PROCESS | 2867 | 20:18:57 INFO - PROCESS | 2867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.79 (2.7%) stddev-sans-first:1.86 20:18:57 INFO - PROCESS | 2867 | Values: 65.0 65.0 66.0 66.0 71.0 66.0 65.0 66.0 66.0 65.0 20:18:57 INFO - PROCESS | 2867 | -------- Summary: end -------- 20:18:57 INFO - PROCESS | 2867 | 20:18:58 INFO - TEST-INFO | 2867: exit 0 20:18:58 INFO - TEST-OK | kraken | took 63368ms 20:18:58 INFO - SUITE-END | took 1182s 20:18:58 INFO - Completed test suite (00:19:42) 20:18:58 INFO - javascript benchmark 20:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2669.2259244819, 2682.4232789950156, 2710.132757517595, 2718.6737591489023, 2730.713275106113, 4613.446386433633, 4659.3709849170355, 4666.416697912761, 4669.976650116753, 4748.857534273973, 4664.906701865961, 4686.601638860701, 4740.620750339973, 4742.739149346785, 4789.928151077736, 4256.723312984662, 4276.636485898703, 4312.784360781949, 4333.523312435629, 4491.0, 4414.470263568361, 4456.977715111436, 4495.033567782926, 4512.977435112836, 4513.954860451403, 4242.193983143193, 4256.106217694288, 4287.48550173978, 4332.913341733148, 4339.544347843478, 4320.805563749639, 4331.7184383015, 4346.826126954918, 4349.151915376503, 4349.804258808361, 4307.741535507848, 4310.978445107786, 4315.697901146921, 4321.65426765858, 4322.50291216511, 4527.117212143633, 4556.179887620227, 4573.222552166139, 4616.838410655611, 4633.050224703928, 5003.149464591028, 5047.066292735855, 5049.4950504949575, 5110.488951104897, 5134.589232861362, 4865.075635629254, 5120.0, 5159.277701121809, 5159.5614372778355, 5172.405173405069, 4707.29390591414, 4741.312509686076, 4752.1921273383605, 4797.56821886032, 4806.182948898696, 5196.428392876781, 5234.502722241381, 5238.790448382022, 5249.947500524946, 5251.816186433456, 4838.080764654705, 4896.902061958741, 5017.774200161001, 5043.495650435, 5048.899022019539, 5000.899982000413, 5014.07239660664, 5033.144365457881, 5036.84889453317, 5074.644774865797, 4943.9258411123865, 4976.2038073908, 4977.626677999165, 4981.153203955337, 5019.949800502021, 4826.758662066883, 4965.751712414365, 4984.476629953875, 5018.673786203885, 5019.42276638184, 4320.200762858881, 4326.2645350289895, 4326.697131200785, 4345.065810850619, 4350.0, 3760.8495660173835, 3777.3956167013694, 3789.6778773803985, 3811.8094095295123, 3825.9043523912123, 4225.049363893161, 4265.317549192115, 4309.698321117555, 4345.130973805189, 4361.563843615677, 5073.16292811682, 5093.592512598983, 5116.718580478035, 5117.053345131163, 5157.277981082651, 4353.542877997828, 4358.019445624773, 4361.542038086019, 4390.560943905584, 4411.536788637211, 4417.668674849335, 4507.098580283956, 4539.205639013159, 4559.840405585788, 4563.338315944169, 4802.447718512416, 4812.711237325701, 4817.0606731686985, 4822.855314340575, 4877.5366340197625, 5102.132637451717, 5108.846734597968, 5109.1059064662795, 5110.828884964252, 5159.329287192641, 4661.580457758818, 4697.0840686065885, 4704.647151463585, 4759.476457589593, 4763.237881938873, 4935.087008903364, 4945.455999840086, 4945.921027847346, 4948.455669876383, 5007.198848184419, 5032.119379108714, 5043.5712964398435, 5046.571041461517, 5047.697138171721, 5098.923516147187, 4746.762661866962, 4846.588040016497, 4852.272159176152, 4864.513548645107, 4915.5330243626795, 4837.467878533429, 4866.294387313749, 4869.926951095807, 4875.43932447773, 4925.261210818263, 4684.7891844867745, 4833.3958255218095, 4843.2250839865455, 4889.511048895082, 4897.730624815669, 4834.830780922792, 4861.295112208781, 4869.610431165427, 4884.951150488591, 4888.315635810918, 4768.356271903387, 4804.735739534359, 4805.399325084364, 4825.420949486084, 4867.5132486751045], "value": 4633.669614314943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.8080033588916, 593.7001814083887, 598.4195330529385, 605.9636421814691, 609.5763444406134, 39638.0, 41166.17667646649, 41180.588194118085, 44892.3266151008, 44974.775126124405, 42053.36919946203, 42620.0, 42663.14673706524, 42727.572724272744, 42728.35907461391, 7589.848203035936, 7692.615369231544, 7852.607369631524, 7865.606719664022, 10070.79858402835, 9697.0, 10112.089911907928, 10115.291929564934, 10119.696409107739, 10122.089011988919, 10119.291649584533, 10119.595216191343, 10124.0, 10193.439360835151, 10194.337368071088, 7622.885656715126, 7751.22487751226, 7756.263155000266, 9920.503974801231, 10067.899321006806, 9679.951600242024, 9994.550245238981, 9997.350172238781, 9997.400155990592, 10003.249756268237, 38194.42708359377, 38511.22977540433, 38529.61470385316, 38544.22911541782, 38709.419358709645, 3040.4831178699674, 3188.6651901550467, 3479.2867462170193, 3607.981960090209, 3675.7794532328144, 29370.0, 29411.558826617616, 29451.41097178066, 29986.0, 31065.0, 3390.2880395117054, 3390.8304584770663, 3405.455127179664, 3411.2665776858094, 3486.041338631871, 254623.0, 255354.0, 255729.0, 255757.0, 255781.0, 31790.0, 52405.737971310664, 52465.0, 52741.47258527366, 52801.47198528043, 32190.83904580462, 34032.0, 34056.82971585176, 34068.31863362719, 34083.65916340805, 11457.54169833214, 11594.826077608843, 11607.76784464306, 11608.941955290169, 11609.709757256136, 7500.737474188377, 9091.31815113869, 9292.117248861347, 9305.813883722423, 9311.208547273558, 7889.250521200477, 7923.881141782877, 7929.1277959424415, 7985.041794984639, 7988.201179882081, 3091.9536206956914, 3153.369326134782, 3164.683531646863, 3167.255694911694, 3182.0453863840753, 870.5864714260675, 877.7322916510526, 922.4880191493651, 1003.247564326755, 1016.6136867990116, 27641.674956136238, 28217.576736348972, 28220.85889570539, 28281.57825138861, 28347.858260708563, 939.3236869453982, 960.9663661771805, 991.8908920018793, 1033.6588925654517, 1041.234692501011, 14804.259787010606, 14931.925340373446, 15081.472148474752, 15232.238388080774, 15292.0, 419491.0, 423129.0, 423742.0, 423848.0, 425778.0, 33819.492707608915, 33860.66139338575, 33988.49017264743, 34031.489527657104, 34082.48876266858, 1109.5949978257877, 1134.880837512066, 1183.7573297473998, 1221.450347343699, 1224.161449407159, 26335.0, 28644.0, 29077.563836542045, 29498.705012949595, 29519.0, 40974.1805163901, 41402.378964316165, 41407.792961035004, 41441.1711765769, 41470.58529414667, 288065.0, 291895.0, 292520.0, 292950.70492950536, 293526.0, 20740.92590740914, 20747.273845415337, 25343.36641583975, 25389.492210156062, 26407.33981650474, 41836.37245441382, 42117.1576568473, 42203.788981054895, 42601.147977040906, 42602.57397425986, 35413.0, 35929.46105808467, 36230.818845905604, 36564.81717591395, 36650.266994659425, 35562.28875422529, 36101.458478122324, 36247.63752362443, 36528.81735591305, 36549.26901461903, 35944.820275898455, 36198.27603447969, 36313.45529817108, 37319.0, 37441.25117497689, 29859.850700746356, 31555.36889262248, 32087.0, 32111.0, 32308.83845580851, 24578.385540361633, 24618.261452156465, 24628.0, 24870.37824054413, 24910.252692419257], "value": 16663.81166755518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.87439396211323, 359.5846796949524, 366.17793054592426, 379.6260683227023, 385.1622720582732, 16467.50597482076, 16564.585885352873, 16777.916110419446, 17028.914855425737, 17189.656206875872, 16487.67024659509, 16488.0, 16924.4076457324, 17301.91349043253, 17328.480145595622, 4984.651074424792, 5143.12566863634, 5144.717040562768, 5183.53348198662, 5183.663061900965, 3721.1999420124666, 3848.9037774055732, 5097.3373461449955, 5615.213870058195, 5907.320658124328, 5909.7340619672, 5912.615679980788, 5926.822195334147, 5938.228030356047, 5945.613535120204, 5779.162021506858, 5832.329282132546, 5946.940530594682, 5958.672273024982, 5959.135925290852, 3374.0, 4807.783649735736, 5069.06222348863, 5074.949250507521, 5153.2270159476, 19709.310174143837, 20372.0, 20415.0, 20562.0, 20626.58746825055, 1916.0802814648907, 2077.6987336836223, 2102.4323432673245, 2106.9157233710785, 2555.731648176933, 12562.057845661611, 12740.872591274061, 12909.483620655163, 12985.805212921814, 13448.798268025987, 1682.2513981278337, 1749.08173209065, 1754.7894252689632, 1759.498542915263, 1765.5321339844822, 64251.678741605996, 65225.67387163081, 65748.6712566439, 65764.67117664429, 67426.66286668535, 8132.674693012332, 8360.707375241838, 8598.914010859937, 8630.784230394165, 8715.869261961076, 11539.76920461586, 11548.538058477734, 11589.478473468715, 11594.47824847867, 11618.535258589562, 6251.531135164881, 6321.65230912295, 6331.493480521547, 6338.968305158444, 6495.1231583736535, 6053.303870055, 6116.8776624468155, 6186.752529898844, 6206.844828879314, 6220.657863817443, 3387.187075101958, 3555.288942211568, 3567.090391950036, 3609.4224924012033, 3659.597444281127, 1602.070798936614, 1683.2173039536674, 1714.4685147604282, 1735.1411051529321, 1790.3375750972223, 831.3930830493653, 831.821158450936, 839.8740188971581, 845.8181490979468, 906.2115959115612, 16036.518904432885, 16845.0, 16863.91568042152, 16869.746953795704, 17129.914350428167, 803.5781214862244, 822.1696086952221, 858.3262139220682, 859.9054104048549, 892.4779004282567, 8989.309287896527, 9155.908440915638, 9377.1091746284, 9377.812443751087, 9450.52747362629, 355077.0, 380399.0, 381555.0, 381734.0, 383375.0, 71783.0, 71822.64088679523, 72374.0, 72672.0, 73272.63363683148, 913.0777914306598, 915.6062892956093, 923.1783712495884, 954.0125969621408, 971.4025874087386, 14480.927595362376, 14618.561443156723, 15149.469768558047, 15167.91984951841, 15315.61710957235, 33219.40671801645, 33387.33225335431, 33477.49783753197, 33879.32241355209, 34215.0, 41189.58810411858, 47304.29043564418, 47796.0, 47958.76020619875, 47968.760156198994, 6918.757843475454, 7014.123234595676, 7053.329933656294, 7154.177269613853, 7183.748568800067, 9623.951880240555, 10461.947690261804, 10482.37105773656, 10488.68533943983, 10607.0, 9132.315076369166, 9143.13140251675, 9372.906270937203, 9480.810383792148, 9533.332666713264, 9204.861927071233, 9277.907220927704, 9304.302177336862, 9327.207187389147, 9365.812683746151, 9207.953960230425, 9353.906460935303, 9433.151016408556, 9506.572204250688, 9686.806263874823, 6962.860742785015, 6976.860462790614, 7058.71765129389, 7167.7132914682825, 7254.238304977901, 8385.32917366597, 9300.906990930003, 9305.813883722152, 9396.812063758549, 9635.084666956627], "value": 7855.708300456331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.9362531873403, 1366.6515038665138, 1438.9424423023079, 1525.946591869284, 1815.3101821307894, 6731.73073077077, 7681.807954801133, 7918.524888506694, 7930.563818989954, 8112.837743245146, 7904.96047519763, 8039.316658084055, 8045.718399856006, 8046.316063134641, 8051.396145289097, 1886.6226754649126, 1936.9612607747836, 1940.185122248659, 2211.071350032986, 2241.0251540579898, 1986.4239370582513, 2189.211883721859, 2256.7630398808137, 2259.2205689037337, 2276.1350686739015, 2073.8029887160696, 2095.6332641787703, 2096.4654013226605, 2098.58028394321, 2105.536781907978, 1838.1820090059928, 2140.1332460353583, 2142.335875878467, 2145.570885822842, 2148.3662319615596, 2007.096806437109, 2071.0, 2073.2743539761113, 2086.2176683743596, 2087.279888438486, 7817.257360550739, 7893.763187104396, 7896.80257993549, 7900.486468379537, 7903.920960790376, 4588.609968152711, 4727.763611819395, 4733.242681170997, 4734.360861283752, 4735.266033764772, 2789.623400840881, 2862.2128914548666, 2936.412717456496, 2988.8655010524362, 2999.5650630658433, 941.8351788436996, 1647.4069335039376, 1686.1147897353865, 1741.0772290685957, 1748.1783561725968, 10705.892941070568, 10819.891801081967, 10830.67507974762, 10832.458377081193, 10835.67492975212, 4082.7550346978683, 4121.62905338515, 4148.751074935513, 4150.605692459211, 4185.916281674349, 8200.466969646954, 8201.425900187049, 8210.548419836967, 8214.794630134294, 8221.958890205511, 4706.247000479907, 4708.364370809897, 4712.2224832902875, 4713.670043097019, 4718.4809670936165, 3623.7825730456257, 3690.409534474471, 4305.138972205571, 4356.825726970886, 4358.825646974149, 3407.557017587698, 3426.0749597608506, 3513.4202856528896, 3565.6969157621375, 3658.158623516606, 1020.6937918624383, 1021.4637315409469, 1038.787048655024, 1039.3763741755038, 1051.1118105201092, 683.6205905722372, 711.4450728431832, 719.8596273726678, 848.7708318753902, 864.9135086491301, 5161.122609156452, 5221.885136519715, 5354.143337066051, 5438.45615438453, 5513.145462453326, 828.3828547731857, 837.1461109668226, 840.3487297344607, 876.509154873273, 886.9201771840436, 3616.3309787689363, 3688.280785246851, 3759.661630453272, 3875.806209689504, 3897.0, 9214.170724634814, 9459.716208513755, 9502.192313653279, 9520.333576649567, 9525.761855953519, 8984.281257499384, 9316.580753865957, 9454.905450945402, 9522.523873806282, 9524.04759524056, 7295.452841036943, 7311.524750891175, 7470.813229669193, 7485.5508669480005, 7505.737299194502, 5385.38068122171, 5606.495415412633, 5638.4925356718095, 5668.869956182874, 5777.537796976148, 8927.508987005518, 9155.267578593563, 9163.175314221486, 9170.082991700776, 9179.862302065341, 9117.498537580497, 9206.953965230132, 9235.26117910579, 9272.211861991806, 9348.53257337144, 6774.356436138559, 6827.658617069226, 6897.2757860423935, 6908.758193463405, 6913.2049814272, 7485.625718714152, 7515.173330933702, 7533.585652789149, 7576.204498527575, 7576.81057973533, 6671.866562668816, 6796.83007924786, 6924.203716572659, 6955.8608827822145, 6977.232504424611, 6674.365935236145, 6738.629375384401, 6762.797116086525, 6820.113385259884, 6984.965075174591, 6518.413342799171, 6539.051837483443, 6543.574667646588, 6551.082848401133, 6557.639329836905, 4543.6365090792, 4560.771961401851, 4653.286029721939, 4655.427594695738, 4715.78778954941, 4839.758012099452, 4904.166291730486, 4917.729524876167, 4932.28481870134, 4992.475790041994], "value": 4181.0191470011605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.2488442722281, 288.59452469280666, 291.5117178725634, 293.2244214053827, 295.11171374163786, 4773.761311934402, 4809.663323567347, 4812.085703716291, 4839.53183876223, 4865.343178670878, 4736.123817093831, 4760.500147484508, 4791.257355109955, 4793.0, 4805.807767689288, 3574.6246644102384, 3603.4414665726854, 3682.576503702082, 3704.5184126063573, 3735.0, 3616.981915090421, 3681.815909204529, 3714.9071273218115, 3728.6271372862766, 3729.254149170177, 3533.575970883485, 3666.853325866962, 3680.263947210555, 3685.299793039314, 3688.3729765939856, 3585.551806024247, 3733.1787006858585, 3752.7185461090526, 3756.7370284080125, 3764.9623503764888, 3324.1191084362663, 3325.6840600142946, 3336.916577085568, 3347.2134048498583, 3358.596968363812, 4606.401167848158, 4616.8614941551805, 4642.51253618372, 4672.579467847876, 4674.78455601546, 4184.246835569596, 4246.787660616957, 4264.658827293809, 4285.97857010713, 4301.935470967938, 4976.975115124437, 5011.84964451067, 5015.648904576681, 5016.824411145629, 5055.5702765265, 3611.1152767571853, 3627.455881617752, 3628.183658676803, 3635.3456377851976, 3635.963640363589, 5029.949700502984, 5243.842684719464, 5250.396204436501, 5297.602679799031, 5327.840164795062, 3686.8156592170285, 3695.371786796251, 3698.4665504129757, 3725.5529336479253, 3726.720495962814, 3690.870819521304, 3725.1990821973404, 3763.247350529905, 3773.8677647129284, 3776.3013842439236, 4266.274733295348, 4295.140971805651, 4296.892577685583, 4298.817825098123, 4326.502452217972, 4868.95131048692, 4988.451270360258, 5011.57401620859, 5022.096022715873, 5088.898222035538, 1251.837261156044, 1253.7555176740448, 1261.4323554400557, 1276.4702648400996, 1279.9680007999875, 828.6271177969937, 830.6469750356074, 846.5005646668495, 875.9605817738217, 880.8854848869606, 4370.803313850821, 4380.9780951095045, 4398.362237475548, 4474.865754027384, 4481.932771008437, 5074.8835256243565, 5089.251804025785, 5142.51146141116, 5216.634835561475, 5217.2695822584865, 4226.915461690749, 4377.562243775597, 4379.605835474759, 4412.933805992912, 4420.292753159479, 2704.445588654321, 2734.8632568371504, 2739.6028025707033, 2756.0, 2761.558150695879, 4854.927176092361, 4860.055977608914, 4872.049950259736, 4873.463918968911, 4881.707097574157, 5031.8426761844985, 5205.687658740488, 5217.321748172713, 5258.421573626898, 5266.603041038586, 4831.565159135765, 4837.758112094381, 4843.975780121147, 4847.079054979543, 4857.587105096107, 5082.923756143735, 5094.223648111714, 5116.9744151279, 5163.483651634807, 5173.198154286091, 4954.405471343462, 4997.5002499749735, 5042.823501177441, 5065.214891691794, 5090.160123579568, 4809.254565542346, 4815.590674792542, 4862.586680132228, 4863.635227357891, 4880.609551235963, 3642.5628924528164, 3649.9270014600093, 3670.22925185714, 3677.1542545215284, 3692.7968961707365, 4926.413632842786, 5089.745512724423, 5118.3090282811345, 5129.615278854027, 5159.535641792257, 4848.0, 4857.295692124693, 4919.262110683283, 4920.450058231646, 4926.5073492650445, 4931.852044438672, 4934.087193869145, 4965.386249468865, 4970.502949705001, 4982.75086245679, 4668.253079507263, 4883.95116048835, 4891.486393928729, 4903.651495838673, 4905.386826646669, 4795.880102997314, 4876.756162191805, 5018.4730603286125, 5024.723640199824, 5033.295338652665, 4945.554900059012, 4948.851534453972, 4951.2078067510465, 4995.575376093073, 5001.549860512426], "value": 3769.962817884318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.7875879718489, 679.7858674517527, 697.7589098636835, 707.9663691011124, 737.8044818123199, 12093.939530302347, 12509.562165324216, 12667.4799024117, 12676.683082922931, 12707.809382859265, 13069.803952940714, 13521.661958451044, 13575.117617354865, 13663.521776737816, 13678.726425471485, 642.0497663458085, 787.8306164174701, 820.8030072782519, 823.6293667849462, 828.391132517602, 810.6838333050115, 824.5671022713094, 824.5877061469265, 824.5918270456133, 824.8226631274275, 842.2377748137915, 845.1590667286059, 847.995760021199, 848.9702860399888, 849.4181485682327, 660.7224965514496, 829.2619568583905, 842.1283971089923, 843.4306842881031, 848.3806821020628, 622.2315440431064, 623.2458724942825, 623.6569886562418, 623.8378021714342, 624.1667374055642, 12431.502739890393, 12434.689132771662, 12446.439910204062, 12450.128491005542, 12472.376381180995, 11428.885711142866, 11666.358350290731, 11678.299302041905, 11884.465199066062, 12016.879831201752, 11102.833457498144, 11110.722231944184, 11114.555417783278, 11223.0, 11337.206395552315, 4028.979855100735, 4042.353223484258, 4071.2671719090554, 4084.244414783275, 4134.689898257643, 47753.761231193625, 47851.52148478505, 48230.75884620554, 48245.517544824455, 48570.75714621404, 9678.17735492477, 9721.222302215805, 9757.756056098513, 9816.509174541245, 9819.06718861707, 16448.588785280463, 17276.65446691059, 17408.39070632522, 17438.91280543589, 17463.21415536304, 6482.837929051811, 6527.118838956775, 6554.737810487527, 6726.8654626908165, 6851.760188393382, 3562.679358857715, 3673.412254039394, 3688.6495782900583, 3707.9814600926825, 3838.5201849768778, 2846.957295640567, 2928.546075358323, 2937.618109645775, 2941.205874413939, 2941.382309714941, 499.6028157614705, 513.2609042978099, 516.0092622165452, 522.1775703267369, 523.0898237067476, 450.3964687319008, 464.7281340415827, 616.3589866538749, 659.3472462262325, 661.163628010567, 7993.160718124629, 8221.095679475253, 8334.66661333552, 8368.205020523163, 8371.748847534584, 549.3599956051156, 596.5108610938988, 609.9613823150842, 635.0854769132435, 646.5506473001219, 3587.712982961409, 3658.506101676293, 3720.144366795598, 3722.590515043343, 3736.663700266989, 55532.72233638887, 57501.0, 57553.13670294949, 57588.0, 58490.70754646199, 48866.0, 49043.75478122586, 49595.0, 50095.0, 52909.47090529122, 42125.789371052946, 45247.77376113164, 45287.0, 45668.314975275396, 46355.76822115868, 7975.723884178504, 8321.667133314842, 8472.44929079608, 8486.74539763808, 8539.274161696325, 30467.542986855657, 30993.0, 31609.36781264316, 32009.0, 32240.355192895542, 39059.41410878782, 41097.0, 41210.79394603008, 41569.1686166281, 42016.36975445432, 10924.453777311262, 11151.219414640897, 11626.476808543466, 11681.941590291994, 12166.635000949986, 12127.939360303142, 12129.878701213227, 12188.939055304667, 12330.0, 13000.804987925378, 11388.37363944991, 11634.592789252336, 11745.060395168195, 11759.60532217066, 12043.397830108635, 11104.222704410937, 11460.19778615489, 11748.530058797553, 11758.118141139277, 11766.823497647714, 10961.177911656498, 11835.11236657237, 12145.514179432723, 12205.084618653815, 12223.57217497419, 9425.970444918923, 9704.805903882025, 9770.218382529523, 9773.0, 9921.25590580695, 9186.265098791948, 9419.387739797165, 9616.278779091455, 9845.60617575289, 9957.601695932082], "value": 6112.564060929571, "unit": "score"}], "name": "dromaeo_css", "value": 6229.631872307262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 113.0, 113.0, 112.0, 113.0, 111.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 140.0, 132.0, 175.0, 139.0, 150.0, 155.0, 134.0, 186.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 109.0, 75.0, 77.0, 75.0, 75.0, 100.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 117.0, 84.0, 84.0, 84.0, 122.0, 84.0, 84.0, 119.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 85.0, 63.0, 62.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 68.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 88.0, 86.0, 84.0, 84.0, 84.0, 84.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 127.0, 128.0, 129.0, 128.0, 134.0, 138.0, 169.0, 131.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 177.0, 172.0, 172.0, 168.0, 171.0, 172.0, 180.0, 169.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 71.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1549.3999999999999, "alertThreshold": 2.0}]} 20:18:58 INFO - Return code: 0 20:18:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:18:59 ERROR - # TBPL SUCCESS # 20:18:59 INFO - Running post-action listener: _resource_record_post_action 20:18:59 INFO - ##### 20:18:59 INFO - ##### Finished run-tests step (success) 20:18:59 INFO - ##### 20:18:59 INFO - Running post-run listener: _resource_record_post_run 20:18:59 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522403840; Read time: 8; Write time: 423512 20:18:59 INFO - TinderboxPrint: CPU usage
13.1% 20:18:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:18:59 INFO - TinderboxPrint: I/O write bytes / time
522,403,840 / 423,512 20:18:59 INFO - TinderboxPrint: CPU idle
8,317.2 (86.9%) 20:18:59 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 20:18:59 INFO - TinderboxPrint: Swap in / out
0 / 0 20:18:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236990464; Read time: 0; Write time: 210068 20:18:59 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285413376; Read time: 8; Write time: 213444 20:18:59 INFO - Running post-run listener: _upload_blobber_files 20:18:59 INFO - Blob upload gear active. 20:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:59 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 20:18:59 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:18:59 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:19:00 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:00 INFO - (blobuploader) - INFO - Done attempting. 20:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:01 INFO - (blobuploader) - INFO - Done attempting. 20:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:06 INFO - (blobuploader) - INFO - Done attempting. 20:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:06 INFO - Return code: 0 20:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40866fa1953fd70798ab6ce1633c659197d2b8dd80f94a22dd02e672254f68fc1fb9ab6fd3e15c6d0b50267169f2bbfe0f93ef283af3b9bd60a770c3d4ede966", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/162c4b84fd74fae27ea4e2f5e529ca547c8b26be3fd7579c547832da9c925ce7a2c1e144825da0900d94a930bbcfa03f8dc861b2c21362f1468879b5f4ff13c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e11a30cda3af165f95f0ff16eb8f5b7e2464392137ece5a02466861f2a2d7c2d1c2169212af7a8615bb3faebf52965fff816c82fc5cb39b0ff6c3bd5be06bd60"} 20:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:06 INFO - Contents: 20:19:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40866fa1953fd70798ab6ce1633c659197d2b8dd80f94a22dd02e672254f68fc1fb9ab6fd3e15c6d0b50267169f2bbfe0f93ef283af3b9bd60a770c3d4ede966", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/162c4b84fd74fae27ea4e2f5e529ca547c8b26be3fd7579c547832da9c925ce7a2c1e144825da0900d94a930bbcfa03f8dc861b2c21362f1468879b5f4ff13c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e11a30cda3af165f95f0ff16eb8f5b7e2464392137ece5a02466861f2a2d7c2d1c2169212af7a8615bb3faebf52965fff816c82fc5cb39b0ff6c3bd5be06bd60"} 20:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:06 INFO - Copying logs to upload dir... 20:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.474718 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-26 20:19:06.283990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:19:06.287895) ========= 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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40866fa1953fd70798ab6ce1633c659197d2b8dd80f94a22dd02e672254f68fc1fb9ab6fd3e15c6d0b50267169f2bbfe0f93ef283af3b9bd60a770c3d4ede966", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/162c4b84fd74fae27ea4e2f5e529ca547c8b26be3fd7579c547832da9c925ce7a2c1e144825da0900d94a930bbcfa03f8dc861b2c21362f1468879b5f4ff13c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e11a30cda3af165f95f0ff16eb8f5b7e2464392137ece5a02466861f2a2d7c2d1c2169212af7a8615bb3faebf52965fff816c82fc5cb39b0ff6c3bd5be06bd60"} build_url:https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/J2sjs728Qgm_oQekp9uUEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40866fa1953fd70798ab6ce1633c659197d2b8dd80f94a22dd02e672254f68fc1fb9ab6fd3e15c6d0b50267169f2bbfe0f93ef283af3b9bd60a770c3d4ede966", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/162c4b84fd74fae27ea4e2f5e529ca547c8b26be3fd7579c547832da9c925ce7a2c1e144825da0900d94a930bbcfa03f8dc861b2c21362f1468879b5f4ff13c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e11a30cda3af165f95f0ff16eb8f5b7e2464392137ece5a02466861f2a2d7c2d1c2169212af7a8615bb3faebf52965fff816c82fc5cb39b0ff6c3bd5be06bd60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:19:06.314980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:19:06.315315) ========= 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=41bf3e9aed84707956354da8000001c5-1464317903.535334-1549360447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:19:06.397293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:19:06.397616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:19:06.397912) ========= ========= Total master_lag: 0.17 =========