builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1463807597.86 results: success (0) buildid: 20160520193101 builduid: b44a9fae169341edb831c445c26a6511 revision: 928fa0c9a879641dcd76b71243da6a6cff70d2d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.861396) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.861797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.862086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.882375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.882681) ========= 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=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 22:13:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.9M=0s 2016-05-20 22:13:18 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.972404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:17.972719) ========= 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=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.022000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.022315) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 928fa0c9a879641dcd76b71243da6a6cff70d2d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 928fa0c9a879641dcd76b71243da6a6cff70d2d2 --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=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 22:13:18,418 truncating revision to first 12 chars 2016-05-20 22:13:18,418 Setting DEBUG logging. 2016-05-20 22:13:18,418 attempt 1/10 2016-05-20 22:13:18,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/928fa0c9a879?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 22:13:18,667 unpacking tar archive at: mozilla-inbound-928fa0c9a879/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513052 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.571792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.572082) ========= script_repo_revision: 928fa0c9a879641dcd76b71243da6a6cff70d2d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.572498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.572797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 22:13:18.590633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-20 22:13:18.590913) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:13:19 INFO - MultiFileLogger online at 20160520 22:13:19 in /builds/slave/test 22:13:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:13:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:13:19 INFO - {'append_to_log': False, 22:13:19 INFO - 'base_work_dir': '/builds/slave/test', 22:13:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:13:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:13:19 INFO - 'branch': 'Mozilla-Inbound', 22:13:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:13:19 INFO - 'config_files': ('talos/linux_config.py',), 22:13:19 INFO - 'default_actions': ('clobber', 22:13:19 INFO - 'read-buildbot-config', 22:13:19 INFO - 'download-and-extract', 22:13:19 INFO - 'populate-webroot', 22:13:19 INFO - 'create-virtualenv', 22:13:19 INFO - 'install', 22:13:19 INFO - 'run-tests'), 22:13:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:13:19 INFO - 'download_minidump_stackwalk': True, 22:13:19 INFO - 'download_symbols': 'ondemand', 22:13:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:13:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:13:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:13:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:13:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:13:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:13:19 INFO - 'installer_path': 'installer.exe', 22:13:19 INFO - 'log_level': 'info', 22:13:19 INFO - 'log_name': 'talos', 22:13:19 INFO - 'log_to_console': True, 22:13:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:13:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:13:19 INFO - 'opt_config_files': (), 22:13:19 INFO - 'pip_index': False, 22:13:19 INFO - 'sps_profile': False, 22:13:19 INFO - 'sps_profile_interval': 0, 22:13:19 INFO - 'suite': 'dromaeojs', 22:13:19 INFO - 'system_bits': '32', 22:13:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:13:19 INFO - 'title': 'talos-linux64-ix-063', 22:13:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:13:19 INFO - 'use_talos_json': True, 22:13:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:13:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:13:19 INFO - 'work_dir': 'build'} 22:13:19 INFO - ##### 22:13:19 INFO - ##### Running clobber step. 22:13:19 INFO - ##### 22:13:19 INFO - Running pre-action listener: _resource_record_pre_action 22:13:19 INFO - Running main action method: clobber 22:13:19 INFO - rmtree: /builds/slave/test/build 22:13:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:13:20 INFO - Running post-action listener: _resource_record_post_action 22:13:20 INFO - ##### 22:13:20 INFO - ##### Finished clobber step (success) 22:13:20 INFO - ##### 22:13:20 INFO - ##### 22:13:20 INFO - ##### Running read-buildbot-config step. 22:13:20 INFO - ##### 22:13:20 INFO - Running pre-action listener: _resource_record_pre_action 22:13:20 INFO - Running main action method: read_buildbot_config 22:13:20 INFO - Using buildbot properties: 22:13:20 INFO - { 22:13:20 INFO - "project": "", 22:13:20 INFO - "product": "firefox", 22:13:20 INFO - "script_repo_revision": "production", 22:13:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:13:20 INFO - "repository": "", 22:13:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:13:20 INFO - "buildid": "20160520193101", 22:13:20 INFO - "pgo_build": "True", 22:13:20 INFO - "basedir": "/builds/slave/test", 22:13:20 INFO - "buildnumber": 954, 22:13:20 INFO - "slavename": "talos-linux64-ix-063", 22:13:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:13:20 INFO - "platform": "ubuntu64_hw", 22:13:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:13:20 INFO - "branch": "mozilla-inbound", 22:13:20 INFO - "repo_path": "integration/mozilla-inbound", 22:13:20 INFO - "revision": "928fa0c9a879641dcd76b71243da6a6cff70d2d2", 22:13:20 INFO - "stage_platform": "linux64-pgo", 22:13:20 INFO - "builduid": "b44a9fae169341edb831c445c26a6511", 22:13:20 INFO - "slavebuilddir": "test" 22:13:20 INFO - } 22:13:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:13:20 INFO - Running post-action listener: _resource_record_post_action 22:13:20 INFO - ##### 22:13:20 INFO - ##### Finished read-buildbot-config step (success) 22:13:20 INFO - ##### 22:13:20 INFO - ##### 22:13:20 INFO - ##### Running download-and-extract step. 22:13:20 INFO - ##### 22:13:20 INFO - Running pre-action listener: _resource_record_pre_action 22:13:20 INFO - Running main action method: download_and_extract 22:13:20 INFO - mkdir: /builds/slave/test/build/tests 22:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:20 INFO - https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:13:21 INFO - Downloaded 1361 bytes. 22:13:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:13:21 INFO - Using the following test package requirements: 22:13:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:13:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:13:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'jsshell-linux-x86_64.zip'], 22:13:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:13:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:13:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:13:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:13:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:13:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:21 INFO - https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:25 INFO - Downloaded 24388824 bytes. 22:13:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:26 INFO - Return code: 0 22:13:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13: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')]} 22:13:26 INFO - https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:39 INFO - Downloaded 24388824 bytes. 22:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:41 INFO - Return code: 0 22:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:41 INFO - https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:13:42 INFO - Downloaded 10840359 bytes. 22:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:13:42 INFO - Return code: 0 22:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:42 INFO - https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:43 INFO - Downloaded 58580554 bytes. 22:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:13:43 INFO - mkdir: /builds/slave/test/properties 22:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:43 INFO - Contents: 22:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:13:44 INFO - Running post-action listener: _resource_record_post_action 22:13:44 INFO - Running post-action listener: set_extra_try_arguments 22:13:44 INFO - ##### 22:13:44 INFO - ##### Finished download-and-extract step (success) 22:13:44 INFO - ##### 22:13:44 INFO - ##### 22:13:44 INFO - ##### Running populate-webroot step. 22:13:44 INFO - ##### 22:13:44 INFO - Running pre-action listener: _resource_record_pre_action 22:13:44 INFO - Running main action method: populate_webroot 22:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:44 INFO - '--tppagecycles', 22:13:44 INFO - '7'], 22:13:44 INFO - 'tests': ['tsvgm']}}, 22:13:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['damp', 'tps']}, 22:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['damp', 'tps']}, 22:13:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['dromaeo_dom']}, 22:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['tsvgx', 22:13:44 INFO - 'tsvgr_opacity', 22:13:44 INFO - 'tart', 22:13:44 INFO - 'tscrollx', 22:13:44 INFO - 'cart']}, 22:13:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:44 INFO - 'tsvgr_opacity', 22:13:44 INFO - 'tart', 22:13:44 INFO - 'tscrollx', 22:13:44 INFO - 'cart']}, 22:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--disable-e10s'], 22:13:44 INFO - 'tests': ['tp5o']}, 22:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['tp5o']}, 22:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--disable-e10s', 22:13:44 INFO - '--xperf_path', 22:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:44 INFO - 'tests': ['tp5n']}, 22:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--xperf_path', 22:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:44 INFO - 'tests': ['tp5n']}}, 22:13:44 INFO - 'talos.zip': {'path': '', 22:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:44 INFO - Running post-action listener: _resource_record_post_action 22:13:44 INFO - ##### 22:13:44 INFO - ##### Finished populate-webroot step (success) 22:13:44 INFO - ##### 22:13:44 INFO - ##### 22:13:44 INFO - ##### Running create-virtualenv step. 22:13:44 INFO - ##### 22:13:44 INFO - Running pre-action listener: _resource_record_pre_action 22:13:44 INFO - Running main action method: create_virtualenv 22:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:45 INFO - Using real prefix '/usr' 22:13:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:47 INFO - Installing pip.................done. 22:13:47 INFO - Return code: 0 22:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:13:47 INFO - Using env: {'DISPLAY': ':0', 22:13:47 INFO - 'HOME': '/home/cltbld', 22:13:47 INFO - 'LANG': 'en_US.UTF-8', 22:13:47 INFO - 'LANGUAGE': 'en_US:en', 22:13:47 INFO - 'LOGNAME': 'cltbld', 22:13:47 INFO - 'MAIL': '/var/mail/cltbld', 22:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:47 INFO - 'MOZ_NO_REMOTE': '1', 22:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:47 INFO - 'NO_EM_RESTART': '1', 22:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:47 INFO - 'PWD': '/builds/slave/test', 22:13:47 INFO - 'SHELL': '/bin/bash', 22:13:47 INFO - 'SHLVL': '1', 22:13:47 INFO - 'TERM': 'linux', 22:13:47 INFO - 'TMOUT': '86400', 22:13:47 INFO - 'USER': 'cltbld', 22:13:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:47 INFO - '_': '/tools/buildbot/bin/python'} 22:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:13:47 INFO - Cleaning up... 22:13:47 INFO - Return code: 0 22:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:47 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:13:47 INFO - Using env: {'DISPLAY': ':0', 22:13:47 INFO - 'HOME': '/home/cltbld', 22:13:47 INFO - 'LANG': 'en_US.UTF-8', 22:13:47 INFO - 'LANGUAGE': 'en_US:en', 22:13:47 INFO - 'LOGNAME': 'cltbld', 22:13:47 INFO - 'MAIL': '/var/mail/cltbld', 22:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:47 INFO - 'MOZ_NO_REMOTE': '1', 22:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:47 INFO - 'NO_EM_RESTART': '1', 22:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:47 INFO - 'PWD': '/builds/slave/test', 22:13:47 INFO - 'SHELL': '/bin/bash', 22:13:47 INFO - 'SHLVL': '1', 22:13:47 INFO - 'TERM': 'linux', 22:13:47 INFO - 'TMOUT': '86400', 22:13:47 INFO - 'USER': 'cltbld', 22:13:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:47 INFO - '_': '/tools/buildbot/bin/python'} 22:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:47 INFO - Downloading/unpacking psutil>=3.1.1 22:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:49 INFO - Installing collected packages: psutil 22:13:49 INFO - Running setup.py install for psutil 22:13:50 INFO - building 'psutil._psutil_linux' extension 22:13:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:13:50 INFO - building 'psutil._psutil_posix' extension 22:13:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:50 INFO - Successfully installed psutil 22:13:50 INFO - Cleaning up... 22:13:50 INFO - Return code: 0 22:13:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:50 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:13:50 INFO - Using env: {'DISPLAY': ':0', 22:13:50 INFO - 'HOME': '/home/cltbld', 22:13:50 INFO - 'LANG': 'en_US.UTF-8', 22:13:50 INFO - 'LANGUAGE': 'en_US:en', 22:13:50 INFO - 'LOGNAME': 'cltbld', 22:13:50 INFO - 'MAIL': '/var/mail/cltbld', 22:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:50 INFO - 'MOZ_NO_REMOTE': '1', 22:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:50 INFO - 'NO_EM_RESTART': '1', 22:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:50 INFO - 'PWD': '/builds/slave/test', 22:13:50 INFO - 'SHELL': '/bin/bash', 22:13:50 INFO - 'SHLVL': '1', 22:13:50 INFO - 'TERM': 'linux', 22:13:50 INFO - 'TMOUT': '86400', 22:13:50 INFO - 'USER': 'cltbld', 22:13:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:50 INFO - '_': '/tools/buildbot/bin/python'} 22:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:52 INFO - Installing collected packages: mozsystemmonitor 22:13:52 INFO - Running setup.py install for mozsystemmonitor 22:13:52 INFO - Successfully installed mozsystemmonitor 22:13:52 INFO - Cleaning up... 22:13:52 INFO - Return code: 0 22:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:13:52 INFO - Using env: {'DISPLAY': ':0', 22:13:52 INFO - 'HOME': '/home/cltbld', 22:13:52 INFO - 'LANG': 'en_US.UTF-8', 22:13:52 INFO - 'LANGUAGE': 'en_US:en', 22:13:52 INFO - 'LOGNAME': 'cltbld', 22:13:52 INFO - 'MAIL': '/var/mail/cltbld', 22:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:52 INFO - 'MOZ_NO_REMOTE': '1', 22:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:52 INFO - 'NO_EM_RESTART': '1', 22:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:52 INFO - 'PWD': '/builds/slave/test', 22:13:52 INFO - 'SHELL': '/bin/bash', 22:13:52 INFO - 'SHLVL': '1', 22:13:52 INFO - 'TERM': 'linux', 22:13:52 INFO - 'TMOUT': '86400', 22:13:52 INFO - 'USER': 'cltbld', 22:13:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:52 INFO - '_': '/tools/buildbot/bin/python'} 22:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - Downloading docopt-0.6.1.tar.gz 22:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:55 INFO - Running setup.py install for blobuploader 22:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:55 INFO - Running setup.py install for requests 22:13:56 INFO - Running setup.py install for docopt 22:13:56 INFO - Successfully installed blobuploader requests docopt 22:13:56 INFO - Cleaning up... 22:13:56 INFO - Return code: 0 22:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:56 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:13:56 INFO - Using env: {'DISPLAY': ':0', 22:13:56 INFO - 'HOME': '/home/cltbld', 22:13:56 INFO - 'LANG': 'en_US.UTF-8', 22:13:56 INFO - 'LANGUAGE': 'en_US:en', 22:13:56 INFO - 'LOGNAME': 'cltbld', 22:13:56 INFO - 'MAIL': '/var/mail/cltbld', 22:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:56 INFO - 'MOZ_NO_REMOTE': '1', 22:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:56 INFO - 'NO_EM_RESTART': '1', 22:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:56 INFO - 'PWD': '/builds/slave/test', 22:13:56 INFO - 'SHELL': '/bin/bash', 22:13:56 INFO - 'SHLVL': '1', 22:13:56 INFO - 'TERM': 'linux', 22:13:56 INFO - 'TMOUT': '86400', 22:13:56 INFO - 'USER': 'cltbld', 22:13:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:56 INFO - '_': '/tools/buildbot/bin/python'} 22:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:56 INFO - Running setup.py (path:/tmp/pip-zdpW66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:56 INFO - Running setup.py (path:/tmp/pip-VgHLFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:56 INFO - Running setup.py (path:/tmp/pip-0fLlCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:56 INFO - Running setup.py (path:/tmp/pip-ecTVfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:56 INFO - Running setup.py (path:/tmp/pip-OkXHNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:56 INFO - Running setup.py (path:/tmp/pip-qfXjmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:56 INFO - Running setup.py (path:/tmp/pip-UgevK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:56 INFO - Running setup.py (path:/tmp/pip-zsuZ16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:57 INFO - Running setup.py (path:/tmp/pip-mHFUmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:57 INFO - Running setup.py (path:/tmp/pip-Yy2Frx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:57 INFO - Running setup.py (path:/tmp/pip-tmiqec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:57 INFO - Running setup.py (path:/tmp/pip-YlEaSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:57 INFO - Running setup.py (path:/tmp/pip-UjoKDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:57 INFO - Running setup.py (path:/tmp/pip-MSVdvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:57 INFO - Running setup.py (path:/tmp/pip-to0ymA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:57 INFO - Running setup.py (path:/tmp/pip-nR6v2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:57 INFO - Running setup.py (path:/tmp/pip-Xl7aCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:57 INFO - Running setup.py install for manifestparser 22:13:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:57 INFO - Running setup.py install for mozcrash 22:13:57 INFO - Running setup.py install for mozdebug 22:13:58 INFO - Running setup.py install for mozdevice 22:13:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozfile 22:13:58 INFO - Running setup.py install for mozhttpd 22:13:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozinfo 22:13:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozInstall 22:13:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozleak 22:13:58 INFO - Running setup.py install for mozlog 22:13:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for moznetwork 22:13:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozprocess 22:13:58 INFO - Running setup.py install for mozprofile 22:13:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Running setup.py install for mozrunner 22:13:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Running setup.py install for mozscreenshot 22:13:59 INFO - Running setup.py install for moztest 22:13:59 INFO - Running setup.py install for mozversion 22:13:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:59 INFO - Cleaning up... 22:13:59 INFO - Return code: 0 22:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:59 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:13:59 INFO - Using env: {'DISPLAY': ':0', 22:13:59 INFO - 'HOME': '/home/cltbld', 22:13:59 INFO - 'LANG': 'en_US.UTF-8', 22:13:59 INFO - 'LANGUAGE': 'en_US:en', 22:13:59 INFO - 'LOGNAME': 'cltbld', 22:13:59 INFO - 'MAIL': '/var/mail/cltbld', 22:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:59 INFO - 'MOZ_NO_REMOTE': '1', 22:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:59 INFO - 'NO_EM_RESTART': '1', 22:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:59 INFO - 'PWD': '/builds/slave/test', 22:13:59 INFO - 'SHELL': '/bin/bash', 22:13:59 INFO - 'SHLVL': '1', 22:13:59 INFO - 'TERM': 'linux', 22:13:59 INFO - 'TMOUT': '86400', 22:13:59 INFO - 'USER': 'cltbld', 22:13:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:59 INFO - '_': '/tools/buildbot/bin/python'} 22:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:59 INFO - Running setup.py (path:/tmp/pip-W7eGHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:59 INFO - Running setup.py (path:/tmp/pip-PcmE9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:59 INFO - Running setup.py (path:/tmp/pip-uwoeii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:59 INFO - Running setup.py (path:/tmp/pip-D5r205-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:14:00 INFO - Running setup.py (path:/tmp/pip-DJLeVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:14:00 INFO - Running setup.py (path:/tmp/pip-s937Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:14:00 INFO - Running setup.py (path:/tmp/pip-b8YEOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:14:00 INFO - Running setup.py (path:/tmp/pip-AkK1Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:14:00 INFO - Running setup.py (path:/tmp/pip-J9YwkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:14:00 INFO - Running setup.py (path:/tmp/pip-OKM2qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:14:00 INFO - Running setup.py (path:/tmp/pip-DWKBSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:14:00 INFO - Running setup.py (path:/tmp/pip-FN3fxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:14:00 INFO - Running setup.py (path:/tmp/pip-c_AAjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:14:00 INFO - Running setup.py (path:/tmp/pip-WYGoPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:00 INFO - Running setup.py (path:/tmp/pip-ymxiVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:14:00 INFO - Running setup.py (path:/tmp/pip-dwyyxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:14:00 INFO - Running setup.py (path:/tmp/pip-tDqyBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:02 INFO - Downloading blessings-1.6.tar.gz 22:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:14:02 INFO - Installing collected packages: blessings 22:14:02 INFO - Running setup.py install for blessings 22:14:03 INFO - Successfully installed blessings 22:14:03 INFO - Cleaning up... 22:14:03 INFO - Return code: 0 22:14:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:03 INFO - Reading from file tmpfile_stdout 22:14:03 INFO - Current package versions: 22:14:03 INFO - argparse == 1.2.1 22:14:03 INFO - blessings == 1.6 22:14:03 INFO - blobuploader == 1.2.4 22:14:03 INFO - docopt == 0.6.1 22:14:03 INFO - manifestparser == 1.1 22:14:03 INFO - mozInstall == 1.12 22:14:03 INFO - mozcrash == 0.17 22:14:03 INFO - mozdebug == 0.1 22:14:03 INFO - mozdevice == 0.48 22:14:03 INFO - mozfile == 1.2 22:14:03 INFO - mozhttpd == 0.7 22:14:03 INFO - mozinfo == 0.9 22:14:03 INFO - mozleak == 0.1 22:14:03 INFO - mozlog == 3.2 22:14:03 INFO - moznetwork == 0.27 22:14:03 INFO - mozprocess == 0.22 22:14:03 INFO - mozprofile == 0.28 22:14:03 INFO - mozrunner == 6.11 22:14:03 INFO - mozscreenshot == 0.1 22:14:03 INFO - mozsystemmonitor == 0.3 22:14:03 INFO - moztest == 0.7 22:14:03 INFO - mozversion == 1.4 22:14:03 INFO - psutil == 3.1.1 22:14:03 INFO - requests == 1.2.3 22:14:03 INFO - wsgiref == 0.1.2 22:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 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 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:14:03 INFO - Using env: {'DISPLAY': ':0', 22:14:03 INFO - 'HOME': '/home/cltbld', 22:14:03 INFO - 'LANG': 'en_US.UTF-8', 22:14:03 INFO - 'LANGUAGE': 'en_US:en', 22:14:03 INFO - 'LOGNAME': 'cltbld', 22:14:03 INFO - 'MAIL': '/var/mail/cltbld', 22:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:03 INFO - 'MOZ_NO_REMOTE': '1', 22:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:03 INFO - 'NO_EM_RESTART': '1', 22:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:03 INFO - 'PWD': '/builds/slave/test', 22:14:03 INFO - 'SHELL': '/bin/bash', 22:14:03 INFO - 'SHLVL': '1', 22:14:03 INFO - 'TERM': 'linux', 22:14:03 INFO - 'TMOUT': '86400', 22:14:03 INFO - 'USER': 'cltbld', 22:14:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:03 INFO - '_': '/tools/buildbot/bin/python'} 22:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:14:03 INFO - Cleaning up... 22:14:03 INFO - Return code: 0 22:14:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:14:03 INFO - Using env: {'DISPLAY': ':0', 22:14:03 INFO - 'HOME': '/home/cltbld', 22:14:03 INFO - 'LANG': 'en_US.UTF-8', 22:14:03 INFO - 'LANGUAGE': 'en_US:en', 22:14:03 INFO - 'LOGNAME': 'cltbld', 22:14:03 INFO - 'MAIL': '/var/mail/cltbld', 22:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:03 INFO - 'MOZ_NO_REMOTE': '1', 22:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:03 INFO - 'NO_EM_RESTART': '1', 22:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:03 INFO - 'PWD': '/builds/slave/test', 22:14:03 INFO - 'SHELL': '/bin/bash', 22:14:03 INFO - 'SHLVL': '1', 22:14:03 INFO - 'TERM': 'linux', 22:14:03 INFO - 'TMOUT': '86400', 22:14:03 INFO - 'USER': 'cltbld', 22:14:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:03 INFO - '_': '/tools/buildbot/bin/python'} 22:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:03 INFO - Downloading/unpacking jsonschema 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:14:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:14:05 INFO - warning: no files found matching '*.txt' 22:14:05 INFO - no previously-included directories found matching 'build' 22:14:05 INFO - no previously-included directories found matching 'dist' 22:14:05 INFO - no previously-included directories found matching '.git*' 22:14:05 INFO - Installing collected packages: jsonschema, functools32 22:14:05 INFO - Running setup.py install for functools32 22:14:05 INFO - warning: no files found matching '*.txt' 22:14:05 INFO - no previously-included directories found matching 'build' 22:14:05 INFO - no previously-included directories found matching 'dist' 22:14:05 INFO - no previously-included directories found matching '.git*' 22:14:06 INFO - Successfully installed jsonschema functools32 22:14:06 INFO - Cleaning up... 22:14:06 INFO - Return code: 0 22:14:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b4e97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:14:06 INFO - Using env: {'DISPLAY': ':0', 22:14:06 INFO - 'HOME': '/home/cltbld', 22:14:06 INFO - 'LANG': 'en_US.UTF-8', 22:14:06 INFO - 'LANGUAGE': 'en_US:en', 22:14:06 INFO - 'LOGNAME': 'cltbld', 22:14:06 INFO - 'MAIL': '/var/mail/cltbld', 22:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:06 INFO - 'MOZ_NO_REMOTE': '1', 22:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:06 INFO - 'NO_EM_RESTART': '1', 22:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:06 INFO - 'PWD': '/builds/slave/test', 22:14:06 INFO - 'SHELL': '/bin/bash', 22:14:06 INFO - 'SHLVL': '1', 22:14:06 INFO - 'TERM': 'linux', 22:14:06 INFO - 'TMOUT': '86400', 22:14:06 INFO - 'USER': 'cltbld', 22:14:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:06 INFO - '_': '/tools/buildbot/bin/python'} 22:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:06 INFO - Downloading/unpacking flake8 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:14:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:14:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:14:08 INFO - no previously-included directories found matching 'docs/_build' 22:14:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:14:08 INFO - Running setup.py install for pep8 22:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:14:09 INFO - no previously-included directories found matching 'docs/_build' 22:14:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:14:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:14:09 INFO - Cleaning up... 22:14:09 INFO - Return code: 0 22:14:09 INFO - Running post-action listener: _resource_record_post_action 22:14:09 INFO - Running post-action listener: _start_resource_monitoring 22:14:09 INFO - Starting resource monitoring. 22:14:09 INFO - ##### 22:14:09 INFO - ##### Finished create-virtualenv step (success) 22:14:09 INFO - ##### 22:14:09 INFO - ##### 22:14:09 INFO - ##### Running install step. 22:14:09 INFO - ##### 22:14:09 INFO - Running pre-action listener: _resource_record_pre_action 22:14:09 INFO - Running main action method: install 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:09 INFO - Reading from file tmpfile_stdout 22:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:14:09 INFO - Reading from file tmpfile_stdout 22:14:09 INFO - Output received: 22:14:09 INFO - Usage: mozinstall [options] installer 22:14:09 INFO - Options: 22:14:09 INFO - -h, --help show this help message and exit 22:14:09 INFO - -d DEST, --destination=DEST 22:14:09 INFO - Directory to install application into. [default: 22:14:09 INFO - "/builds/slave/test"] 22:14:09 INFO - --app=APP Application being installed. [default: firefox] 22:14:09 INFO - mkdir: /builds/slave/test/build/application 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:14:30 INFO - Reading from file tmpfile_stdout 22:14:33 INFO - Output received: 22:14:33 INFO - /builds/slave/test/build/application/firefox/firefox 22:14:33 INFO - Running post-action listener: _resource_record_post_action 22:14:33 INFO - ##### 22:14:33 INFO - ##### Finished install step (success) 22:14:33 INFO - ##### 22:14:33 INFO - ##### 22:14:33 INFO - ##### Running run-tests step. 22:14:33 INFO - ##### 22:14:33 INFO - Running pre-action listener: _resource_record_pre_action 22:14:33 INFO - Running main action method: run_tests 22:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:14:33 INFO - Python 2.7.3 22:14:33 INFO - Return code: 0 22:14:33 INFO - grabbing minidump binary from tooltool 22:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:33 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 0x28359c0>, '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 0x28368c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2836d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:14:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:14:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:14:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:14:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:14:33 INFO - Return code: 0 22:14:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:14:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:14:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:14:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:14:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:14:34 INFO - Return code: 0 22:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 22:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 22:14:34 INFO - Using env: {'DISPLAY': ':0', 22:14:34 INFO - 'HOME': '/home/cltbld', 22:14:34 INFO - 'LANG': 'en_US.UTF-8', 22:14:34 INFO - 'LANGUAGE': 'en_US:en', 22:14:34 INFO - 'LOGNAME': 'cltbld', 22:14:34 INFO - 'MAIL': '/var/mail/cltbld', 22:14:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:14:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:34 INFO - 'MOZ_NO_REMOTE': '1', 22:14:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:34 INFO - 'NO_EM_RESTART': '1', 22:14:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:34 INFO - 'PWD': '/builds/slave/test', 22:14:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:14:34 INFO - 'SHELL': '/bin/bash', 22:14:34 INFO - 'SHLVL': '1', 22:14:34 INFO - 'TERM': 'linux', 22:14:34 INFO - 'TMOUT': '86400', 22:14:34 INFO - 'USER': 'cltbld', 22:14:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273', 22:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:34 INFO - '_': '/tools/buildbot/bin/python'} 22:14:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 22:14:34 INFO - mozversion application_buildid: 20160520193101 22:14:34 INFO - mozversion application_changeset: 928fa0c9a879641dcd76b71243da6a6cff70d2d2 22:14:34 INFO - mozversion application_display_name: Nightly 22:14:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:34 INFO - mozversion application_name: Firefox 22:14:34 INFO - mozversion application_remotingname: firefox 22:14:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:34 INFO - mozversion application_vendor: Mozilla 22:14:34 INFO - mozversion application_version: 49.0a1 22:14:34 INFO - mozversion platform_buildid: 20160520193101 22:14:34 INFO - mozversion platform_changeset: 928fa0c9a879641dcd76b71243da6a6cff70d2d2 22:14:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:34 INFO - mozversion platform_version: 49.0a1 22:14:34 INFO - using testdate: 1463807674 22:14:34 INFO - actual date: 1463807674 22:14:34 INFO - starting webserver on 'localhost:41095' 22:14:34 INFO - SUITE-START | Running 2 tests 22:14:34 INFO - TEST-START | dromaeo_css 22:14:34 INFO - operating with platform_type : linux_ 22:14:34 INFO - Initialising browser for dromaeo_css test... 22:14:34 INFO - TEST-INFO | started process 17427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysNo9p/profile http://localhost:41095/getInfo.html) 22:14:41 INFO - PROCESS | 17427 | __metrics Screen width/height:1600/1200 22:14:41 INFO - PROCESS | 17427 | colorDepth:24 22:14:41 INFO - PROCESS | 17427 | Browser inner width/height: 1024/697 22:14:41 INFO - PROCESS | 17427 | __metrics 22:14:43 ERROR - PROCESS | 17427 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:14:44 INFO - TEST-INFO | 17427: exit 0 22:14:44 INFO - Browser initialized. 22:14:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:44 INFO - TEST-INFO | started process 17511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysNo9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:56 INFO - PROCESS | 17511 | RSS: Main: 152981504 22:14:56 INFO - PROCESS | 17511 | 22:15:47 INFO - PROCESS | 17511 | 1463807747834 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:17:56 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41095/tests/dromaeo/cssquery-ext.html) 22:17:57 INFO - PROCESS | 17511 | RSS: Main: 257441792 22:17:57 INFO - PROCESS | 17511 | 22:20:59 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-ext.html (next: http://localhost:41095/tests/dromaeo/cssquery-jquery.html) 22:21:00 INFO - PROCESS | 17511 | RSS: Main: 241238016 22:21:00 INFO - PROCESS | 17511 | 22:24:02 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41095/tests/dromaeo/cssquery-mootools.html) 22:24:03 INFO - PROCESS | 17511 | RSS: Main: 240644096 22:24:03 INFO - PROCESS | 17511 | 22:27:05 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41095/tests/dromaeo/cssquery-prototype.html) 22:27:05 INFO - PROCESS | 17511 | RSS: Main: 233709568 22:27:05 INFO - PROCESS | 17511 | 22:30:08 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41095/tests/dromaeo/cssquery-yui.html) 22:30:08 INFO - PROCESS | 17511 | RSS: Main: 210259968 22:30:08 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-yui.html (next: http://localhost:41095/tests/dromaeo/cssquery-dojo.html) 22:33:11 INFO - PROCESS | 17511 | RSS: Main: 311390208 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | __start_tp_report 22:33:11 INFO - PROCESS | 17511 | _x_x_mozilla_page_load 22:33:11 INFO - PROCESS | 17511 | _x_x_mozilla_page_load_details 22:33:11 INFO - PROCESS | 17511 | |i|pagename|runs| 22:33:11 INFO - PROCESS | 17511 | |0;dojo.html;3068.2329417645587;3092.226943264184;3117.9532307015384;3121.5161649944253;3155.54244634528;5198.870028249286;5243.501867322599;5398.13629819229;5492.1212605983;5509.228707980886;5250;5336.466353364672;5360.758765855536;5395.460453954603;5395.460453954613;4833.444153922309;4870.342503762;4909.361782968209;4930;4993.400791904976;4970.87572810679;4976.875578110558;5011.248312753098;5027.2207807789855;5031.823886163985;4741.834035808747;4829.975850120744;4933.309336692848;4940.357753492023;4973.751312434364;4949.82675606352;4972.477889821553;4975.701457912537;4985.775640096204;5020.4226513951;4736.407949006374;4937.629677774145;4972.428170760372;4977.477364876709;4991.700497970133;5197.948020519784;5274.4198138204765;5281.52466278033;5361.035013697533;5366;5772.913406298909;5811.099279611667;5815.592908496407;5819;5825.79609713658;5548.861278468071;5586.832395028156;5822.883542329129;5825.825225243207;5847.707614619295;5257.158854583248;5369.060414427459;5373.516383525423;5376.301080859464;5380.166074258496;5830.183774271605;5830.4461076197695;5832.88334233313;5835.912461313083;5845.269341332333;5502.807401741;5584.274044374205;5621.7751289948765;5636.267285252891;5650.180723795027;5759.337676167294;5810.94189058104;5832.096025116114;5835.299764028259;5835.503982161564;5700.144978253295;5732.799352022743;5747.109198074305;5756.884862302731;5773.24947756789;5485.040117979417;5536.972315138479;5662.292213473316;5668.631538949955;5745.741441635137;4354.194474022316;4357.128574285156;4360.171567402247;4360.9127817444105;4399.186150562092;3872.845086196577;3886.8250928708276;3886.8639597613947;3927.509061367329;3928.4500169976227;5336.546393556591;5369.48989845964;5403.648762830403;5441.183822426668;5481.095619222863;5859.941400586024;5859.970700146472;5867.970660146672;5877.118432235199;5903.144044113579;5534.363548192009;5537.169424586264;5540.279763630702;5545.334559852843;5551.306086739158;4887.29134275528;4902.191138462185;4959.7272150032095;5001.174806156943;5009.7495125243595;6037.18498002764;6054.606450580698;6055.788047418319;6063.151158837854;6072.149899014142;5558.694271814928;5852.970735146297;5860.648361098348;5866.149408335853;5869.090291004901;5854.9121763174435;5984.880302393841;6004.759809607567;6038.275406951194;6055.303640081447;5708.628939118944;5712.514436272797;5747.8563035924435;5749.568782341257;5755.827325180251;5571.777128914798;5722.141678748055;5866.178734977021;5871.324797648325;5871.647701137946;5677.74450149736;5731.5701322400155;5732.656040637575;5741.5406767459335;5779.797707080232;5690.146478028329;5697;5703.600747947604;5704.543636509153;5708.457696518824;5339.359276886798;5470.671759694431;5530.059889818821;5633.4084921082695;5643.971780141073;5775.971120144372;5808.5062769665055;5811.389804070512;5812.709364531672;5827.94172058274;5571.60998730085;5602.467765562265;5618.6628802272;5629.296337957755;5661.518770904355 22:33:11 INFO - PROCESS | 17511 | |1;ext.html;576.1674380520147;622.8256088295279;623.7785586116929;639.2456900856987;643.9857224870826;33812.66187338126;36853.26293474129;42757.7862110689;43936.780316098455;43939.78030109853;46882;47458.52541474584;47485.99999999991;47554.28668569974;47580.76209618956;8683.609237584324;8846.955765221164;8861.867071993925;8866.069062748415;8868.600912958933;8689.17452841979;8801.955990220073;8802;8810.074942131048;8836.955815220916;8830.602622881986;8838.911610883873;8858.60136293865;8881.46711197327;8886.333524985619;8715.43349682275;8733.301335893113;8786.560671966408;8790.472571645721;8817.030126686059;8714.34642401816;8722.825543489094;8764.517951512664;8766.956165219197;8775.210231079169;42711;43055;43063;43140.13719725588;43170.784146079066;3653.6163702811086;3675.8162091895565;3703.370427027412;3790.507234059582;3800.3304201126844;32400.18999525007;33051.6694833051;33295.6670433295;33373.16567085818;34541.309173816386;4040.878773636796;4042.514898212204;4056.776877271749;4199.68502362324;4224.429701990222;254253;254604;254746;254859;255093;35919.640803592156;36540.63459365426;36848;60304.698476507336;60690;38058.61941380606;38091.23817523634;38100.42849357262;38266;38324.233515329535;15539.689206216039;15657.765133523006;15664.686706265811;15671.451499197474;15671.608209794846;13047.543335983195;13101;13115.344232788322;13131.212127272394;13141.145825521311;8429.32565394767;8464.06895241523;8469.661213551512;8508.489490630582;8539.658413663508;3288.1943923738836;3299.15871452778;3302.207470207133;3310.155910242873;3344.3478521688526;1018.6078359831519;1081.1620993729923;1113.2874960025429;1127.5320741892024;1139.8119310313705;32891;33308.333833323195;33337.833310833776;33349.166270842936;33925.83037084799;1058.8041212375736;1102.9558817647364;1105.2318638546133;1120.5293776613842;1138.2316936068287;16407.343706251853;16502.669946601;16573.337066517444;16666.33334666624;16984.235709393106;508878;513804;514112;514796;515467;60707.39292607106;60908.69545652244;61152.38847611467;61601.075983860275;61625.69187154035;1307.3789949773782;1401.7196560687903;1425.8003879456885;1430.1419148511018;1454.178389210093;28706.425871482872;29964.250893727833;30107.54838677378;30566.84716576403;30640.540391893694;51614;52030.73984630052;52263;52395.47604524058;52401;401981;401997;402926;404508;405507;25901.611475828253;28335.149945501667;28890.42219155647;29074.709252908047;29337.413251735274;48585.757071214415;49248.50751492439;49535.752321238164;49814;50740;41175.58824411837;41846.790766045975;42306.78846605747;42440;43090.56909430865;41920.580794191665;42105.57894421017;42121;43007.569924300355;43342.78328608463;40913.38629920494;42007.78996105;42017.78991105025;42467.1506569873;42486.57513424826;35511.46732799062;36652.81673591615;36912.26175476529;36976.63023369839;37660.43509347307;25012.74987250104;25234.62148067817;25281.367965800266;25374;25427.61837259665 22:33:11 INFO - PROCESS | 17511 | |2;jquery.html;390.56061930328383;396.9920601587967;401.6826706901546;409.15305317991755;416.72704378632005;13422.753888778769;18168;19685.50786230343;19698.113584888695;19796.604067918634;14443.638909027279;14665.92667036666;17815.198316075774;18611.348602798906;18749.7187542187;5622.634528755628;5797.1594118852745;5842.64944103353;5845.766169353221;5849.85375365615;5586.13414920688;5656.321241451032;5752.913706294409;5765.971170144165;5771.278590176228;4032.092779124688;5697.8005769798065;5721.542276617882;5730.226419433365;6143.907841382383;6421.8715625687455;6531.967340163269;6555.442787363032;6567.179102612174;6571.178602674666;5631;5664.801731939362;5721.6853073080965;5727.713614319267;5738.569607279471;21691.45771355713;22435.439114022116;22471;22558;22875;2194.473326401668;2255.4023183856293;2348.1664009276633;2636.8022398320013;2931.618889544367;10162.898371016268;10181.18550515957;10222.233332500093;10636.042756151906;10697.09074728649;1851.7592712947364;1892.262017813054;1922.442491677412;1929.24759343856;1935.806419358067;43632.78183609094;45489.772551137365;78631.60684196542;83277.58361208216;84051.57974210152;10841.83737243942;10904.78190436187;10927.45362731876;11021.338719676845;11157.94421027906;15100.54698359051;15152.090874547563;15173.848261517463;15177.924110379377;15205.847941520444;7747.690092396241;7970;7981.72063977758;8211.507309561446;8219.260266576037;7778.688852445839;7870.567118808406;7906.604669766489;8024.438289319692;8044.839103217902;4704.270838020112;4750.07373562152;4780.784864681098;4786.7845946932475;4826.58973987215;1934.6517626827306;1974.6544354737864;1985.3646833013586;1991.173662929868;2010.256205204084;884.8761173435724;989.618996686281;996.7159359582485;1059.7774467361787;1089.3736101741372;18038.458846234633;18483.537911552317;18543;18740.53148671267;18777.024088616527;1016.8068067067234;1020.8009438159488;1033.571068006784;1054.667779649408;1079.7732476179933;10090.394576325443;10594.152467802558;10663.520141593646;10710.250282480152;10749.731256718489;476475;486371;488748;490955;494633;68291.3170868285;87679;90563.54718226366;90914.54542727377;90980.5450972741;1035.5909415780725;1046.2048842879467;1047.895210478946;1083.7724077943562;1091.8034753744244;16587.751183732496;16787.160641968097;16845.747313790056;17060.658786823944;17138.828611714223;37820.62179378171;38908.80545597254;40010.399844002946;41726.79136604298;41766;52329.738351308;55724.16413753716;56723.71638141783;57063;57231.71384143052;8607.440516366416;8698.956505217433;8771.429857059271;8824.382293239412;8869;9800.31397802147;12895.613131606067;12995.220286782824;13066.608001759962;13183.736325273632;10660.25378223517;10673.89326106729;10801.621943232263;10849.294795838245;10931;11229.606963756229;11344.9432752839;11387;11818.231814932002;11997.100217483548;10604.575816967235;10871.782564348827;10936.562537498728;11324.263922844988;11384.601538946097;8623.913760862311;8698.91301086981;8736;8746.65013399457;8827.77786108053;10812.243142979916;10844.349339039683;10982.121430285399;11065.668029959113;11214.551417943518 22:33:11 INFO - PROCESS | 17511 | |3;mootools.html;1339.2098661789555;1529.8776097912166;1532.103719324195;1692.6022384739583;1822.5716956515225;7891.329237014854;8793.472391656505;8810.207081362683;9098;9108.316876234292;8825.117488251171;9003.324750643711;9010.369274150811;9014.414063085895;9034.864477032834;2085.8122768950793;2293.9311820645325;2381.368937231635;2415.0339864054386;2432.2460037388464;2450.6569080328677;2452.399162205253;2454.9509009819794;2457.778799908008;2459.102427613926;2358.13927916311;2408.14510848648;2408.819338549607;2409.1929203716777;2412.0713525292713;2098.8111070003697;2355.5171189906114;2423.127674037345;2425.50277193175;2428.81783866209;2405.182238039075;2431.0154387473103;2435.7686019828266;2448.4368595223023;2483.4412257242157;8800.691975780817;8849.292056635519;8866.202041816268;8879.334049946216;8887.333449991276;5367.490088441592;5486.31421072366;5495.780168793243;5497.45025497451;5502.752376143083;3462.774919630216;3482.12870502456;3490.406630872758;3595.7482976191677;3596.892093237207;1022.3303736052823;1038.8649475568204;1067.5889782433742;1074.0816601805423;1076.0692001418715;12676.68308292291;12957.352132393436;12958.22250664963;12972.286524241163;12982.805257921043;4889.559939605381;4944.851654450372;4970.2793095001025;4996.250562415594;5002.299678045077;10744.194185435967;10796.082333001626;10815.513301901434;10816.891831081588;10837.783244335227;4878.731669758197;5407.78368865241;5417.295751552273;5417.322834645669;5421.457854214547;4904.411470623477;5055.115354812893;5056.9494305057215;5090.694558326512;5110.48895110486;4128.752274863517;4169.207850508394;4210.842018444952;4237.766922819213;4244.193603215379;1303.6154334471353;1321.6960099177052;1330.3281842669583;1332.2739107186605;1338.0967846703436;856.1566856646199;860.1226748716274;936.9833730402453;937.3813283233034;938.5025936253796;5820.796272130455;5840.737166827503;5849.122631605208;5965.313988891333;6060.848478787977;450.38747303666986;460.6545091181614;461.54768327039017;462.3480891942345;466.3215022142774;4098;4197.517285512145;4226.809793559297;4253.829846806093;4271.273883439822;10988.230823842414;11364.886351136549;11366.886331136582;11409.657710268539;11452.083833293316;10650.307729997681;11102;11152.76944611081;11195.160362972647;11418.942905285421;8407.62165702545;8427.241548260563;8506.404551681446;8528.08118173406;8531.4881107135;6069.33237343883;6282.277538083179;6300.810975670737;6310.936890631218;6315.842103947254;10138.847917281395;10487.528061237415;10690.465476726287;10736.51685674131;10738.355698658106;10670.093042091508;10686.25196236256;10693.625723099654;10696.83954740664;10706.036456718934;7180.892286615809;7266.781996540112;7564.810879728051;7702.191269916578;7876.72431464896;8830.984436789851;8842.46945183291;8897.73306800797;8911.821763564563;8916.73249802481;7415.443841712001;7873.1733168016535;7876.921230787619;7916.683332666629;8004.119546849725;7684;7727.961360193163;7754.844903102019;7938.880916786368;7966.681332746625;6960.303969602999;7022.08712867324;7044.260352663102;7051.541649792747;7057.117860267466;5102.158143906214;5229.921551176812;5321.255024296679;5419.620626556103;5536.778528858962;5230.529252367305;5320.255164276927;5412.83761487156;5532.557395408438;5536.474034966672 22:33:11 INFO - PROCESS | 17511 | |4;prototype.html;335.49005511622335;337.1638336924427;346.9323481921025;347.1079326131839;348.62000419542693;5324.201369794533;5371.167469042305;5375.30121084259;5396.649217800845;5456.890862182754;5243.4232234454275;5273.657212281209;5320.840374788753;5345.358556973169;5347.919781203275;4017.2367250222364;4192;4200.096979149483;4201.852935147271;4221.873343799691;4135.524414692319;4179.832806687728;4190.706650534464;4194.517630472489;4200.180964711883;4139.855105071323;4152;4155.979220103895;4167.395727619493;4171.663868233783;3903.9609603904023;3978.508059477696;4108.712390132692;4117.608827161444;4132.979335103335;3632.836522356474;3640.5631324240994;3642.9453558196647;3669.7247706422127;3683.4290684943608;4913.729744864031;5105.183170692671;5108.821191258326;5123.359580052494;5134.2812006319145;4562.5665561771575;4661.18429274879;4735.455422626407;4742.099001189763;4784.64115191362;5522;5527.364353099405;5543.528800052;5548.889022219573;5550.833474995757;3929.783861887595;3999.9800000999808;4041.6968727345275;4056.8782936511657;4067.938980915259;5703.230063941356;5706.315242170925;5728.341240757324;5737.569682273805;5746.138079288098;4128.545859955402;4129;4131.615908670569;4133.503979522477;4134.276501612206;4163.854265100707;4210.926213815457;4259.680523960654;4261.680373971964;4266.274733295348;4755.476897541268;4765.880852978703;4768;4774.498677638798;4792.616590672737;5467.398586155519;5522.861928451821;5523.696196709219;5613.4282400927805;5619.690916999522;1411.6188629070298;1445.9421623134956;1459.729949959261;1464.3630020940925;1467.7945087687733;904.8461761500561;951.728757304165;962.6486332488731;963.393062370702;965.9565319560637;4816.819879129635;4818.566329030404;4823.710577365369;4826.8069277228515;4827.975860120677;4981.227909674007;5007.84976450707;5053.823116190989;5056.646034777604;5091.41448733393;4808.749725071507;4825.153159635832;5123.488570871527;5143.639945203875;5386.91919621206;3024.395120975814;3031.7271445570004;3035;3039.9664114201278;3047.9085627431214;5666.291713535808;5887.35239123696;5893.882122357614;5898.203742494794;5901.262342207224;5747.3677895431465;5780.104083867007;5789.942100579025;5793.188953546507;5803.390643982406;5869.20765696634;5890.322612899486;5910.202122713378;5921.644701317849;5934.821955341346;5450.809221677222;5709.54655368813;5722.74247658848;5747.281589801275;5772.7402266898935;5621.775128994795;5688.5733569981585;5707.372189059283;5710.885782284248;5726.713664316851;5728.484436400744;5927.881442371042;5938;5939.75265194314;5967.343592204767;4029.879103626896;4111.650509706708;4115.58844115598;4133.21468920904;4137.50349958007;5604.3187043885855;5717.914231286451;5726.9713651431475;5764.913526297025;5773.566982476247;5516.91724624139;5602.467765562265;5618.185363122406;5656.547476201812;5663.405342438985;5590.273264475592;5606.636018388934;5607.5513958884;5619.550435965195;5623.409541998031;5472.945270547243;5491.835244942658;5527.115661494142;5536.584756143386;5546.500814926676;5405.86485337854;5613.354464236665;5619.269494965628;5651.576131790214;5661.329907677327;5486.533644640251;5489.917651235314;5506.944930550643;5531.1426728857095;5544.861378465571 22:33:11 INFO - PROCESS | 17511 | |5;yui.html;769.5690413368515;806.9314108300794;809.3201710563126;820.3560205238889;826.4834478450969;13980.860191398097;15001.324940377683;15011.774823377658;15060.623484412896;15081.170535620537;14084.647883802885;14088.859111408883;14104.788428173586;14107.224102674349;14157.36291866866;672.6838385958591;796.6972550430828;798.3692882622721;811.9188081191863;812.1594150054694;806.5725165662209;814.2346194577108;817.0562999735286;817.23588444804;817.8364327134597;858.7767180533075;861.6208868098048;862.2886118951858;863.2748491267334;863.9870401943975;698.1970733656285;834.56185502611;856.1224744636735;860.1957170045996;862.5988915154452;614.8124821929309;617.7992152550439;620.2371083567192;623.8315654773186;624.1012941364467;13387.598372048855;13410.396532156077;13433.529826456028;13443.865561344359;13445.731085378238;13659.453621855115;14067.617221822875;14110.153390796482;14141.656542628434;14440.13359198441;11649.825252621218;12354.135210535265;12524.311162886037;12558.874411255953;12831.101822872402;4377.868663940087;4396.450443694538;4435.206507760861;4484.753338566377;4616.584507394317;63697.3630263696;64382.3561764381;64652;66467.0029949556;66529.66735166342;11160.330380177214;11226.47050040319;11239.438028098562;11291.887081129247;11395.259308144945;17441.563960900825;19400;19411.126499307564;19418.223271069;19430.417087487396;7950.920490795018;8062.39532035088;8099.676012959533;8250.298724608356;8296.170382961776;4753.548412900769;4775.355327030876;4894.853154405374;4973.1297023020825;5007.098722229961;3348.5814273215847;3428.8285585720614;3433.690967812859;3445.2764919366714;3446.2590543033366;631.778877392918;631.962082275065;646.0696596900542;646.0922404022356;656.5929123943185;705.947053970944;708.6598432752205;741.5810067311952;747.3983443328173;787.2599756229126;9472.242220622335;9979.966127267475;9985.850212246822;10081.546330415149;10132.594696212216;701.8771714949863;725.7242247945852;758.635854789704;779.174075479993;797.6490344248512;4497.775111244425;4797.784099715521;4830.468648448667;4835.326148947875;4867.805287788448;68374;71920.45590403794;73031.63484182545;73157.26842731505;73310;63915;64026.35973640297;64414.35585644084;64439.355606444275;66218.33781662218;56413;56453.43546564564;57616;58094.4190558089;59020.704896476105;9215.907840921505;9287.257019438293;9336.39313444651;9420.858687119562;9579.712608621752;37173.628263717015;37533.249335013694;38102.04744881289;38233;38657;50768.74615626898;52928.47071529235;53060.20409693781;53313.466865332404;53606.73196633992;10957.06864916491;11024.669259922215;11329.093672506344;11705.356205408785;12242.143049986415;12758.872411275768;13312.866871331164;13805.24071176095;13982.44070237179;14045.297735113409;11252.774944501229;11367.374794386387;11551.480183391599;12123.151379403356;12878.742425151631;11206.943965280121;11262.662120136409;11290;11480.233189125236;11725.061995040205;11405.885941140483;11447.771044579229;11456.541738330374;11539.596114135966;11805.30312461098;9510.95244523773;9568.282378821477;9658;9940.850887236553;10082.591334110411;10601.25791194609;10642.467876605984;10797.946010269898;10848.186386020921;10886 22:33:11 INFO - PROCESS | 17511 | __end_tp_report 22:33:11 INFO - PROCESS | 17511 | __start_cc_report 22:33:11 INFO - PROCESS | 17511 | _x_x_mozilla_cycle_collect,885 22:33:11 INFO - PROCESS | 17511 | __end_cc_report 22:33:11 INFO - PROCESS | 17511 | __startTimestamp1463808791955__endTimestamp 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | ------- Summary: start ------- 22:33:11 INFO - PROCESS | 17511 | Number of tests: 6 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#0] dojo.html Cycles:165 Average:5366.72 Median:5558.69 stddev:620.96 (11.2%) stddev-sans-first:596.11 22:33:11 INFO - PROCESS | 17511 | Values: 3068.2 3092.2 3118.0 3121.5 3155.5 5198.9 5243.5 5398.1 5492.1 5509.2 5250.0 5336.5 5360.8 5395.5 5395.5 4833.4 4870.3 4909.4 4930.0 4993.4 4970.9 4976.9 5011.2 5027.2 5031.8 4741.8 4830.0 4933.3 4940.4 4973.8 4949.8 4972.5 4975.7 4985.8 5020.4 4736.4 4937.6 4972.4 4977.5 4991.7 5197.9 5274.4 5281.5 5361.0 5366.0 5772.9 5811.1 5815.6 5819.0 5825.8 5548.9 5586.8 5822.9 5825.8 5847.7 5257.2 5369.1 5373.5 5376.3 5380.2 5830.2 5830.4 5832.9 5835.9 5845.3 5502.8 5584.3 5621.8 5636.3 5650.2 5759.3 5810.9 5832.1 5835.3 5835.5 5700.1 5732.8 5747.1 5756.9 5773.2 5485.0 5537.0 5662.3 5668.6 5745.7 4354.2 4357.1 4360.2 4360.9 4399.2 3872.8 3886.8 3886.9 3927.5 3928.5 5336.5 5369.5 5403.6 5441.2 5481.1 5859.9 5860.0 5868.0 5877.1 5903.1 5534.4 5537.2 5540.3 5545.3 5551.3 4887.3 4902.2 4959.7 5001.2 5009.7 6037.2 6054.6 6055.8 6063.2 6072.1 5558.7 5853.0 5860.6 5866.1 5869.1 5854.9 5984.9 6004.8 6038.3 6055.3 5708.6 5712.5 5747.9 5749.6 5755.8 5571.8 5722.1 5866.2 5871.3 5871.6 5677.7 5731.6 5732.7 5741.5 5779.8 5690.1 5697.0 5703.6 5704.5 5708.5 5339.4 5470.7 5530.1 5633.4 5644.0 5776.0 5808.5 5811.4 5812.7 5827.9 5571.6 5602.5 5618.7 5629.3 5661.5 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#1] ext.html Cycles:180 Average:54894.96 Median:405007.50 stddev:107478.76 (26.5%) stddev-sans-first:107702.88 22:33:11 INFO - PROCESS | 17511 | Values: 576.2 622.8 623.8 639.2 644.0 33812.7 36853.3 42757.8 43936.8 43939.8 46882.0 47458.5 47486.0 47554.3 47580.8 8683.6 8847.0 8861.9 8866.1 8868.6 8689.2 8802.0 8802.0 8810.1 8837.0 8830.6 8838.9 8858.6 8881.5 8886.3 8715.4 8733.3 8786.6 8790.5 8817.0 8714.3 8722.8 8764.5 8767.0 8775.2 42711.0 43055.0 43063.0 43140.1 43170.8 3653.6 3675.8 3703.4 3790.5 3800.3 32400.2 33051.7 33295.7 33373.2 34541.3 4040.9 4042.5 4056.8 4199.7 4224.4 254253.0 254604.0 254746.0 254859.0 255093.0 35919.6 36540.6 36848.0 60304.7 60690.0 38058.6 38091.2 38100.4 38266.0 38324.2 15539.7 15657.8 15664.7 15671.5 15671.6 13047.5 13101.0 13115.3 13131.2 13141.1 8429.3 8464.1 8469.7 8508.5 8539.7 3288.2 3299.2 3302.2 3310.2 3344.3 1018.6 1081.2 1113.3 1127.5 1139.8 32891.0 33308.3 33337.8 33349.2 33925.8 1058.8 1103.0 1105.2 1120.5 1138.2 16407.3 16502.7 16573.3 16666.3 16984.2 508878.0 513804.0 514112.0 514796.0 515467.0 60707.4 60908.7 61152.4 61601.1 61625.7 1307.4 1401.7 1425.8 1430.1 1454.2 28706.4 29964.3 30107.5 30566.8 30640.5 51614.0 52030.7 52263.0 52395.5 52401.0 401981.0 401997.0 402926.0 404508.0 405507.0 25901.6 28335.1 28890.4 29074.7 29337.4 48585.8 49248.5 49535.8 49814.0 50740.0 41175.6 41846.8 42306.8 42440.0 43090.6 41920.6 42105.6 42121.0 43007.6 43342.8 40913.4 42007.8 42017.8 42467.2 42486.6 35511.5 36652.8 36912.3 36976.6 37660.4 25012.7 25234.6 25281.4 25374.0 25427.6 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#2] jquery.html Cycles:180 Average:28052.40 Median:12406.70 stddev:80108.02 (645.7%) stddev-sans-first:80305.82 22:33:11 INFO - PROCESS | 17511 | Values: 390.6 397.0 401.7 409.2 416.7 13422.8 18168.0 19685.5 19698.1 19796.6 14443.6 14665.9 17815.2 18611.3 18749.7 5622.6 5797.2 5842.6 5845.8 5849.9 5586.1 5656.3 5752.9 5766.0 5771.3 4032.1 5697.8 5721.5 5730.2 6143.9 6421.9 6532.0 6555.4 6567.2 6571.2 5631.0 5664.8 5721.7 5727.7 5738.6 21691.5 22435.4 22471.0 22558.0 22875.0 2194.5 2255.4 2348.2 2636.8 2931.6 10162.9 10181.2 10222.2 10636.0 10697.1 1851.8 1892.3 1922.4 1929.2 1935.8 43632.8 45489.8 78631.6 83277.6 84051.6 10841.8 10904.8 10927.5 11021.3 11157.9 15100.5 15152.1 15173.8 15177.9 15205.8 7747.7 7970.0 7981.7 8211.5 8219.3 7778.7 7870.6 7906.6 8024.4 8044.8 4704.3 4750.1 4780.8 4786.8 4826.6 1934.7 1974.7 1985.4 1991.2 2010.3 884.9 989.6 996.7 1059.8 1089.4 18038.5 18483.5 18543.0 18740.5 18777.0 1016.8 1020.8 1033.6 1054.7 1079.8 10090.4 10594.2 10663.5 10710.3 10749.7 476475.0 486371.0 488748.0 490955.0 494633.0 68291.3 87679.0 90563.5 90914.5 90980.5 1035.6 1046.2 1047.9 1083.8 1091.8 16587.8 16787.2 16845.7 17060.7 17138.8 37820.6 38908.8 40010.4 41726.8 41766.0 52329.7 55724.2 56723.7 57063.0 57231.7 8607.4 8699.0 8771.4 8824.4 8869.0 9800.3 12895.6 12995.2 13066.6 13183.7 10660.3 10673.9 10801.6 10849.3 10931.0 11229.6 11344.9 11387.0 11818.2 11997.1 10604.6 10871.8 10936.6 11324.3 11384.6 8623.9 8698.9 8736.0 8746.7 8827.8 10812.2 10844.3 10982.1 11065.7 11214.6 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#3] mootools.html Cycles:180 Average:5955.37 Median:4884.15 stddev:3429.96 (70.2%) stddev-sans-first:3422.03 22:33:11 INFO - PROCESS | 17511 | Values: 1339.2 1529.9 1532.1 1692.6 1822.6 7891.3 8793.5 8810.2 9098.0 9108.3 8825.1 9003.3 9010.4 9014.4 9034.9 2085.8 2293.9 2381.4 2415.0 2432.2 2450.7 2452.4 2455.0 2457.8 2459.1 2358.1 2408.1 2408.8 2409.2 2412.1 2098.8 2355.5 2423.1 2425.5 2428.8 2405.2 2431.0 2435.8 2448.4 2483.4 8800.7 8849.3 8866.2 8879.3 8887.3 5367.5 5486.3 5495.8 5497.5 5502.8 3462.8 3482.1 3490.4 3595.7 3596.9 1022.3 1038.9 1067.6 1074.1 1076.1 12676.7 12957.4 12958.2 12972.3 12982.8 4889.6 4944.9 4970.3 4996.3 5002.3 10744.2 10796.1 10815.5 10816.9 10837.8 4878.7 5407.8 5417.3 5417.3 5421.5 4904.4 5055.1 5056.9 5090.7 5110.5 4128.8 4169.2 4210.8 4237.8 4244.2 1303.6 1321.7 1330.3 1332.3 1338.1 856.2 860.1 937.0 937.4 938.5 5820.8 5840.7 5849.1 5965.3 6060.8 450.4 460.7 461.5 462.3 466.3 4098.0 4197.5 4226.8 4253.8 4271.3 10988.2 11364.9 11366.9 11409.7 11452.1 10650.3 11102.0 11152.8 11195.2 11418.9 8407.6 8427.2 8506.4 8528.1 8531.5 6069.3 6282.3 6300.8 6310.9 6315.8 10138.8 10487.5 10690.5 10736.5 10738.4 10670.1 10686.3 10693.6 10696.8 10706.0 7180.9 7266.8 7564.8 7702.2 7876.7 8831.0 8842.5 8897.7 8911.8 8916.7 7415.4 7873.2 7876.9 7916.7 8004.1 7684.0 7728.0 7754.8 7938.9 7966.7 6960.3 7022.1 7044.3 7051.5 7057.1 5102.2 5229.9 5321.3 5419.6 5536.8 5230.5 5320.3 5412.8 5532.6 5536.5 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#4] prototype.html Cycles:180 Average:4661.28 Median:5297.25 stddev:1358.27 (25.6%) stddev-sans-first:1322.71 22:33:11 INFO - PROCESS | 17511 | Values: 335.5 337.2 346.9 347.1 348.6 5324.2 5371.2 5375.3 5396.6 5456.9 5243.4 5273.7 5320.8 5345.4 5347.9 4017.2 4192.0 4200.1 4201.9 4221.9 4135.5 4179.8 4190.7 4194.5 4200.2 4139.9 4152.0 4156.0 4167.4 4171.7 3904.0 3978.5 4108.7 4117.6 4133.0 3632.8 3640.6 3642.9 3669.7 3683.4 4913.7 5105.2 5108.8 5123.4 5134.3 4562.6 4661.2 4735.5 4742.1 4784.6 5522.0 5527.4 5543.5 5548.9 5550.8 3929.8 4000.0 4041.7 4056.9 4067.9 5703.2 5706.3 5728.3 5737.6 5746.1 4128.5 4129.0 4131.6 4133.5 4134.3 4163.9 4210.9 4259.7 4261.7 4266.3 4755.5 4765.9 4768.0 4774.5 4792.6 5467.4 5522.9 5523.7 5613.4 5619.7 1411.6 1445.9 1459.7 1464.4 1467.8 904.8 951.7 962.6 963.4 966.0 4816.8 4818.6 4823.7 4826.8 4828.0 4981.2 5007.8 5053.8 5056.6 5091.4 4808.7 4825.2 5123.5 5143.6 5386.9 3024.4 3031.7 3035.0 3040.0 3047.9 5666.3 5887.4 5893.9 5898.2 5901.3 5747.4 5780.1 5789.9 5793.2 5803.4 5869.2 5890.3 5910.2 5921.6 5934.8 5450.8 5709.5 5722.7 5747.3 5772.7 5621.8 5688.6 5707.4 5710.9 5726.7 5728.5 5927.9 5938.0 5939.8 5967.3 4029.9 4111.7 4115.6 4133.2 4137.5 5604.3 5717.9 5727.0 5764.9 5773.6 5516.9 5602.5 5618.2 5656.5 5663.4 5590.3 5606.6 5607.6 5619.6 5623.4 5472.9 5491.8 5527.1 5536.6 5546.5 5405.9 5613.4 5619.3 5651.6 5661.3 5486.5 5489.9 5506.9 5531.1 5544.9 22:33:11 INFO - PROCESS | 17511 | 22:33:11 INFO - PROCESS | 17511 | [#5] yui.html Cycles:180 Average:16141.88 Median:4933.99 stddev:20096.61 (407.3%) stddev-sans-first:20119.83 22:33:11 INFO - PROCESS | 17511 | Values: 769.6 806.9 809.3 820.4 826.5 13980.9 15001.3 15011.8 15060.6 15081.2 14084.6 14088.9 14104.8 14107.2 14157.4 672.7 796.7 798.4 811.9 812.2 806.6 814.2 817.1 817.2 817.8 858.8 861.6 862.3 863.3 864.0 698.2 834.6 856.1 860.2 862.6 614.8 617.8 620.2 623.8 624.1 13387.6 13410.4 13433.5 13443.9 13445.7 13659.5 14067.6 14110.2 14141.7 14440.1 11649.8 12354.1 12524.3 12558.9 12831.1 4377.9 4396.5 4435.2 4484.8 4616.6 63697.4 64382.4 64652.0 66467.0 66529.7 11160.3 11226.5 11239.4 11291.9 11395.3 17441.6 19400.0 19411.1 19418.2 19430.4 7950.9 8062.4 8099.7 8250.3 8296.2 4753.5 4775.4 4894.9 4973.1 5007.1 3348.6 3428.8 3433.7 3445.3 3446.3 631.8 632.0 646.1 646.1 656.6 705.9 708.7 741.6 747.4 787.3 9472.2 9980.0 9985.9 10081.5 10132.6 701.9 725.7 758.6 779.2 797.6 4497.8 4797.8 4830.5 4835.3 4867.8 68374.0 71920.5 73031.6 73157.3 73310.0 63915.0 64026.4 64414.4 64439.4 66218.3 56413.0 56453.4 57616.0 58094.4 59020.7 9215.9 9287.3 9336.4 9420.9 9579.7 37173.6 37533.2 38102.0 38233.0 38657.0 50768.7 52928.5 53060.2 53313.5 53606.7 10957.1 11024.7 11329.1 11705.4 12242.1 12758.9 13312.9 13805.2 13982.4 14045.3 11252.8 11367.4 11551.5 12123.2 12878.7 11206.9 11262.7 11290.0 11480.2 11725.1 11405.9 11447.8 11456.5 11539.6 11805.3 9511.0 9568.3 9658.0 9940.9 10082.6 10601.3 10642.5 10797.9 10848.2 10886.0 22:33:11 INFO - PROCESS | 17511 | -------- Summary: end -------- 22:33:11 INFO - PROCESS | 17511 | 22:33:12 INFO - TEST-INFO | 17511: exit 0 22:33:12 INFO - TEST-OK | dromaeo_css | took 1118067ms 22:33:12 INFO - TEST-START | kraken 22:33:12 INFO - operating with platform_type : linux_ 22:33:12 INFO - Initialising browser for kraken test... 22:33:12 INFO - TEST-INFO | started process 17695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvx76g/profile http://localhost:41095/getInfo.html) 22:33:18 INFO - PROCESS | 17695 | __metrics Screen width/height:1600/1200 22:33:18 INFO - PROCESS | 17695 | colorDepth:24 22:33:18 INFO - PROCESS | 17695 | Browser inner width/height: 1024/697 22:33:18 INFO - PROCESS | 17695 | __metrics 22:33:20 ERROR - PROCESS | 17695 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:33:21 INFO - TEST-INFO | 17695: exit 0 22:33:21 INFO - Browser initialized. 22:33:21 INFO - Running cycle 1/1 for kraken test... 22:33:21 INFO - TEST-INFO | started process 17778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvx76g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:33 INFO - PROCESS | 17778 | RSS: Main: 153067520 22:33:33 INFO - PROCESS | 17778 | 22:33:35 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-beat-detection) 22:33:36 INFO - PROCESS | 17778 | RSS: Main: 209879040 22:33:36 INFO - PROCESS | 17778 | 22:33:39 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-dft) 22:33:40 INFO - PROCESS | 17778 | RSS: Main: 197242880 22:33:40 INFO - PROCESS | 17778 | 22:33:43 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-fft) 22:33:44 INFO - PROCESS | 17778 | RSS: Main: 266022912 22:33:44 INFO - PROCESS | 17778 | 22:33:46 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-oscillator) 22:33:46 INFO - PROCESS | 17778 | RSS: Main: 174804992 22:33:46 INFO - PROCESS | 17778 | 22:33:49 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:49 INFO - PROCESS | 17778 | RSS: Main: 179101696 22:33:49 INFO - PROCESS | 17778 | 22:33:52 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:53 INFO - PROCESS | 17778 | RSS: Main: 215240704 22:33:53 INFO - PROCESS | 17778 | 22:33:57 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:57 INFO - PROCESS | 17778 | RSS: Main: 213536768 22:33:57 INFO - PROCESS | 17778 | 22:34:00 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41095/tests/kraken/driver.html?testName=json-parse-financial) 22:34:01 INFO - PROCESS | 17778 | RSS: Main: 214450176 22:34:01 INFO - PROCESS | 17778 | 22:34:02 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:34:03 INFO - PROCESS | 17778 | RSS: Main: 204124160 22:34:03 INFO - PROCESS | 17778 | 22:34:05 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:34:05 INFO - PROCESS | 17778 | RSS: Main: 206938112 22:34:05 INFO - PROCESS | 17778 | 22:34:08 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:34:08 INFO - PROCESS | 17778 | RSS: Main: 218230784 22:34:08 INFO - PROCESS | 17778 | 22:34:11 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:34:12 INFO - PROCESS | 17778 | RSS: Main: 221249536 22:34:12 INFO - PROCESS | 17778 | 22:34:14 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:34:15 INFO - PROCESS | 17778 | RSS: Main: 222023680 22:34:15 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41095/tests/kraken/driver.html?testName=ai-astar) 22:34:17 INFO - PROCESS | 17778 | RSS: Main: 268537856 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | __start_tp_report 22:34:17 INFO - PROCESS | 17778 | _x_x_mozilla_page_load 22:34:17 INFO - PROCESS | 17778 | _x_x_mozilla_page_load_details 22:34:17 INFO - PROCESS | 17778 | |i|pagename|runs| 22:34:17 INFO - PROCESS | 17778 | |0;ai-astar;112;106;110;112;113;118;110;109;108;111 22:34:17 INFO - PROCESS | 17778 | |1;audio-beat-detection;156;128;128;214;132;126;152;126;164;126 22:34:17 INFO - PROCESS | 17778 | |2;audio-dft;162;160;161;160;160;161;161;162;160;160 22:34:17 INFO - PROCESS | 17778 | |3;audio-fft;75;76;75;132;75;75;74;75;120;74 22:34:17 INFO - PROCESS | 17778 | |4;audio-oscillator;93;92;164;93;93;92;134;92;93;137 22:34:17 INFO - PROCESS | 17778 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 22:34:17 INFO - PROCESS | 17778 | |6;imaging-darkroom;145;145;145;147;146;145;145;146;146;145 22:34:17 INFO - PROCESS | 17778 | |7;imaging-desaturate;95;95;95;96;95;94;95;95;95;95 22:34:17 INFO - PROCESS | 17778 | |8;json-parse-financial;56;53;55;55;54;55;54;115;52;51 22:34:17 INFO - PROCESS | 17778 | |9;json-stringify-tinderbox;62;61;62;62;61;62;61;61;60;62 22:34:17 INFO - PROCESS | 17778 | |10;stanford-crypto-aes;83;77;79;78;78;79;80;87;80;79 22:34:17 INFO - PROCESS | 17778 | |11;stanford-crypto-ccm;133;119;119;122;116;116;116;126;251;121 22:34:17 INFO - PROCESS | 17778 | |12;stanford-crypto-pbkdf2;163;163;161;160;165;160;166;162;161;157 22:34:17 INFO - PROCESS | 17778 | |13;stanford-crypto-sha256-iterative;63;66;63;63;63;61;63;61;61;62 22:34:17 INFO - PROCESS | 17778 | __end_tp_report 22:34:17 INFO - PROCESS | 17778 | __start_cc_report 22:34:17 INFO - PROCESS | 17778 | _x_x_mozilla_cycle_collect,1988 22:34:17 INFO - PROCESS | 17778 | __end_cc_report 22:34:17 INFO - PROCESS | 17778 | __startTimestamp1463808857422__endTimestamp 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | ------- Summary: start ------- 22:34:17 INFO - PROCESS | 17778 | Number of tests: 14 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:3.25 (2.9%) stddev-sans-first:3.42 22:34:17 INFO - PROCESS | 17778 | Values: 112.0 106.0 110.0 112.0 113.0 118.0 110.0 109.0 108.0 111.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:142.00 stddev:28.13 (19.8%) stddev-sans-first:29.56 22:34:17 INFO - PROCESS | 17778 | Values: 156.0 128.0 128.0 214.0 132.0 126.0 152.0 126.0 164.0 126.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 22:34:17 INFO - PROCESS | 17778 | Values: 162.0 160.0 161.0 160.0 160.0 161.0 161.0 162.0 160.0 160.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.00 stddev:21.75 (29.0%) stddev-sans-first:22.76 22:34:17 INFO - PROCESS | 17778 | Values: 75.0 76.0 75.0 132.0 75.0 75.0 74.0 75.0 120.0 74.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.50 stddev:26.50 (28.6%) stddev-sans-first:27.52 22:34:17 INFO - PROCESS | 17778 | Values: 93.0 92.0 164.0 93.0 93.0 92.0 134.0 92.0 93.0 137.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:34:17 INFO - PROCESS | 17778 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 22:34:17 INFO - PROCESS | 17778 | Values: 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 146.0 145.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 22:34:17 INFO - PROCESS | 17778 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:54.50 stddev:19.38 (35.6%) stddev-sans-first:20.51 22:34:17 INFO - PROCESS | 17778 | Values: 56.0 53.0 55.0 55.0 54.0 55.0 54.0 115.0 52.0 51.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 22:34:17 INFO - PROCESS | 17778 | Values: 62.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 60.0 62.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.94 (3.7%) stddev-sans-first:2.92 22:34:17 INFO - PROCESS | 17778 | Values: 83.0 77.0 79.0 78.0 78.0 79.0 80.0 87.0 80.0 79.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:121.50 stddev:41.48 (34.1%) stddev-sans-first:44.00 22:34:17 INFO - PROCESS | 17778 | Values: 133.0 119.0 119.0 122.0 116.0 116.0 116.0 126.0 251.0 121.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.50 stddev:2.62 (1.6%) stddev-sans-first:2.74 22:34:17 INFO - PROCESS | 17778 | Values: 163.0 163.0 161.0 160.0 165.0 160.0 166.0 162.0 161.0 157.0 22:34:17 INFO - PROCESS | 17778 | 22:34:17 INFO - PROCESS | 17778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 22:34:17 INFO - PROCESS | 17778 | Values: 63.0 66.0 63.0 63.0 63.0 61.0 63.0 61.0 61.0 62.0 22:34:17 INFO - PROCESS | 17778 | -------- Summary: end -------- 22:34:17 INFO - PROCESS | 17778 | 22:34:18 INFO - TEST-INFO | 17778: exit 0 22:34:18 INFO - TEST-OK | kraken | took 65871ms 22:34:18 INFO - SUITE-END | took 1183s 22:34:19 INFO - Completed test suite (00:19:44) 22:34:19 INFO - javascript benchmark 22:34:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.2329417645587, 3092.226943264184, 3117.9532307015384, 3121.5161649944253, 3155.54244634528, 5198.870028249286, 5243.501867322599, 5398.13629819229, 5492.1212605983, 5509.228707980886, 5250.0, 5336.466353364672, 5360.758765855536, 5395.460453954603, 5395.460453954613, 4833.444153922309, 4870.342503762, 4909.361782968209, 4930.0, 4993.400791904976, 4970.87572810679, 4976.875578110558, 5011.248312753098, 5027.2207807789855, 5031.823886163985, 4741.834035808747, 4829.975850120744, 4933.309336692848, 4940.357753492023, 4973.751312434364, 4949.82675606352, 4972.477889821553, 4975.701457912537, 4985.775640096204, 5020.4226513951, 4736.407949006374, 4937.629677774145, 4972.428170760372, 4977.477364876709, 4991.700497970133, 5197.948020519784, 5274.4198138204765, 5281.52466278033, 5361.035013697533, 5366.0, 5772.913406298909, 5811.099279611667, 5815.592908496407, 5819.0, 5825.79609713658, 5548.861278468071, 5586.832395028156, 5822.883542329129, 5825.825225243207, 5847.707614619295, 5257.158854583248, 5369.060414427459, 5373.516383525423, 5376.301080859464, 5380.166074258496, 5830.183774271605, 5830.4461076197695, 5832.88334233313, 5835.912461313083, 5845.269341332333, 5502.807401741, 5584.274044374205, 5621.7751289948765, 5636.267285252891, 5650.180723795027, 5759.337676167294, 5810.94189058104, 5832.096025116114, 5835.299764028259, 5835.503982161564, 5700.144978253295, 5732.799352022743, 5747.109198074305, 5756.884862302731, 5773.24947756789, 5485.040117979417, 5536.972315138479, 5662.292213473316, 5668.631538949955, 5745.741441635137, 4354.194474022316, 4357.128574285156, 4360.171567402247, 4360.9127817444105, 4399.186150562092, 3872.845086196577, 3886.8250928708276, 3886.8639597613947, 3927.509061367329, 3928.4500169976227, 5336.546393556591, 5369.48989845964, 5403.648762830403, 5441.183822426668, 5481.095619222863, 5859.941400586024, 5859.970700146472, 5867.970660146672, 5877.118432235199, 5903.144044113579, 5534.363548192009, 5537.169424586264, 5540.279763630702, 5545.334559852843, 5551.306086739158, 4887.29134275528, 4902.191138462185, 4959.7272150032095, 5001.174806156943, 5009.7495125243595, 6037.18498002764, 6054.606450580698, 6055.788047418319, 6063.151158837854, 6072.149899014142, 5558.694271814928, 5852.970735146297, 5860.648361098348, 5866.149408335853, 5869.090291004901, 5854.9121763174435, 5984.880302393841, 6004.759809607567, 6038.275406951194, 6055.303640081447, 5708.628939118944, 5712.514436272797, 5747.8563035924435, 5749.568782341257, 5755.827325180251, 5571.777128914798, 5722.141678748055, 5866.178734977021, 5871.324797648325, 5871.647701137946, 5677.74450149736, 5731.5701322400155, 5732.656040637575, 5741.5406767459335, 5779.797707080232, 5690.146478028329, 5697.0, 5703.600747947604, 5704.543636509153, 5708.457696518824, 5339.359276886798, 5470.671759694431, 5530.059889818821, 5633.4084921082695, 5643.971780141073, 5775.971120144372, 5808.5062769665055, 5811.389804070512, 5812.709364531672, 5827.94172058274, 5571.60998730085, 5602.467765562265, 5618.6628802272, 5629.296337957755, 5661.518770904355], "value": 5324.120769072356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1674380520147, 622.8256088295279, 623.7785586116929, 639.2456900856987, 643.9857224870826, 33812.66187338126, 36853.26293474129, 42757.7862110689, 43936.780316098455, 43939.78030109853, 46882.0, 47458.52541474584, 47485.99999999991, 47554.28668569974, 47580.76209618956, 8683.609237584324, 8846.955765221164, 8861.867071993925, 8866.069062748415, 8868.600912958933, 8689.17452841979, 8801.955990220073, 8802.0, 8810.074942131048, 8836.955815220916, 8830.602622881986, 8838.911610883873, 8858.60136293865, 8881.46711197327, 8886.333524985619, 8715.43349682275, 8733.301335893113, 8786.560671966408, 8790.472571645721, 8817.030126686059, 8714.34642401816, 8722.825543489094, 8764.517951512664, 8766.956165219197, 8775.210231079169, 42711.0, 43055.0, 43063.0, 43140.13719725588, 43170.784146079066, 3653.6163702811086, 3675.8162091895565, 3703.370427027412, 3790.507234059582, 3800.3304201126844, 32400.18999525007, 33051.6694833051, 33295.6670433295, 33373.16567085818, 34541.309173816386, 4040.878773636796, 4042.514898212204, 4056.776877271749, 4199.68502362324, 4224.429701990222, 254253.0, 254604.0, 254746.0, 254859.0, 255093.0, 35919.640803592156, 36540.63459365426, 36848.0, 60304.698476507336, 60690.0, 38058.61941380606, 38091.23817523634, 38100.42849357262, 38266.0, 38324.233515329535, 15539.689206216039, 15657.765133523006, 15664.686706265811, 15671.451499197474, 15671.608209794846, 13047.543335983195, 13101.0, 13115.344232788322, 13131.212127272394, 13141.145825521311, 8429.32565394767, 8464.06895241523, 8469.661213551512, 8508.489490630582, 8539.658413663508, 3288.1943923738836, 3299.15871452778, 3302.207470207133, 3310.155910242873, 3344.3478521688526, 1018.6078359831519, 1081.1620993729923, 1113.2874960025429, 1127.5320741892024, 1139.8119310313705, 32891.0, 33308.333833323195, 33337.833310833776, 33349.166270842936, 33925.83037084799, 1058.8041212375736, 1102.9558817647364, 1105.2318638546133, 1120.5293776613842, 1138.2316936068287, 16407.343706251853, 16502.669946601, 16573.337066517444, 16666.33334666624, 16984.235709393106, 508878.0, 513804.0, 514112.0, 514796.0, 515467.0, 60707.39292607106, 60908.69545652244, 61152.38847611467, 61601.075983860275, 61625.69187154035, 1307.3789949773782, 1401.7196560687903, 1425.8003879456885, 1430.1419148511018, 1454.178389210093, 28706.425871482872, 29964.250893727833, 30107.54838677378, 30566.84716576403, 30640.540391893694, 51614.0, 52030.73984630052, 52263.0, 52395.47604524058, 52401.0, 401981.0, 401997.0, 402926.0, 404508.0, 405507.0, 25901.611475828253, 28335.149945501667, 28890.42219155647, 29074.709252908047, 29337.413251735274, 48585.757071214415, 49248.50751492439, 49535.752321238164, 49814.0, 50740.0, 41175.58824411837, 41846.790766045975, 42306.78846605747, 42440.0, 43090.56909430865, 41920.580794191665, 42105.57894421017, 42121.0, 43007.569924300355, 43342.78328608463, 40913.38629920494, 42007.78996105, 42017.78991105025, 42467.1506569873, 42486.57513424826, 35511.46732799062, 36652.81673591615, 36912.26175476529, 36976.63023369839, 37660.43509347307, 25012.74987250104, 25234.62148067817, 25281.367965800266, 25374.0, 25427.61837259665], "value": 18732.843142811864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.56061930328383, 396.9920601587967, 401.6826706901546, 409.15305317991755, 416.72704378632005, 13422.753888778769, 18168.0, 19685.50786230343, 19698.113584888695, 19796.604067918634, 14443.638909027279, 14665.92667036666, 17815.198316075774, 18611.348602798906, 18749.7187542187, 5622.634528755628, 5797.1594118852745, 5842.64944103353, 5845.766169353221, 5849.85375365615, 5586.13414920688, 5656.321241451032, 5752.913706294409, 5765.971170144165, 5771.278590176228, 4032.092779124688, 5697.8005769798065, 5721.542276617882, 5730.226419433365, 6143.907841382383, 6421.8715625687455, 6531.967340163269, 6555.442787363032, 6567.179102612174, 6571.178602674666, 5631.0, 5664.801731939362, 5721.6853073080965, 5727.713614319267, 5738.569607279471, 21691.45771355713, 22435.439114022116, 22471.0, 22558.0, 22875.0, 2194.473326401668, 2255.4023183856293, 2348.1664009276633, 2636.8022398320013, 2931.618889544367, 10162.898371016268, 10181.18550515957, 10222.233332500093, 10636.042756151906, 10697.09074728649, 1851.7592712947364, 1892.262017813054, 1922.442491677412, 1929.24759343856, 1935.806419358067, 43632.78183609094, 45489.772551137365, 78631.60684196542, 83277.58361208216, 84051.57974210152, 10841.83737243942, 10904.78190436187, 10927.45362731876, 11021.338719676845, 11157.94421027906, 15100.54698359051, 15152.090874547563, 15173.848261517463, 15177.924110379377, 15205.847941520444, 7747.690092396241, 7970.0, 7981.72063977758, 8211.507309561446, 8219.260266576037, 7778.688852445839, 7870.567118808406, 7906.604669766489, 8024.438289319692, 8044.839103217902, 4704.270838020112, 4750.07373562152, 4780.784864681098, 4786.7845946932475, 4826.58973987215, 1934.6517626827306, 1974.6544354737864, 1985.3646833013586, 1991.173662929868, 2010.256205204084, 884.8761173435724, 989.618996686281, 996.7159359582485, 1059.7774467361787, 1089.3736101741372, 18038.458846234633, 18483.537911552317, 18543.0, 18740.53148671267, 18777.024088616527, 1016.8068067067234, 1020.8009438159488, 1033.571068006784, 1054.667779649408, 1079.7732476179933, 10090.394576325443, 10594.152467802558, 10663.520141593646, 10710.250282480152, 10749.731256718489, 476475.0, 486371.0, 488748.0, 490955.0, 494633.0, 68291.3170868285, 87679.0, 90563.54718226366, 90914.54542727377, 90980.5450972741, 1035.5909415780725, 1046.2048842879467, 1047.895210478946, 1083.7724077943562, 1091.8034753744244, 16587.751183732496, 16787.160641968097, 16845.747313790056, 17060.658786823944, 17138.828611714223, 37820.62179378171, 38908.80545597254, 40010.399844002946, 41726.79136604298, 41766.0, 52329.738351308, 55724.16413753716, 56723.71638141783, 57063.0, 57231.71384143052, 8607.440516366416, 8698.956505217433, 8771.429857059271, 8824.382293239412, 8869.0, 9800.31397802147, 12895.613131606067, 12995.220286782824, 13066.608001759962, 13183.736325273632, 10660.25378223517, 10673.89326106729, 10801.621943232263, 10849.294795838245, 10931.0, 11229.606963756229, 11344.9432752839, 11387.0, 11818.231814932002, 11997.100217483548, 10604.575816967235, 10871.782564348827, 10936.562537498728, 11324.263922844988, 11384.601538946097, 8623.913760862311, 8698.91301086981, 8736.0, 8746.65013399457, 8827.77786108053, 10812.243142979916, 10844.349339039683, 10982.121430285399, 11065.668029959113, 11214.551417943518], "value": 9070.708124305893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.2098661789555, 1529.8776097912166, 1532.103719324195, 1692.6022384739583, 1822.5716956515225, 7891.329237014854, 8793.472391656505, 8810.207081362683, 9098.0, 9108.316876234292, 8825.117488251171, 9003.324750643711, 9010.369274150811, 9014.414063085895, 9034.864477032834, 2085.8122768950793, 2293.9311820645325, 2381.368937231635, 2415.0339864054386, 2432.2460037388464, 2450.6569080328677, 2452.399162205253, 2454.9509009819794, 2457.778799908008, 2459.102427613926, 2358.13927916311, 2408.14510848648, 2408.819338549607, 2409.1929203716777, 2412.0713525292713, 2098.8111070003697, 2355.5171189906114, 2423.127674037345, 2425.50277193175, 2428.81783866209, 2405.182238039075, 2431.0154387473103, 2435.7686019828266, 2448.4368595223023, 2483.4412257242157, 8800.691975780817, 8849.292056635519, 8866.202041816268, 8879.334049946216, 8887.333449991276, 5367.490088441592, 5486.31421072366, 5495.780168793243, 5497.45025497451, 5502.752376143083, 3462.774919630216, 3482.12870502456, 3490.406630872758, 3595.7482976191677, 3596.892093237207, 1022.3303736052823, 1038.8649475568204, 1067.5889782433742, 1074.0816601805423, 1076.0692001418715, 12676.68308292291, 12957.352132393436, 12958.22250664963, 12972.286524241163, 12982.805257921043, 4889.559939605381, 4944.851654450372, 4970.2793095001025, 4996.250562415594, 5002.299678045077, 10744.194185435967, 10796.082333001626, 10815.513301901434, 10816.891831081588, 10837.783244335227, 4878.731669758197, 5407.78368865241, 5417.295751552273, 5417.322834645669, 5421.457854214547, 4904.411470623477, 5055.115354812893, 5056.9494305057215, 5090.694558326512, 5110.48895110486, 4128.752274863517, 4169.207850508394, 4210.842018444952, 4237.766922819213, 4244.193603215379, 1303.6154334471353, 1321.6960099177052, 1330.3281842669583, 1332.2739107186605, 1338.0967846703436, 856.1566856646199, 860.1226748716274, 936.9833730402453, 937.3813283233034, 938.5025936253796, 5820.796272130455, 5840.737166827503, 5849.122631605208, 5965.313988891333, 6060.848478787977, 450.38747303666986, 460.6545091181614, 461.54768327039017, 462.3480891942345, 466.3215022142774, 4098.0, 4197.517285512145, 4226.809793559297, 4253.829846806093, 4271.273883439822, 10988.230823842414, 11364.886351136549, 11366.886331136582, 11409.657710268539, 11452.083833293316, 10650.307729997681, 11102.0, 11152.76944611081, 11195.160362972647, 11418.942905285421, 8407.62165702545, 8427.241548260563, 8506.404551681446, 8528.08118173406, 8531.4881107135, 6069.33237343883, 6282.277538083179, 6300.810975670737, 6310.936890631218, 6315.842103947254, 10138.847917281395, 10487.528061237415, 10690.465476726287, 10736.51685674131, 10738.355698658106, 10670.093042091508, 10686.25196236256, 10693.625723099654, 10696.83954740664, 10706.036456718934, 7180.892286615809, 7266.781996540112, 7564.810879728051, 7702.191269916578, 7876.72431464896, 8830.984436789851, 8842.46945183291, 8897.73306800797, 8911.821763564563, 8916.73249802481, 7415.443841712001, 7873.1733168016535, 7876.921230787619, 7916.683332666629, 8004.119546849725, 7684.0, 7727.961360193163, 7754.844903102019, 7938.880916786368, 7966.681332746625, 6960.303969602999, 7022.08712867324, 7044.260352663102, 7051.541649792747, 7057.117860267466, 5102.158143906214, 5229.921551176812, 5321.255024296679, 5419.620626556103, 5536.778528858962, 5230.529252367305, 5320.255164276927, 5412.83761487156, 5532.557395408438, 5536.474034966672], "value": 4661.581766551964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.49005511622335, 337.1638336924427, 346.9323481921025, 347.1079326131839, 348.62000419542693, 5324.201369794533, 5371.167469042305, 5375.30121084259, 5396.649217800845, 5456.890862182754, 5243.4232234454275, 5273.657212281209, 5320.840374788753, 5345.358556973169, 5347.919781203275, 4017.2367250222364, 4192.0, 4200.096979149483, 4201.852935147271, 4221.873343799691, 4135.524414692319, 4179.832806687728, 4190.706650534464, 4194.517630472489, 4200.180964711883, 4139.855105071323, 4152.0, 4155.979220103895, 4167.395727619493, 4171.663868233783, 3903.9609603904023, 3978.508059477696, 4108.712390132692, 4117.608827161444, 4132.979335103335, 3632.836522356474, 3640.5631324240994, 3642.9453558196647, 3669.7247706422127, 3683.4290684943608, 4913.729744864031, 5105.183170692671, 5108.821191258326, 5123.359580052494, 5134.2812006319145, 4562.5665561771575, 4661.18429274879, 4735.455422626407, 4742.099001189763, 4784.64115191362, 5522.0, 5527.364353099405, 5543.528800052, 5548.889022219573, 5550.833474995757, 3929.783861887595, 3999.9800000999808, 4041.6968727345275, 4056.8782936511657, 4067.938980915259, 5703.230063941356, 5706.315242170925, 5728.341240757324, 5737.569682273805, 5746.138079288098, 4128.545859955402, 4129.0, 4131.615908670569, 4133.503979522477, 4134.276501612206, 4163.854265100707, 4210.926213815457, 4259.680523960654, 4261.680373971964, 4266.274733295348, 4755.476897541268, 4765.880852978703, 4768.0, 4774.498677638798, 4792.616590672737, 5467.398586155519, 5522.861928451821, 5523.696196709219, 5613.4282400927805, 5619.690916999522, 1411.6188629070298, 1445.9421623134956, 1459.729949959261, 1464.3630020940925, 1467.7945087687733, 904.8461761500561, 951.728757304165, 962.6486332488731, 963.393062370702, 965.9565319560637, 4816.819879129635, 4818.566329030404, 4823.710577365369, 4826.8069277228515, 4827.975860120677, 4981.227909674007, 5007.84976450707, 5053.823116190989, 5056.646034777604, 5091.41448733393, 4808.749725071507, 4825.153159635832, 5123.488570871527, 5143.639945203875, 5386.91919621206, 3024.395120975814, 3031.7271445570004, 3035.0, 3039.9664114201278, 3047.9085627431214, 5666.291713535808, 5887.35239123696, 5893.882122357614, 5898.203742494794, 5901.262342207224, 5747.3677895431465, 5780.104083867007, 5789.942100579025, 5793.188953546507, 5803.390643982406, 5869.20765696634, 5890.322612899486, 5910.202122713378, 5921.644701317849, 5934.821955341346, 5450.809221677222, 5709.54655368813, 5722.74247658848, 5747.281589801275, 5772.7402266898935, 5621.775128994795, 5688.5733569981585, 5707.372189059283, 5710.885782284248, 5726.713664316851, 5728.484436400744, 5927.881442371042, 5938.0, 5939.75265194314, 5967.343592204767, 4029.879103626896, 4111.650509706708, 4115.58844115598, 4133.21468920904, 4137.50349958007, 5604.3187043885855, 5717.914231286451, 5726.9713651431475, 5764.913526297025, 5773.566982476247, 5516.91724624139, 5602.467765562265, 5618.185363122406, 5656.547476201812, 5663.405342438985, 5590.273264475592, 5606.636018388934, 5607.5513958884, 5619.550435965195, 5623.409541998031, 5472.945270547243, 5491.835244942658, 5527.115661494142, 5536.584756143386, 5546.500814926676, 5405.86485337854, 5613.354464236665, 5619.269494965628, 5651.576131790214, 5661.329907677327, 5486.533644640251, 5489.917651235314, 5506.944930550643, 5531.1426728857095, 5544.861378465571], "value": 4233.519136413718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.5690413368515, 806.9314108300794, 809.3201710563126, 820.3560205238889, 826.4834478450969, 13980.860191398097, 15001.324940377683, 15011.774823377658, 15060.623484412896, 15081.170535620537, 14084.647883802885, 14088.859111408883, 14104.788428173586, 14107.224102674349, 14157.36291866866, 672.6838385958591, 796.6972550430828, 798.3692882622721, 811.9188081191863, 812.1594150054694, 806.5725165662209, 814.2346194577108, 817.0562999735286, 817.23588444804, 817.8364327134597, 858.7767180533075, 861.6208868098048, 862.2886118951858, 863.2748491267334, 863.9870401943975, 698.1970733656285, 834.56185502611, 856.1224744636735, 860.1957170045996, 862.5988915154452, 614.8124821929309, 617.7992152550439, 620.2371083567192, 623.8315654773186, 624.1012941364467, 13387.598372048855, 13410.396532156077, 13433.529826456028, 13443.865561344359, 13445.731085378238, 13659.453621855115, 14067.617221822875, 14110.153390796482, 14141.656542628434, 14440.13359198441, 11649.825252621218, 12354.135210535265, 12524.311162886037, 12558.874411255953, 12831.101822872402, 4377.868663940087, 4396.450443694538, 4435.206507760861, 4484.753338566377, 4616.584507394317, 63697.3630263696, 64382.3561764381, 64652.0, 66467.0029949556, 66529.66735166342, 11160.330380177214, 11226.47050040319, 11239.438028098562, 11291.887081129247, 11395.259308144945, 17441.563960900825, 19400.0, 19411.126499307564, 19418.223271069, 19430.417087487396, 7950.920490795018, 8062.39532035088, 8099.676012959533, 8250.298724608356, 8296.170382961776, 4753.548412900769, 4775.355327030876, 4894.853154405374, 4973.1297023020825, 5007.098722229961, 3348.5814273215847, 3428.8285585720614, 3433.690967812859, 3445.2764919366714, 3446.2590543033366, 631.778877392918, 631.962082275065, 646.0696596900542, 646.0922404022356, 656.5929123943185, 705.947053970944, 708.6598432752205, 741.5810067311952, 747.3983443328173, 787.2599756229126, 9472.242220622335, 9979.966127267475, 9985.850212246822, 10081.546330415149, 10132.594696212216, 701.8771714949863, 725.7242247945852, 758.635854789704, 779.174075479993, 797.6490344248512, 4497.775111244425, 4797.784099715521, 4830.468648448667, 4835.326148947875, 4867.805287788448, 68374.0, 71920.45590403794, 73031.63484182545, 73157.26842731505, 73310.0, 63915.0, 64026.35973640297, 64414.35585644084, 64439.355606444275, 66218.33781662218, 56413.0, 56453.43546564564, 57616.0, 58094.4190558089, 59020.704896476105, 9215.907840921505, 9287.257019438293, 9336.39313444651, 9420.858687119562, 9579.712608621752, 37173.628263717015, 37533.249335013694, 38102.04744881289, 38233.0, 38657.0, 50768.74615626898, 52928.47071529235, 53060.20409693781, 53313.466865332404, 53606.73196633992, 10957.06864916491, 11024.669259922215, 11329.093672506344, 11705.356205408785, 12242.143049986415, 12758.872411275768, 13312.866871331164, 13805.24071176095, 13982.44070237179, 14045.297735113409, 11252.774944501229, 11367.374794386387, 11551.480183391599, 12123.151379403356, 12878.742425151631, 11206.943965280121, 11262.662120136409, 11290.0, 11480.233189125236, 11725.061995040205, 11405.885941140483, 11447.771044579229, 11456.541738330374, 11539.596114135966, 11805.30312461098, 9510.95244523773, 9568.282378821477, 9658.0, 9940.850887236553, 10082.591334110411, 10601.25791194609, 10642.467876605984, 10797.946010269898, 10848.186386020921, 10886.0], "value": 6947.029978177795, "unit": "score"}], "name": "dromaeo_css", "value": 7062.006550888352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 112.0, 113.0, 118.0, 110.0, 109.0, 108.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 128.0, 214.0, 132.0, 126.0, 152.0, 126.0, 164.0, 126.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 132.0, 75.0, 75.0, 74.0, 75.0, 120.0, 74.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 164.0, 93.0, 93.0, 92.0, 134.0, 92.0, 93.0, 137.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 55.0, 54.0, 55.0, 54.0, 115.0, 52.0, 51.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 60.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 79.0, 78.0, 78.0, 79.0, 80.0, 87.0, 80.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 119.0, 119.0, 122.0, 116.0, 116.0, 116.0, 126.0, 251.0, 121.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 160.0, 165.0, 160.0, 166.0, 162.0, 161.0, 157.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 63.0, 61.0, 63.0, 61.0, 61.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1527.2, "alertThreshold": 2.0}]} 22:34:19 INFO - Return code: 0 22:34:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:34:19 ERROR - # TBPL SUCCESS # 22:34:19 INFO - Running post-action listener: _resource_record_post_action 22:34:19 INFO - ##### 22:34:19 INFO - ##### Finished run-tests step (success) 22:34:19 INFO - ##### 22:34:19 INFO - Running post-run listener: _resource_record_post_run 22:34:19 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543735808; Read time: 932; Write time: 3633692 22:34:19 INFO - TinderboxPrint: CPU usage
13.5% 22:34:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 932 22:34:19 INFO - TinderboxPrint: I/O write bytes / time
543,735,808 / 3,633,692 22:34:19 INFO - TinderboxPrint: CPU idle
8,353.1 (86.5%) 22:34:19 INFO - TinderboxPrint: CPU user
1,207.3 (12.5%) 22:34:19 INFO - TinderboxPrint: Swap in / out
0 / 0 22:34:19 INFO - install - Wall time: 24s; CPU: 21.0%; Read bytes: 0; Write bytes: 245530624; Read time: 0; Write time: 2233792 22:34:19 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291098624; Read time: 932; Write time: 1314580 22:34:19 INFO - Running post-run listener: _upload_blobber_files 22:34:19 INFO - Blob upload gear active. 22:34:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:34:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:34:20 INFO - (blobuploader) - INFO - Open directory for files ... 22:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:20 INFO - (blobuploader) - INFO - Done attempting. 22:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:34:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:25 INFO - (blobuploader) - INFO - Done attempting. 22:34:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:34:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:26 INFO - (blobuploader) - INFO - Done attempting. 22:34:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:34:26 INFO - Return code: 0 22:34:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:34:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:34:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66c4314521a648c7d3c52da4fc2f5452fb4ba04321aea808b90a2529a706b80371acba53688e241d0d9d42e745260a570ba0b834ff84ac0621264792ef677c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e380bd482875641c701ad646a662a8c2da0120179fc5a098a5d00a929a290016d4fa5e74da0a95ba6990587c41526e0a986c51f7bbf67a25d49604606e014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2ea4016d613084da9c5b45499c6dd230fb0ae87f5fef19b0e4be17ec2030e8591366775bcfdce5becd20986f337b9ad8dbf7e5168d0f239ddd87b277fcc0ed4"} 22:34:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:34:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:34:26 INFO - Contents: 22:34:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66c4314521a648c7d3c52da4fc2f5452fb4ba04321aea808b90a2529a706b80371acba53688e241d0d9d42e745260a570ba0b834ff84ac0621264792ef677c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e380bd482875641c701ad646a662a8c2da0120179fc5a098a5d00a929a290016d4fa5e74da0a95ba6990587c41526e0a986c51f7bbf67a25d49604606e014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2ea4016d613084da9c5b45499c6dd230fb0ae87f5fef19b0e4be17ec2030e8591366775bcfdce5becd20986f337b9ad8dbf7e5168d0f239ddd87b277fcc0ed4"} 22:34:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:34:26 INFO - Copying logs to upload dir... 22:34:26 INFO - mkdir: /builds/slave/test/build/upload/logs 22:34:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.376496 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-20 22:34:25.971727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 22:34:25.974924) ========= 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=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66c4314521a648c7d3c52da4fc2f5452fb4ba04321aea808b90a2529a706b80371acba53688e241d0d9d42e745260a570ba0b834ff84ac0621264792ef677c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e380bd482875641c701ad646a662a8c2da0120179fc5a098a5d00a929a290016d4fa5e74da0a95ba6990587c41526e0a986c51f7bbf67a25d49604606e014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2ea4016d613084da9c5b45499c6dd230fb0ae87f5fef19b0e4be17ec2030e8591366775bcfdce5becd20986f337b9ad8dbf7e5168d0f239ddd87b277fcc0ed4"} build_url:https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/bGdJDOdtTs229ttTdgMpPQ/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/Mozilla-Inbound/sha512/66c4314521a648c7d3c52da4fc2f5452fb4ba04321aea808b90a2529a706b80371acba53688e241d0d9d42e745260a570ba0b834ff84ac0621264792ef677c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e380bd482875641c701ad646a662a8c2da0120179fc5a098a5d00a929a290016d4fa5e74da0a95ba6990587c41526e0a986c51f7bbf67a25d49604606e014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2ea4016d613084da9c5b45499c6dd230fb0ae87f5fef19b0e4be17ec2030e8591366775bcfdce5becd20986f337b9ad8dbf7e5168d0f239ddd87b277fcc0ed4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 22:34:25.999949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:34:26.000291) ========= 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=33d5923976266a1c518c4bf7000001ab-1463807495.937392-1306316273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:34:26.084865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 22:34:26.085231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 22:34:26.085625) ========= ========= Total master_lag: 0.18 =========