builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1464790627.27 results: success (0) buildid: 20160601043021 builduid: f49e8bf10ea146109552233da1c964f7 revision: 045cdefdb9410e0ed47cb479d410700d522ca7ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.274378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.274903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.275226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.290471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.290807) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:17:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.9M=0s 2016-06-01 07:17:07 (68.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.483143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.483493) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:07.533736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:17:07.534118) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 045cdefdb9410e0ed47cb479d410700d522ca7ba --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 045cdefdb9410e0ed47cb479d410700d522ca7ba --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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:17:07,677 truncating revision to first 12 chars 2016-06-01 07:17:07,677 Setting DEBUG logging. 2016-06-01 07:17:07,677 attempt 1/10 2016-06-01 07:17:07,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/045cdefdb941?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:17:08,777 unpacking tar archive at: mozilla-inbound-045cdefdb941/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433233 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:17:09.086632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:09.087066) ========= script_repo_revision: 045cdefdb9410e0ed47cb479d410700d522ca7ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:09.087506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:09.088009) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:17:09.099216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-01 07:17:09.099574) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:09 INFO - MultiFileLogger online at 20160601 07:17:09 in /builds/slave/test 07:17:09 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 07:17:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:09 INFO - {'append_to_log': False, 07:17:09 INFO - 'base_work_dir': '/builds/slave/test', 07:17:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:17:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:09 INFO - 'branch': 'Mozilla-Inbound', 07:17:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:09 INFO - 'config_files': ('talos/linux_config.py',), 07:17:09 INFO - 'default_actions': ('clobber', 07:17:09 INFO - 'read-buildbot-config', 07:17:09 INFO - 'download-and-extract', 07:17:09 INFO - 'populate-webroot', 07:17:09 INFO - 'create-virtualenv', 07:17:09 INFO - 'install', 07:17:09 INFO - 'run-tests'), 07:17:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:09 INFO - 'download_minidump_stackwalk': True, 07:17:09 INFO - 'download_symbols': 'ondemand', 07:17:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:09 INFO - 'installer_path': 'installer.exe', 07:17:09 INFO - 'log_level': 'info', 07:17:09 INFO - 'log_name': 'talos', 07:17:09 INFO - 'log_to_console': True, 07:17:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:09 INFO - 'opt_config_files': (), 07:17:09 INFO - 'pip_index': False, 07:17:09 INFO - 'sps_profile': False, 07:17:09 INFO - 'sps_profile_interval': 0, 07:17:09 INFO - 'suite': 'dromaeojs', 07:17:09 INFO - 'system_bits': '32', 07:17:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:09 INFO - 'title': 'talos-linux64-ix-023', 07:17:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:09 INFO - 'use_talos_json': True, 07:17:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:09 INFO - 'work_dir': 'build'} 07:17:09 INFO - ##### 07:17:09 INFO - ##### Running clobber step. 07:17:09 INFO - ##### 07:17:09 INFO - Running pre-action listener: _resource_record_pre_action 07:17:09 INFO - Running main action method: clobber 07:17:09 INFO - rmtree: /builds/slave/test/build 07:17:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:09 INFO - Running post-action listener: _resource_record_post_action 07:17:09 INFO - ##### 07:17:09 INFO - ##### Finished clobber step (success) 07:17:09 INFO - ##### 07:17:09 INFO - ##### 07:17:09 INFO - ##### Running read-buildbot-config step. 07:17:09 INFO - ##### 07:17:09 INFO - Running pre-action listener: _resource_record_pre_action 07:17:09 INFO - Running main action method: read_buildbot_config 07:17:09 INFO - Using buildbot properties: 07:17:09 INFO - { 07:17:09 INFO - "project": "", 07:17:09 INFO - "product": "firefox", 07:17:09 INFO - "script_repo_revision": "production", 07:17:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:17:09 INFO - "repository": "", 07:17:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:17:09 INFO - "buildid": "20160601043021", 07:17:09 INFO - "pgo_build": "True", 07:17:09 INFO - "basedir": "/builds/slave/test", 07:17:09 INFO - "buildnumber": 1880, 07:17:09 INFO - "slavename": "talos-linux64-ix-023", 07:17:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:09 INFO - "platform": "ubuntu64_hw", 07:17:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:17:09 INFO - "branch": "mozilla-inbound", 07:17:09 INFO - "repo_path": "integration/mozilla-inbound", 07:17:09 INFO - "revision": "045cdefdb9410e0ed47cb479d410700d522ca7ba", 07:17:09 INFO - "stage_platform": "linux64-pgo", 07:17:09 INFO - "builduid": "f49e8bf10ea146109552233da1c964f7", 07:17:09 INFO - "slavebuilddir": "test" 07:17:09 INFO - } 07:17:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:17:09 INFO - Running post-action listener: _resource_record_post_action 07:17:09 INFO - ##### 07:17:09 INFO - ##### Finished read-buildbot-config step (success) 07:17:09 INFO - ##### 07:17:09 INFO - ##### 07:17:09 INFO - ##### Running download-and-extract step. 07:17:09 INFO - ##### 07:17:09 INFO - Running pre-action listener: _resource_record_pre_action 07:17:09 INFO - Running main action method: download_and_extract 07:17:09 INFO - mkdir: /builds/slave/test/build/tests 07:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:09 INFO - https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/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 07:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/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 07:17:10 INFO - Downloaded 1361 bytes. 07:17:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:17:10 INFO - Using the following test package requirements: 07:17:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:17:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'jsshell-linux-x86_64.zip'], 07:17:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:10 INFO - https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:11 INFO - Downloaded 24422680 bytes. 07:17:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:17:13 INFO - Return code: 0 07:17:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:13 INFO - https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:14 INFO - Downloaded 24422680 bytes. 07:17:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:17:15 INFO - Return code: 0 07:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:15 INFO - https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:17:16 INFO - Downloaded 10834055 bytes. 07:17:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:17:16 INFO - Return code: 0 07:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:16 INFO - https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:17:18 INFO - Downloaded 59021380 bytes. 07:17:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:17:18 INFO - mkdir: /builds/slave/test/properties 07:17:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:18 INFO - Contents: 07:17:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:17:19 INFO - Running post-action listener: _resource_record_post_action 07:17:19 INFO - Running post-action listener: set_extra_try_arguments 07:17:19 INFO - ##### 07:17:19 INFO - ##### Finished download-and-extract step (success) 07:17:19 INFO - ##### 07:17:19 INFO - ##### 07:17:19 INFO - ##### Running populate-webroot step. 07:17:19 INFO - ##### 07:17:19 INFO - Running pre-action listener: _resource_record_pre_action 07:17:19 INFO - Running main action method: populate_webroot 07:17:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:19 INFO - '--tppagecycles', 07:17:19 INFO - '7'], 07:17:19 INFO - 'tests': ['tsvgm']}}, 07:17:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['damp', 'tps']}, 07:17:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'tests': ['damp', 'tps']}, 07:17:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['dromaeo_dom']}, 07:17:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['a11yr', 07:17:19 INFO - 'ts_paint', 07:17:19 INFO - 'tpaint', 07:17:19 INFO - 'sessionrestore', 07:17:19 INFO - 'sessionrestore_no_auto_restore', 07:17:19 INFO - 'tabpaint']}, 07:17:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['tsvgx', 07:17:19 INFO - 'tsvgr_opacity', 07:17:19 INFO - 'tart', 07:17:19 INFO - 'tscrollx', 07:17:19 INFO - 'cart']}, 07:17:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:19 INFO - 'tsvgr_opacity', 07:17:19 INFO - 'tart', 07:17:19 INFO - 'tscrollx', 07:17:19 INFO - 'cart']}, 07:17:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'talos_options': ['--disable-e10s'], 07:17:19 INFO - 'tests': ['tp5o']}, 07:17:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'tests': ['tp5o']}, 07:17:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'talos_options': ['--disable-e10s', 07:17:19 INFO - '--xperf_path', 07:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:19 INFO - 'tests': ['tp5n']}, 07:17:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:19 INFO - 'talos_options': ['--xperf_path', 07:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:19 INFO - 'tests': ['tp5n']}}, 07:17:19 INFO - 'talos.zip': {'path': '', 07:17:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:19 INFO - Running post-action listener: _resource_record_post_action 07:17:19 INFO - ##### 07:17:19 INFO - ##### Finished populate-webroot step (success) 07:17:19 INFO - ##### 07:17:19 INFO - ##### 07:17:19 INFO - ##### Running create-virtualenv step. 07:17:19 INFO - ##### 07:17:19 INFO - Running pre-action listener: _resource_record_pre_action 07:17:19 INFO - Running main action method: create_virtualenv 07:17:19 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:17:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:19 INFO - Using real prefix '/usr' 07:17:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:21 INFO - Installing pip.................done. 07:17:21 INFO - Return code: 0 07:17:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:21 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:21 INFO - Using env: {'DISPLAY': ':0', 07:17:21 INFO - 'HOME': '/home/cltbld', 07:17:21 INFO - 'LANG': 'en_US.UTF-8', 07:17:21 INFO - 'LANGUAGE': 'en_US:en', 07:17:21 INFO - 'LOGNAME': 'cltbld', 07:17:21 INFO - 'MAIL': '/var/mail/cltbld', 07:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:21 INFO - 'MOZ_NO_REMOTE': '1', 07:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:21 INFO - 'NO_EM_RESTART': '1', 07:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:21 INFO - 'PWD': '/builds/slave/test', 07:17:21 INFO - 'SHELL': '/bin/bash', 07:17:21 INFO - 'SHLVL': '1', 07:17:21 INFO - 'TERM': 'linux', 07:17:21 INFO - 'TMOUT': '86400', 07:17:21 INFO - 'USER': 'cltbld', 07:17:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:21 INFO - '_': '/tools/buildbot/bin/python'} 07:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:21 INFO - Cleaning up... 07:17:21 INFO - Return code: 0 07:17:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:21 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:17:21 INFO - Using env: {'DISPLAY': ':0', 07:17:21 INFO - 'HOME': '/home/cltbld', 07:17:21 INFO - 'LANG': 'en_US.UTF-8', 07:17:21 INFO - 'LANGUAGE': 'en_US:en', 07:17:21 INFO - 'LOGNAME': 'cltbld', 07:17:21 INFO - 'MAIL': '/var/mail/cltbld', 07:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:21 INFO - 'MOZ_NO_REMOTE': '1', 07:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:21 INFO - 'NO_EM_RESTART': '1', 07:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:21 INFO - 'PWD': '/builds/slave/test', 07:17:21 INFO - 'SHELL': '/bin/bash', 07:17:21 INFO - 'SHLVL': '1', 07:17:21 INFO - 'TERM': 'linux', 07:17:21 INFO - 'TMOUT': '86400', 07:17:21 INFO - 'USER': 'cltbld', 07:17:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:21 INFO - '_': '/tools/buildbot/bin/python'} 07:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:22 INFO - Downloading/unpacking psutil>=3.1.1 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:24 INFO - Installing collected packages: psutil 07:17:24 INFO - Running setup.py install for psutil 07:17:24 INFO - building 'psutil._psutil_linux' extension 07:17:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:17:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:17:24 INFO - building 'psutil._psutil_posix' extension 07:17:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:17:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:24 INFO - Successfully installed psutil 07:17:24 INFO - Cleaning up... 07:17:24 INFO - Return code: 0 07:17:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:24 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:17:24 INFO - Using env: {'DISPLAY': ':0', 07:17:24 INFO - 'HOME': '/home/cltbld', 07:17:24 INFO - 'LANG': 'en_US.UTF-8', 07:17:24 INFO - 'LANGUAGE': 'en_US:en', 07:17:24 INFO - 'LOGNAME': 'cltbld', 07:17:24 INFO - 'MAIL': '/var/mail/cltbld', 07:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:24 INFO - 'MOZ_NO_REMOTE': '1', 07:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:24 INFO - 'NO_EM_RESTART': '1', 07:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:24 INFO - 'PWD': '/builds/slave/test', 07:17:24 INFO - 'SHELL': '/bin/bash', 07:17:24 INFO - 'SHLVL': '1', 07:17:24 INFO - 'TERM': 'linux', 07:17:24 INFO - 'TMOUT': '86400', 07:17:24 INFO - 'USER': 'cltbld', 07:17:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:24 INFO - '_': '/tools/buildbot/bin/python'} 07:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:26 INFO - Installing collected packages: mozsystemmonitor 07:17:26 INFO - Running setup.py install for mozsystemmonitor 07:17:26 INFO - Successfully installed mozsystemmonitor 07:17:26 INFO - Cleaning up... 07:17:27 INFO - Return code: 0 07:17:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:27 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:17:27 INFO - Using env: {'DISPLAY': ':0', 07:17:27 INFO - 'HOME': '/home/cltbld', 07:17:27 INFO - 'LANG': 'en_US.UTF-8', 07:17:27 INFO - 'LANGUAGE': 'en_US:en', 07:17:27 INFO - 'LOGNAME': 'cltbld', 07:17:27 INFO - 'MAIL': '/var/mail/cltbld', 07:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:27 INFO - 'MOZ_NO_REMOTE': '1', 07:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:27 INFO - 'NO_EM_RESTART': '1', 07:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:27 INFO - 'PWD': '/builds/slave/test', 07:17:27 INFO - 'SHELL': '/bin/bash', 07:17:27 INFO - 'SHLVL': '1', 07:17:27 INFO - 'TERM': 'linux', 07:17:27 INFO - 'TMOUT': '86400', 07:17:27 INFO - 'USER': 'cltbld', 07:17:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:27 INFO - '_': '/tools/buildbot/bin/python'} 07:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - Downloading docopt-0.6.1.tar.gz 07:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:31 INFO - Running setup.py install for blobuploader 07:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:31 INFO - Running setup.py install for requests 07:17:31 INFO - Running setup.py install for docopt 07:17:31 INFO - Successfully installed blobuploader requests docopt 07:17:31 INFO - Cleaning up... 07:17:31 INFO - Return code: 0 07:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:31 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:31 INFO - Using env: {'DISPLAY': ':0', 07:17:31 INFO - 'HOME': '/home/cltbld', 07:17:31 INFO - 'LANG': 'en_US.UTF-8', 07:17:31 INFO - 'LANGUAGE': 'en_US:en', 07:17:31 INFO - 'LOGNAME': 'cltbld', 07:17:31 INFO - 'MAIL': '/var/mail/cltbld', 07:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:31 INFO - 'MOZ_NO_REMOTE': '1', 07:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:31 INFO - 'NO_EM_RESTART': '1', 07:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:31 INFO - 'PWD': '/builds/slave/test', 07:17:31 INFO - 'SHELL': '/bin/bash', 07:17:31 INFO - 'SHLVL': '1', 07:17:31 INFO - 'TERM': 'linux', 07:17:31 INFO - 'TMOUT': '86400', 07:17:31 INFO - 'USER': 'cltbld', 07:17:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:31 INFO - '_': '/tools/buildbot/bin/python'} 07:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:31 INFO - Running setup.py (path:/tmp/pip-8mXyk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:31 INFO - Running setup.py (path:/tmp/pip-8lqoz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:32 INFO - Running setup.py (path:/tmp/pip-7S9qTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:32 INFO - Running setup.py (path:/tmp/pip-A183rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:32 INFO - Running setup.py (path:/tmp/pip-2EA14w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:32 INFO - Running setup.py (path:/tmp/pip-S7VOtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:32 INFO - Running setup.py (path:/tmp/pip-VwYgR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:32 INFO - Running setup.py (path:/tmp/pip-Nx6lKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:32 INFO - Running setup.py (path:/tmp/pip-VHfiSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:32 INFO - Running setup.py (path:/tmp/pip-OZwpHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:32 INFO - Running setup.py (path:/tmp/pip-AyV9q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:32 INFO - Running setup.py (path:/tmp/pip-CjPaLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:32 INFO - Running setup.py (path:/tmp/pip-tL41JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:32 INFO - Running setup.py (path:/tmp/pip-JwrQGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:32 INFO - Running setup.py (path:/tmp/pip-lo0KAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:32 INFO - Running setup.py (path:/tmp/pip-hnj8DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:33 INFO - Running setup.py (path:/tmp/pip-RkBzX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:33 INFO - Running setup.py install for manifestparser 07:17:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Running setup.py install for mozcrash 07:17:33 INFO - Running setup.py install for mozdebug 07:17:33 INFO - Running setup.py install for mozdevice 07:17:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Running setup.py install for mozfile 07:17:33 INFO - Running setup.py install for mozhttpd 07:17:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Running setup.py install for mozinfo 07:17:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Running setup.py install for mozInstall 07:17:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:33 INFO - Running setup.py install for mozleak 07:17:34 INFO - Running setup.py install for mozlog 07:17:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Running setup.py install for moznetwork 07:17:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Running setup.py install for mozprocess 07:17:34 INFO - Running setup.py install for mozprofile 07:17:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Running setup.py install for mozrunner 07:17:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Running setup.py install for mozscreenshot 07:17:34 INFO - Running setup.py install for moztest 07:17:34 INFO - Running setup.py install for mozversion 07:17:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:34 INFO - Cleaning up... 07:17:34 INFO - Return code: 0 07:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:34 INFO - Using env: {'DISPLAY': ':0', 07:17:34 INFO - 'HOME': '/home/cltbld', 07:17:34 INFO - 'LANG': 'en_US.UTF-8', 07:17:34 INFO - 'LANGUAGE': 'en_US:en', 07:17:34 INFO - 'LOGNAME': 'cltbld', 07:17:34 INFO - 'MAIL': '/var/mail/cltbld', 07:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:34 INFO - 'MOZ_NO_REMOTE': '1', 07:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:34 INFO - 'NO_EM_RESTART': '1', 07:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:34 INFO - 'PWD': '/builds/slave/test', 07:17:34 INFO - 'SHELL': '/bin/bash', 07:17:34 INFO - 'SHLVL': '1', 07:17:34 INFO - 'TERM': 'linux', 07:17:34 INFO - 'TMOUT': '86400', 07:17:34 INFO - 'USER': 'cltbld', 07:17:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:34 INFO - '_': '/tools/buildbot/bin/python'} 07:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:35 INFO - Running setup.py (path:/tmp/pip-h9Oo9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:35 INFO - Running setup.py (path:/tmp/pip-K575QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:35 INFO - Running setup.py (path:/tmp/pip-sdyszD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:35 INFO - Running setup.py (path:/tmp/pip-amnZ8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:35 INFO - Running setup.py (path:/tmp/pip-fFnrlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:35 INFO - Running setup.py (path:/tmp/pip-UYbTvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:35 INFO - Running setup.py (path:/tmp/pip-xfcPsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:35 INFO - Running setup.py (path:/tmp/pip-T9yHCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:35 INFO - Running setup.py (path:/tmp/pip-AaXvgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:35 INFO - Running setup.py (path:/tmp/pip-ioFasj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:35 INFO - Running setup.py (path:/tmp/pip-8h9a3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:35 INFO - Running setup.py (path:/tmp/pip-Km8kJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:36 INFO - Running setup.py (path:/tmp/pip-3RC7YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:36 INFO - Running setup.py (path:/tmp/pip-xeOW9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:36 INFO - Running setup.py (path:/tmp/pip-wnLst2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:36 INFO - Running setup.py (path:/tmp/pip-MTx7Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:36 INFO - Running setup.py (path:/tmp/pip-GqOkpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:38 INFO - Downloading blessings-1.6.tar.gz 07:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:38 INFO - Installing collected packages: blessings 07:17:38 INFO - Running setup.py install for blessings 07:17:38 INFO - Successfully installed blessings 07:17:38 INFO - Cleaning up... 07:17:38 INFO - Return code: 0 07:17:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:38 INFO - Reading from file tmpfile_stdout 07:17:38 INFO - Current package versions: 07:17:38 INFO - argparse == 1.2.1 07:17:38 INFO - blessings == 1.6 07:17:38 INFO - blobuploader == 1.2.4 07:17:38 INFO - docopt == 0.6.1 07:17:38 INFO - manifestparser == 1.1 07:17:38 INFO - mozInstall == 1.12 07:17:38 INFO - mozcrash == 0.17 07:17:38 INFO - mozdebug == 0.1 07:17:38 INFO - mozdevice == 0.48 07:17:38 INFO - mozfile == 1.2 07:17:38 INFO - mozhttpd == 0.7 07:17:38 INFO - mozinfo == 0.9 07:17:38 INFO - mozleak == 0.1 07:17:38 INFO - mozlog == 3.2 07:17:38 INFO - moznetwork == 0.27 07:17:38 INFO - mozprocess == 0.22 07:17:38 INFO - mozprofile == 0.28 07:17:38 INFO - mozrunner == 6.11 07:17:38 INFO - mozscreenshot == 0.1 07:17:38 INFO - mozsystemmonitor == 0.3 07:17:38 INFO - moztest == 0.7 07:17:38 INFO - mozversion == 1.4 07:17:38 INFO - psutil == 3.1.1 07:17:38 INFO - requests == 1.2.3 07:17:38 INFO - wsgiref == 0.1.2 07:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:38 INFO - Using env: {'DISPLAY': ':0', 07:17:38 INFO - 'HOME': '/home/cltbld', 07:17:38 INFO - 'LANG': 'en_US.UTF-8', 07:17:38 INFO - 'LANGUAGE': 'en_US:en', 07:17:38 INFO - 'LOGNAME': 'cltbld', 07:17:38 INFO - 'MAIL': '/var/mail/cltbld', 07:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:38 INFO - 'MOZ_NO_REMOTE': '1', 07:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:38 INFO - 'NO_EM_RESTART': '1', 07:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:38 INFO - 'PWD': '/builds/slave/test', 07:17:38 INFO - 'SHELL': '/bin/bash', 07:17:38 INFO - 'SHLVL': '1', 07:17:38 INFO - 'TERM': 'linux', 07:17:38 INFO - 'TMOUT': '86400', 07:17:38 INFO - 'USER': 'cltbld', 07:17:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:38 INFO - '_': '/tools/buildbot/bin/python'} 07:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:38 INFO - Cleaning up... 07:17:38 INFO - Return code: 0 07:17:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:17:38 INFO - Using env: {'DISPLAY': ':0', 07:17:38 INFO - 'HOME': '/home/cltbld', 07:17:38 INFO - 'LANG': 'en_US.UTF-8', 07:17:38 INFO - 'LANGUAGE': 'en_US:en', 07:17:38 INFO - 'LOGNAME': 'cltbld', 07:17:38 INFO - 'MAIL': '/var/mail/cltbld', 07:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:38 INFO - 'MOZ_NO_REMOTE': '1', 07:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:38 INFO - 'NO_EM_RESTART': '1', 07:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:38 INFO - 'PWD': '/builds/slave/test', 07:17:38 INFO - 'SHELL': '/bin/bash', 07:17:38 INFO - 'SHLVL': '1', 07:17:38 INFO - 'TERM': 'linux', 07:17:38 INFO - 'TMOUT': '86400', 07:17:38 INFO - 'USER': 'cltbld', 07:17:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:38 INFO - '_': '/tools/buildbot/bin/python'} 07:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:39 INFO - Downloading/unpacking jsonschema 07:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:41 INFO - Downloading/unpacking functools32 (from jsonschema) 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:41 INFO - warning: no files found matching '*.txt' 07:17:41 INFO - no previously-included directories found matching 'build' 07:17:41 INFO - no previously-included directories found matching 'dist' 07:17:41 INFO - no previously-included directories found matching '.git*' 07:17:41 INFO - Installing collected packages: jsonschema, functools32 07:17:41 INFO - Running setup.py install for functools32 07:17:41 INFO - warning: no files found matching '*.txt' 07:17:41 INFO - no previously-included directories found matching 'build' 07:17:41 INFO - no previously-included directories found matching 'dist' 07:17:41 INFO - no previously-included directories found matching '.git*' 07:17:41 INFO - Successfully installed jsonschema functools32 07:17:41 INFO - Cleaning up... 07:17:41 INFO - Return code: 0 07:17:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:41 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 0x7fc73812df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:17:41 INFO - Using env: {'DISPLAY': ':0', 07:17:41 INFO - 'HOME': '/home/cltbld', 07:17:41 INFO - 'LANG': 'en_US.UTF-8', 07:17:41 INFO - 'LANGUAGE': 'en_US:en', 07:17:41 INFO - 'LOGNAME': 'cltbld', 07:17:41 INFO - 'MAIL': '/var/mail/cltbld', 07:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:41 INFO - 'MOZ_NO_REMOTE': '1', 07:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:41 INFO - 'NO_EM_RESTART': '1', 07:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:41 INFO - 'PWD': '/builds/slave/test', 07:17:41 INFO - 'SHELL': '/bin/bash', 07:17:41 INFO - 'SHLVL': '1', 07:17:41 INFO - 'TERM': 'linux', 07:17:41 INFO - 'TMOUT': '86400', 07:17:41 INFO - 'USER': 'cltbld', 07:17:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:41 INFO - '_': '/tools/buildbot/bin/python'} 07:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:41 INFO - Downloading/unpacking flake8 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:17:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:17:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:44 INFO - no previously-included directories found matching 'docs/_build' 07:17:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:17:44 INFO - Running setup.py install for pep8 07:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:44 INFO - no previously-included directories found matching 'docs/_build' 07:17:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:17:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:17:44 INFO - Cleaning up... 07:17:44 INFO - Return code: 0 07:17:44 INFO - Running post-action listener: _resource_record_post_action 07:17:44 INFO - Running post-action listener: _start_resource_monitoring 07:17:44 INFO - Starting resource monitoring. 07:17:44 INFO - ##### 07:17:44 INFO - ##### Finished create-virtualenv step (success) 07:17:44 INFO - ##### 07:17:44 INFO - ##### 07:17:44 INFO - ##### Running install step. 07:17:44 INFO - ##### 07:17:44 INFO - Running pre-action listener: _resource_record_pre_action 07:17:44 INFO - Running main action method: install 07:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:44 INFO - Reading from file tmpfile_stdout 07:17:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:44 INFO - Reading from file tmpfile_stdout 07:17:44 INFO - Output received: 07:17:44 INFO - Usage: mozinstall [options] installer 07:17:44 INFO - Options: 07:17:44 INFO - -h, --help show this help message and exit 07:17:44 INFO - -d DEST, --destination=DEST 07:17:44 INFO - Directory to install application into. [default: 07:17:44 INFO - "/builds/slave/test"] 07:17:44 INFO - --app=APP Application being installed. [default: firefox] 07:17:44 INFO - mkdir: /builds/slave/test/build/application 07:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:18:01 INFO - Reading from file tmpfile_stdout 07:18:01 INFO - Output received: 07:18:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:01 INFO - Running post-action listener: _resource_record_post_action 07:18:01 INFO - ##### 07:18:01 INFO - ##### Finished install step (success) 07:18:01 INFO - ##### 07:18:01 INFO - ##### 07:18:01 INFO - ##### Running run-tests step. 07:18:01 INFO - ##### 07:18:01 INFO - Running pre-action listener: _resource_record_pre_action 07:18:01 INFO - Running main action method: run_tests 07:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:01 INFO - Python 2.7.3 07:18:01 INFO - Return code: 0 07:18:01 INFO - grabbing minidump binary from tooltool 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:01 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 0x125b9c0>, '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 0x125c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:18:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:18:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:18:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:01 INFO - Return code: 0 07:18:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:18:02 INFO - Return code: 0 07:18:02 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/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:18:02 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/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 07:18:02 INFO - Using env: {'DISPLAY': ':0', 07:18:02 INFO - 'HOME': '/home/cltbld', 07:18:02 INFO - 'LANG': 'en_US.UTF-8', 07:18:02 INFO - 'LANGUAGE': 'en_US:en', 07:18:02 INFO - 'LOGNAME': 'cltbld', 07:18:02 INFO - 'MAIL': '/var/mail/cltbld', 07:18:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:02 INFO - 'MOZ_NO_REMOTE': '1', 07:18:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:02 INFO - 'NO_EM_RESTART': '1', 07:18:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:02 INFO - 'PWD': '/builds/slave/test', 07:18:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:02 INFO - 'SHELL': '/bin/bash', 07:18:02 INFO - 'SHLVL': '1', 07:18:02 INFO - 'TERM': 'linux', 07:18:02 INFO - 'TMOUT': '86400', 07:18:02 INFO - 'USER': 'cltbld', 07:18:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256', 07:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:02 INFO - '_': '/tools/buildbot/bin/python'} 07:18:02 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/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:18:02 INFO - mozversion application_buildid: 20160601043021 07:18:02 INFO - mozversion application_changeset: 045cdefdb9410e0ed47cb479d410700d522ca7ba 07:18:02 INFO - mozversion application_display_name: Nightly 07:18:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:02 INFO - mozversion application_name: Firefox 07:18:02 INFO - mozversion application_remotingname: firefox 07:18:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:02 INFO - mozversion application_vendor: Mozilla 07:18:02 INFO - mozversion application_version: 49.0a1 07:18:02 INFO - mozversion platform_buildid: 20160601043021 07:18:02 INFO - mozversion platform_changeset: 045cdefdb9410e0ed47cb479d410700d522ca7ba 07:18:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:02 INFO - mozversion platform_version: 49.0a1 07:18:02 INFO - using testdate: 1464790682 07:18:02 INFO - actual date: 1464790682 07:18:02 INFO - starting webserver on 'localhost:46179' 07:18:02 INFO - SUITE-START | Running 2 tests 07:18:02 INFO - TEST-START | dromaeo_css 07:18:02 INFO - operating with platform_type : linux_ 07:18:02 INFO - Initialising browser for dromaeo_css test... 07:18:02 INFO - TEST-INFO | started process 4800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_rRhW/profile http://localhost:46179/getInfo.html) 07:18:06 INFO - PROCESS | 4800 | __metrics Screen width/height:1600/1200 07:18:06 INFO - PROCESS | 4800 | colorDepth:24 07:18:06 INFO - PROCESS | 4800 | Browser inner width/height: 1024/697 07:18:06 INFO - PROCESS | 4800 | __metrics 07:18:07 ERROR - PROCESS | 4800 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:18:08 INFO - TEST-INFO | 4800: exit 0 07:18:08 INFO - Browser initialized. 07:18:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:08 INFO - TEST-INFO | started process 4882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_rRhW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:20 INFO - PROCESS | 4882 | RSS: Main: 156188672 07:18:20 INFO - PROCESS | 4882 | 07:19:11 INFO - PROCESS | 4882 | 1464790751755 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:21:19 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46179/tests/dromaeo/cssquery-ext.html) 07:21:20 INFO - PROCESS | 4882 | RSS: Main: 247308288 07:21:20 INFO - PROCESS | 4882 | 07:24:22 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-ext.html (next: http://localhost:46179/tests/dromaeo/cssquery-jquery.html) 07:24:23 INFO - PROCESS | 4882 | RSS: Main: 242581504 07:24:23 INFO - PROCESS | 4882 | 07:27:25 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46179/tests/dromaeo/cssquery-mootools.html) 07:27:26 INFO - PROCESS | 4882 | RSS: Main: 242790400 07:27:26 INFO - PROCESS | 4882 | 07:30:28 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46179/tests/dromaeo/cssquery-prototype.html) 07:30:28 INFO - PROCESS | 4882 | RSS: Main: 247898112 07:30:28 INFO - PROCESS | 4882 | 07:33:31 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46179/tests/dromaeo/cssquery-yui.html) 07:33:32 INFO - PROCESS | 4882 | RSS: Main: 208982016 07:33:32 INFO - PROCESS | 4882 | 07:36:34 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:46179/tests/dromaeo/cssquery-yui.html (next: http://localhost:46179/tests/dromaeo/cssquery-dojo.html) 07:36:34 INFO - PROCESS | 4882 | RSS: Main: 285409280 07:36:34 INFO - PROCESS | 4882 | 07:36:34 INFO - PROCESS | 4882 | __start_tp_report 07:36:34 INFO - PROCESS | 4882 | _x_x_mozilla_page_load 07:36:34 INFO - PROCESS | 4882 | _x_x_mozilla_page_load_details 07:36:34 INFO - PROCESS | 4882 | |i|pagename|runs| 07:36:34 INFO - PROCESS | 4882 | |0;dojo.html;3130.968690313096;3143.8585263663135;3173.7143657070865;3198.6961238682316;3220.259340351719;5233.790648374061;5315.335583052119;5324.467553244684;5470.398256191816;5480.068388373976;5355.571554275649;5365.517103460687;5368.436314187013;5399.028174928511;5440.863978400542;4797.999999999991;4934.111859865223;4939.061578300129;4939.333190019337;5115.079285728568;5027.069992051483;5037.168867136918;5080.923786143211;5086.059079070365;5093.159628661267;4803.279508073782;4834;4852.6117910567245;4920.261960705887;4932.975335123338;4867.829625963074;4868.561829435368;4882.096812089775;4887.804487820518;4996.7001979881325;4928.852134435972;4946.752662366867;4953.702777833341;4959.479254678243;4972.5276098770555;5215.687058776485;5241.50205730455;5280.9207861882105;5297.629165958346;5417.349918009824;5788.363280039192;5827.59206855516;5845.736941837585;5848.239728835267;5857.941420585825;5889.116632505158;5890.440408161217;5906.320773111104;5912.083627037816;5917.55618328627;5219.269302297681;5333.653312534711;5361.195820626898;5390.326209223807;5422.3764267109;5985.042393217064;6003.159557661931;6006.159137720722;6006.969965150146;6012.789552365646;5527.336719593674;5772.191893134965;5778.855528611818;5785.103308987113;5793.913091303634;5736.942630573641;5806.390329015477;5806.593538452268;5841.912371314434;5841.9415805842245;5800.535957123504;5813.09896965971;5813.302403711582;5820.650760954356;5820.796272130455;5585.944140558542;5680.630759000652;5758.2514273144225;5816.1566572846705;5820.039693450533;4384.05742765307;4401.889952751143;4406.4051353066925;4436.0906014267;4442.089371678798;3907.081835768592;3923.0780766519847;3924.843006279717;3938.448617193595;3967.6627486663956;5285.894282114336;5398.64908780928;5428.2671839301975;5511.366192887789;5546.694931778791;5792.391798861143;5853.619514731528;5872.324682661463;5874.118882167709;5931.525477961753;5510.889782204334;5515.586331025189;5519.144532597454;5520.171974203901;5528.530074943675;4892.608591312686;4949.257611358253;4967.130752118364;5030.547250747451;5079.3396858408905;6028.186194863725;6033.185519954838;6034.336223015464;6039.396060393926;6067.666278354733;5843.1235314701435;5844.444777746107;5857.619254748428;5858.502027327725;5859.179714840011;5792.478676919098;5926.170336152856;5960.612560183574;5986.4013598639785;6009.158717779427;5683.60214784961;5727.198192253171;5734.655920644775;5738.971305143615;5746.396628353963;5834.649921004753;5845.561582881216;5845.620034697731;5850.795222167204;5851.502622277154;5513.228148059195;5629.437056294338;5631.380548139619;5692.715364231854;5733.741981610921;5690.402507736628;5693.060644993695;5699.686517241592;5703.657780533182;5709.22925405065;5368.624196306221;5545.805896793593;5557.333120025461;5560.19377190297;5562.860928476659;5648.745806438802;5693.117566777156;5730.799422020209;5834;5836.970815145897;5581.079121944996;5581.860453488695;5583.664980101207;5584.972075139598;5627.352854421631 07:36:34 INFO - PROCESS | 4882 | |1;ext.html;630.2248234671354;631.1353445779282;642.7332656947367;645.9321771214026;654.6693919570616;43146.352804707916;45100;45166.77416612912;48252.51747482524;48316.75841620796;43908.341374879405;44417.11165776682;44429.33355999662;44494.11011779762;44538.109237815224;8821.647134114628;8996.77508062297;9010.954945225265;9017.504037277948;9022;8802.07578204289;8887.155720206601;8892.110788921089;8894.155055269739;8901.421407608485;8881.555922203896;8941.239994600433;8946.105389461034;8946.642134314652;8946.910530894706;8824.647014119428;8861.202491775739;8865.734027979106;8894.199522042982;8902.020777714479;8730.86903696445;8812.779680507974;8813.735587932373;8819.470831750052;8821.779455513599;43897.78051109724;44250;44270;44417;44452.777736111115;3408.880689175867;3658.2866341063504;3734.402495600691;4010.8796736097966;4236.216299984513;32264.516032259537;32318.676813231803;32903.506447403306;33225;33413.83293083544;4207.495100587918;4262.381954616594;4263.232618128735;4315.331123675835;4495.595396414338;322449;323487;324962;325935;326279;54897;58039.41960580424;58643;58790.41209587849;58826.705866470395;60901.69549152226;62767.6861615689;62786.37213627805;68431.31568684349;68619.3138068623;16011.359545618045;16278.75581866273;16296.42962496307;16361.509154725378;16383.754243686355;12636;12656.620301390973;12761.042921780903;12762.553310634083;12767.106302558732;16838.747418788727;18035.72946405805;18364.173612187482;18568.535786605175;18576.907115464335;5990.820275391745;6278.121063051177;6288.5598008138995;6350.587211831216;6353.3329000455215;971.5725080964494;1037.968860934173;1066.5787014129376;1146.3351256271342;1159.049579344929;30457.847710761303;32486.67513324884;32880.83559582187;33206.16984575405;33763;1102.5479553383075;1111.0944580167138;1130.4234840231377;1141.8686851012073;1152.7982603044434;17125.828741712674;17313.480595582154;17319.74843270367;17340.393086242173;17368.39210627622;153892;154435;154780;155605;155610.22194888952;58433.41566584365;59740;59755.40244597585;59762.402375976555;59819.70090149521;1347.4408120630026;1359.7620416427283;1385.6535866033491;1387.847336792972;1388.0699931046224;30696.232594185323;32451.675483244864;32544.674553254164;32870.178245544055;32938.67061329356;51615;51894.74052629713;52058.21912671237;52070.479295208075;52090.47909521008;472839;474763;475976;476191;477683;37796.24407511889;39597.40603891001;42514.78742606391;44724.10551789011;44908.10183796371;44494.555054450335;48498.5150148494;48930.5106948926;49318.26022609736;50329.245061323374;38837.2232555353;40930.17218569481;41277.587224128576;41744.582554175286;42594.57405425906;40408.59591404166;40845.79577102095;41145.17709645731;41154.17691646091;41742.165156696086;40925.38611920883;41263.793681031406;41771.373429399195;42118.1576368477;42650.36024459574;34908.47637285494;37190.305475389774;37327.81336093302;37787;37822.243555129295;27880.721192788624;28229.43541129207;28650.840069385184;28675.856620716764;28818.567721483774 07:36:34 INFO - PROCESS | 4882 | |2;jquery.html;400.29348200426244;405.4830091633168;405.7849339849881;406.3295562322168;424.59027038907465;13743.725125497509;18252.817471825278;19724.112414941326;19789;19803.207871685132;15691.529254122366;18060;18819.623607527843;18854.434366969013;18973;5665.915011274824;5823.621464604787;5869.2369991901;5879.941200588003;5881.206037184968;5789.507891829199;5807.912881306784;5808.8838223235725;5844.853878653025;5886.911696324559;5703.57223208259;5746.454086861741;5760.596758226926;5823.621464604808;5841.299044114712;5568.749406276747;5718.885622287573;5733.455321744427;5742.397048309951;5801.100829371433;5087.821926232601;5090.261912022773;5106.106431374495;5107;5122.282880396748;22217;22455.663165052538;23147.884260578758;23272.65091023636;23504.882475587514;2358.714500597179;2422.9636555451684;2510.811689123323;2520.5841036229;2899.405621847516;13604.387802548908;14436.278186090654;14563;14632.41470341185;15328.15695136767;1901.1349835824667;1987.3441764217773;1994.768962510898;2056;2089.1225685212094;79748.60125699392;82691.58654206751;83761;84045;85095.14904850934;10660.41367724767;10689.091427228617;11085.113190944705;11176.27354221973;11425.571803524559;15551;15714.921425393028;15726.21368931549;15735.291911863993;15744.92127539355;7965.522068675898;8110.675572977015;8159.224873636995;8162.591870406456;8249.8350032999;7283.198848126808;7697.343761713141;7749.8450030999065;7864;7885.29032387088;6473.741050358027;6801.319868013258;6897;7079;7139.821504462326;1913.3877159308888;1958.7845337013202;1971.5071232191951;1984.3848406993877;2011.7485314335709;844.4511067805976;980.460746589373;1057.6139709006156;1091.5742860284495;1092.7541303206874;19446.124924378437;19539.80460195408;19969.900150499154;20403;20542.589148216954;1043.7442826507554;1059.8463222832645;1062.0866055192528;1071.5820829876354;1136.2784631758893;10519.631812886511;11706.648800535997;11742.354170520703;11776.646700598996;11777.116716246315;503901;510553;515678;537795;539134;86432.56783716042;87559.56220218858;87607;87988;88037.11962880417;1050.4642632257603;1070.3363914373294;1078.218291738499;1093.8796732359433;1100.5322737836389;17656.646867062842;17726.911365443608;18094.185761640496;18158.81841181571;18474.168662409957;28452.43095138127;28819.423611528073;36051.098722532144;36954.815225923696;40498.59501404948;51391.48608514017;54125.72937135289;54151.458485414645;54193.45806541884;54247;8871.467711937305;8880.600372983361;8994.730158095268;9055.818883622422;9235.953820230856;8912.197902188835;10036.64871729486;13684.31578421055;13829.723405532035;13834.584962451143;11521.251118677259;11939.223950443193;11942.044636428891;11947.283163010246;11988.100892433276;11507.482163302504;11554.94222528882;11670.416479175838;11688.94155529217;11824.940875295568;11788.410579470821;11870.169088163746;12091.879081209076;12198.14612977083;12346.13577049598;7445.218252083453;7903.9209607903185;8128.674853005814;8861.069587693199;9081;10770.946145269538;11587.652370428901;11638.592649257236;11878.406079696153;12007.81988270194 07:36:34 INFO - PROCESS | 4882 | |3;mootools.html;1278.7122897348092;1502.4516051641153;1532.3410933298683;1704.4375356132477;1850.2876392588857;8383;8707.390482666216;8734.956325218373;8756.12438756124;8770.210681038705;8509.659613615464;8676.26251768599;8695.956520217405;8696.47821130731;8699.913000869989;2060.9896950515226;2309.1340747219792;2399.1483023526657;2405.1101092595763;2412.2763171048705;2368.348704106367;2379.357573455166;2380.8928598213124;2382.5473160099527;2387.462820865309;2363.9881800590974;2381.785639292463;2391.6771235883107;2395.700537432821;2398.0527691561824;1998.8201061904426;2221.31139346803;2280.338701776483;2300.2639155470256;2322.756110608387;2314.0628045641542;2328.93013209604;2347.166755801683;2352.5882970480097;2353.976460235393;8809.03100658927;8857.512836793974;8866.556672166365;8871.733847984571;8874.023857375749;5123.820666276662;5252.763625636855;5256.92114618281;5260.736963151865;5264.578833693296;3303.4549299365576;3496.5104885316077;3535.080878971486;3576.9642303576893;3578.8031658258788;1120.9159313051555;1134.217390000905;1166.6208482243305;1166.8016437205695;1172.976540469186;12131.636050918487;12136.514539418413;12172.391380430943;12174.756504869942;12318.5072597096;4557.088582283556;4696.647751418657;4743.1225223333795;4777.044591081798;4778.331033655291;10121.240906931862;10136.239782016231;10142.645007424704;10145.782506099315;10147;5124.000819840096;5188.273641690166;5191.558717509054;5193.350831146106;5195.402528709171;4238.618524332825;4674.929876051862;4788.712677239377;4791.185498465269;4858.198397264412;4054.412110243998;4060.451655989489;4082.5509193988637;4130.834766609302;4145.150244199992;1295.5724610878387;1305.2103477396038;1307.9673008174873;1313.5730887461614;1322.2463195978391;919.1911118215927;991.4844280973854;1006.6225165562914;1009.5961615353917;1012.711377257478;5783.479486846204;5964.373740757244;6062.060380641008;6116.113163591254;6177.722002509898;477.1935429124768;482.43795977686307;493.1443944755846;499.34835040272793;499.8275594919747;3948.822302996372;4081.285774989365;4105.958940410617;4125.91748165035;4174.060836311805;10714;11029.669109926715;11086.445677716081;11104.44477776124;11120.054795342487;10293.948530257301;10893.237473376788;10960.780784384267;10986.780264394667;10999.450027498753;7935.365170786324;8224.547649879314;8267.131951145044;8277.379196560281;8282.792930176673;5888.735006924784;5950.910736339045;5980.312264089685;6042.1540984261355;6049.864466354862;9717.514124293615;10036.447995360326;10150.086492215736;10207.132393746615;10242.334248273839;10160.644377446753;10231.590736370461;10330.638427655296;10339.431331276852;10345.586176552853;7110.4667149965;7614.124375696866;7760.30157285847;7799.688012479437;7905.090914544901;8566.871496927426;8582.613782379683;8633.69782057625;8662.696805611773;8663.436876603;7494.962525187339;7725.768226953201;7821.061472623322;7893.881591776013;7967.920320796949;7589.203133670885;7613.200613935457;7694.692212311445;7735.613219338898;7746.612669366622;7145.82135446618;7190;7197.748078817216;7225.096862892138;7227.096612923385;4884.3650325457465;5035.622328325464;5118.616103792156;5146.202338637517;5173.40505841833;5186.222066690027;5190.532852043334;5192.610554208374;5249.842504724865;5298.2052692096495 07:36:34 INFO - PROCESS | 4882 | |4;prototype.html;315.41490535057466;320.68252430094196;324.07799809541854;331.9784214026089;338.8124623195699;4985.900281994358;5290.523852853243;5304.973475132619;5320.813771517997;5331.92002119968;5214.165733482643;5252.553532949704;5266.605004624659;5304.3634763828395;5308.654937429064;4186.351115577075;4188.39268306097;4204.621584057434;4209.452771139755;4222.282212023963;3892.2020985698005;4096.201240758053;4199.349100889367;4217.40956266123;4224.549761138547;3999.400239904047;4022.356422972325;4066.6340029397347;4074.409210664452;4079.776067179834;4030.7380020298588;4041.6564592009713;4044.4337792709043;4046.190761847642;4087.9795601021806;3584.605693373727;3587.65917237862;3592.167994322888;3593.568771747381;3599.2801439711902;4991.875203119951;5009.298698182258;5064.3163172971545;5075.467075957008;5078.958813443272;4581.129585378767;4581.198290299184;4589.196890544142;4597.54024597541;4640.2343613303765;5410.729463526808;5435.1737096709885;5435.456454354572;5465.152901300305;5473.31583552056;3779.263043706478;3843.9231215375817;3894.2600905828085;3894.8315505348564;3903.902402439933;5387.78448862045;5483.506484416422;5656.830295091154;5657.321121465409;5666.008448521492;3952.3873799561115;3953.604639536081;3956.6942908840015;3968.404739289072;3968.722189446711;3833.50164478616;3928.194720082376;3977.204559088194;3982.7809470478824;4009.8797036088963;4596.2186428306595;4605.976970115128;4606.930896036562;4620.53794620542;4626.86119416418;5426.321709786277;5489.7648029193915;5507.311586051744;5520.282363292827;5529.585281103853;1366.125679565079;1366.349282392156;1411.7882317652434;1413.4558195094962;1414.8231471066117;861.1818772166467;863.7322430046705;875.8292133033997;882.92495137914;890.2744263425287;4793.760311984387;4803;4809.687370320918;4829.492903245179;4835.28347436662;5101.5408613224245;5102.897942041139;5115.590752739772;5144.356955380577;5148.768305426265;4475.216837053567;4804.639652026112;4805.693267231748;4814.542618451242;4846.903061938812;2642.775364094035;2645.20643806861;2722.7883591801856;2732.7540521353176;2739.821911575741;5143.379835351852;5155.252488389237;5159.458256883048;5159.638825282194;5160.522948984433;4667.696599721007;5046.722430266371;5073.543381095719;5093.2360145977655;5112.821051263262;5096.770645320969;5100.336956195745;5141.203113517411;5155.407128180307;5199.376074871039;5066.265391518135;5067.746612669425;5101.974490127525;5108.233764935289;5480.643758155867;5394.973025134849;5558.388577256579;5571.832845014656;5600.8716687658425;5631.831045068655;5750.971245143747;5753.827385178452;5761.769529218952;5786.218860453785;5792;3872.225554888977;3970.642642162219;3973.841046358229;3988.900277493086;3999.5200575931076;5535.557155427476;5567.972160139336;5584.664920104807;5587;5639.351474580476;5433.402325744244;5447.564194864322;5470.72646367688;5480.479354461319;5492.313460817398;5269.499397557226;5449.918251226314;5532.91700624499;5552.250446189874;5564.276644036249;5309.973450132725;5372.689743410371;5389.83830485086;5410.3507579090765;5411.702356370437;5339.492748188916;5532.1701744737;5567.582431317748;5571.9721401392735;5610.607257491936;5449.7275136243825;5458.836234912959;5472.604485856081;5480.287562616834;5482.150266708666 07:36:34 INFO - PROCESS | 4882 | |5;yui.html;675.2336098528169;676.8003438985498;714.8847797435997;767.4052609227848;789.6880732110816;15044.849551504496;15373.615659608515;15561.066336019847;16185.19074046296;16773.496795096136;15371.769423458629;15489.148096854697;15489.612759681013;15509;15524.223788810543;695.9025736396909;791.9643616037292;817.8936738224022;823.5058964621239;824.8721448175543;821.6795449774593;824.1840577827967;827.9254867061964;828.4615000249855;828.8135169586825;856.8671855862351;862.8576284912982;862.9741107766777;863.6459051788768;863.7840539865034;721.6463932673005;815.09524427885;838.9203025712609;857.7255278310943;859.8710193470998;614.3181069013392;614.6895817612077;615.698307829165;616.0482055224688;616.303576958039;14143.575692729235;14248.073875198079;14249.145051296955;14264.215468149248;14270.215138167398;12393.814092788616;12873.87126128736;13028.739425211537;13110.213387196798;13207.669808254774;12355.93822030884;12626.81059784104;12753.936230318788;12821.102522823407;13270;4293.57359272843;4301.634361079312;4401.119776044772;4415.359772832953;4420.889477763049;51827.74086129621;59777.7011114946;59893;60150.699246503485;60771.08843367353;10811.35131892089;10943.4528273586;10978.286411383235;11227.208766204618;11240.38177900207;19574.314898978468;19579.16102165178;19587.412377628694;19607.509812254808;19615.705764413546;8522.957385213034;8657.653693852175;8682;8791.912080879109;8886.289096872235;4574.268117101248;4680.157571637138;4724.314974328703;4773.641976851681;4833.10587541306;3488.947665785015;3606.6032736398975;3623.8912832614537;3624.4382120771324;3625.818709064589;638.2341190571241;646.9385408386196;651.3616655677463;652.6114421218318;668.358375959075;592.523018969725;708.0830324729385;769.8960640313599;770.7995921060565;777.1956025513566;9419.929109084387;9433.858492122623;9437.622495100257;9490.335676502717;9564.90435095654;579.939106393831;610.0330975404034;688.6728803818146;724.2669157058597;745.198911170494;4481.955180448219;4518.728876267434;4609.723416595015;4711.104890070876;4820.301056346881;68953.3104668957;70573.64713176401;72035;72240.63879680673;73527;55370.44629553653;60379.056408512704;61677.38322616716;62708.686456568335;66478.66760666262;55815.16277255845;55861.72069139628;56048.719756400955;56170;56730.43269567334;8840.557972101498;8972.28221742272;9038.728838134866;9070.954645226731;9084.772880678036;17330.826691733426;17387.56531086733;17413;29174;38742.963414755905;47535.286970694775;51935.74032129815;52157;52161.47838521566;52564.73717631387;10519.78960420772;10798.622048228275;10963.122950163808;11301.378424186749;11728.41357932083;11424.257423267461;11537;12057.638270851889;12594.87405125937;13002.154859934075;10935.507902144263;11427.085833133495;12427.378631068592;12488.687782805502;12525.749485010067;12166.45250963691;12285.324307163191;12633.17884337552;12651.304178270284;12671.113022088733;11867.58463453775;11891.227070240408;12220.694482638006;12264.693382665504;12617.179883307555;9481.478518681539;9601.32790704672;9725.67711824439;9911.504424778876;10450.111740502143;9474.621015159317;10103.797924041331;10131.949340253252;10196.3372380795;10201.438920859424 07:36:35 INFO - PROCESS | 4882 | __end_tp_report 07:36:35 INFO - PROCESS | 4882 | __start_cc_report 07:36:35 INFO - PROCESS | 4882 | _x_x_mozilla_cycle_collect,954 07:36:35 INFO - PROCESS | 4882 | __end_cc_report 07:36:35 INFO - PROCESS | 4882 | __startTimestamp1464791794986__endTimestamp 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | ------- Summary: start ------- 07:36:35 INFO - PROCESS | 4882 | Number of tests: 6 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#0] dojo.html Cycles:165 Average:5389.75 Median:5581.08 stddev:618.24 (11.1%) stddev-sans-first:594.20 07:36:35 INFO - PROCESS | 4882 | Values: 3131.0 3143.9 3173.7 3198.7 3220.3 5233.8 5315.3 5324.5 5470.4 5480.1 5355.6 5365.5 5368.4 5399.0 5440.9 4798.0 4934.1 4939.1 4939.3 5115.1 5027.1 5037.2 5080.9 5086.1 5093.2 4803.3 4834.0 4852.6 4920.3 4933.0 4867.8 4868.6 4882.1 4887.8 4996.7 4928.9 4946.8 4953.7 4959.5 4972.5 5215.7 5241.5 5280.9 5297.6 5417.3 5788.4 5827.6 5845.7 5848.2 5857.9 5889.1 5890.4 5906.3 5912.1 5917.6 5219.3 5333.7 5361.2 5390.3 5422.4 5985.0 6003.2 6006.2 6007.0 6012.8 5527.3 5772.2 5778.9 5785.1 5793.9 5736.9 5806.4 5806.6 5841.9 5841.9 5800.5 5813.1 5813.3 5820.7 5820.8 5585.9 5680.6 5758.3 5816.2 5820.0 4384.1 4401.9 4406.4 4436.1 4442.1 3907.1 3923.1 3924.8 3938.4 3967.7 5285.9 5398.6 5428.3 5511.4 5546.7 5792.4 5853.6 5872.3 5874.1 5931.5 5510.9 5515.6 5519.1 5520.2 5528.5 4892.6 4949.3 4967.1 5030.5 5079.3 6028.2 6033.2 6034.3 6039.4 6067.7 5843.1 5844.4 5857.6 5858.5 5859.2 5792.5 5926.2 5960.6 5986.4 6009.2 5683.6 5727.2 5734.7 5739.0 5746.4 5834.6 5845.6 5845.6 5850.8 5851.5 5513.2 5629.4 5631.4 5692.7 5733.7 5690.4 5693.1 5699.7 5703.7 5709.2 5368.6 5545.8 5557.3 5560.2 5562.9 5648.7 5693.1 5730.8 5834.0 5837.0 5581.1 5581.9 5583.7 5585.0 5627.4 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#1] ext.html Cycles:180 Average:50783.83 Median:42554.68 stddev:91320.71 (214.6%) stddev-sans-first:91499.25 07:36:35 INFO - PROCESS | 4882 | Values: 630.2 631.1 642.7 645.9 654.7 43146.4 45100.0 45166.8 48252.5 48316.8 43908.3 44417.1 44429.3 44494.1 44538.1 8821.6 8996.8 9011.0 9017.5 9022.0 8802.1 8887.2 8892.1 8894.2 8901.4 8881.6 8941.2 8946.1 8946.6 8946.9 8824.6 8861.2 8865.7 8894.2 8902.0 8730.9 8812.8 8813.7 8819.5 8821.8 43897.8 44250.0 44270.0 44417.0 44452.8 3408.9 3658.3 3734.4 4010.9 4236.2 32264.5 32318.7 32903.5 33225.0 33413.8 4207.5 4262.4 4263.2 4315.3 4495.6 322449.0 323487.0 324962.0 325935.0 326279.0 54897.0 58039.4 58643.0 58790.4 58826.7 60901.7 62767.7 62786.4 68431.3 68619.3 16011.4 16278.8 16296.4 16361.5 16383.8 12636.0 12656.6 12761.0 12762.6 12767.1 16838.7 18035.7 18364.2 18568.5 18576.9 5990.8 6278.1 6288.6 6350.6 6353.3 971.6 1038.0 1066.6 1146.3 1159.0 30457.8 32486.7 32880.8 33206.2 33763.0 1102.5 1111.1 1130.4 1141.9 1152.8 17125.8 17313.5 17319.7 17340.4 17368.4 153892.0 154435.0 154780.0 155605.0 155610.2 58433.4 59740.0 59755.4 59762.4 59819.7 1347.4 1359.8 1385.7 1387.8 1388.1 30696.2 32451.7 32544.7 32870.2 32938.7 51615.0 51894.7 52058.2 52070.5 52090.5 472839.0 474763.0 475976.0 476191.0 477683.0 37796.2 39597.4 42514.8 44724.1 44908.1 44494.6 48498.5 48930.5 49318.3 50329.2 38837.2 40930.2 41277.6 41744.6 42594.6 40408.6 40845.8 41145.2 41154.2 41742.2 40925.4 41263.8 41771.4 42118.2 42650.4 34908.5 37190.3 37327.8 37787.0 37822.2 27880.7 28229.4 28650.8 28675.9 28818.6 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#2] jquery.html Cycles:180 Average:29647.42 Median:23388.77 stddev:85694.89 (366.4%) stddev-sans-first:85907.14 07:36:35 INFO - PROCESS | 4882 | Values: 400.3 405.5 405.8 406.3 424.6 13743.7 18252.8 19724.1 19789.0 19803.2 15691.5 18060.0 18819.6 18854.4 18973.0 5665.9 5823.6 5869.2 5879.9 5881.2 5789.5 5807.9 5808.9 5844.9 5886.9 5703.6 5746.5 5760.6 5823.6 5841.3 5568.7 5718.9 5733.5 5742.4 5801.1 5087.8 5090.3 5106.1 5107.0 5122.3 22217.0 22455.7 23147.9 23272.7 23504.9 2358.7 2423.0 2510.8 2520.6 2899.4 13604.4 14436.3 14563.0 14632.4 15328.2 1901.1 1987.3 1994.8 2056.0 2089.1 79748.6 82691.6 83761.0 84045.0 85095.1 10660.4 10689.1 11085.1 11176.3 11425.6 15551.0 15714.9 15726.2 15735.3 15744.9 7965.5 8110.7 8159.2 8162.6 8249.8 7283.2 7697.3 7749.8 7864.0 7885.3 6473.7 6801.3 6897.0 7079.0 7139.8 1913.4 1958.8 1971.5 1984.4 2011.7 844.5 980.5 1057.6 1091.6 1092.8 19446.1 19539.8 19969.9 20403.0 20542.6 1043.7 1059.8 1062.1 1071.6 1136.3 10519.6 11706.6 11742.4 11776.6 11777.1 503901.0 510553.0 515678.0 537795.0 539134.0 86432.6 87559.6 87607.0 87988.0 88037.1 1050.5 1070.3 1078.2 1093.9 1100.5 17656.6 17726.9 18094.2 18158.8 18474.2 28452.4 28819.4 36051.1 36954.8 40498.6 51391.5 54125.7 54151.5 54193.5 54247.0 8871.5 8880.6 8994.7 9055.8 9236.0 8912.2 10036.6 13684.3 13829.7 13834.6 11521.3 11939.2 11942.0 11947.3 11988.1 11507.5 11554.9 11670.4 11688.9 11824.9 11788.4 11870.2 12091.9 12198.1 12346.1 7445.2 7903.9 8128.7 8861.1 9081.0 10770.9 11587.7 11638.6 11878.4 12007.8 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#3] mootools.html Cycles:180 Average:5798.28 Median:4719.89 stddev:3298.62 (69.9%) stddev-sans-first:3290.38 07:36:35 INFO - PROCESS | 4882 | Values: 1278.7 1502.5 1532.3 1704.4 1850.3 8383.0 8707.4 8735.0 8756.1 8770.2 8509.7 8676.3 8696.0 8696.5 8699.9 2061.0 2309.1 2399.1 2405.1 2412.3 2368.3 2379.4 2380.9 2382.5 2387.5 2364.0 2381.8 2391.7 2395.7 2398.1 1998.8 2221.3 2280.3 2300.3 2322.8 2314.1 2328.9 2347.2 2352.6 2354.0 8809.0 8857.5 8866.6 8871.7 8874.0 5123.8 5252.8 5256.9 5260.7 5264.6 3303.5 3496.5 3535.1 3577.0 3578.8 1120.9 1134.2 1166.6 1166.8 1173.0 12131.6 12136.5 12172.4 12174.8 12318.5 4557.1 4696.6 4743.1 4777.0 4778.3 10121.2 10136.2 10142.6 10145.8 10147.0 5124.0 5188.3 5191.6 5193.4 5195.4 4238.6 4674.9 4788.7 4791.2 4858.2 4054.4 4060.5 4082.6 4130.8 4145.2 1295.6 1305.2 1308.0 1313.6 1322.2 919.2 991.5 1006.6 1009.6 1012.7 5783.5 5964.4 6062.1 6116.1 6177.7 477.2 482.4 493.1 499.3 499.8 3948.8 4081.3 4106.0 4125.9 4174.1 10714.0 11029.7 11086.4 11104.4 11120.1 10293.9 10893.2 10960.8 10986.8 10999.5 7935.4 8224.5 8267.1 8277.4 8282.8 5888.7 5950.9 5980.3 6042.2 6049.9 9717.5 10036.4 10150.1 10207.1 10242.3 10160.6 10231.6 10330.6 10339.4 10345.6 7110.5 7614.1 7760.3 7799.7 7905.1 8566.9 8582.6 8633.7 8662.7 8663.4 7495.0 7725.8 7821.1 7893.9 7967.9 7589.2 7613.2 7694.7 7735.6 7746.6 7145.8 7190.0 7197.7 7225.1 7227.1 4884.4 5035.6 5118.6 5146.2 5173.4 5186.2 5190.5 5192.6 5249.8 5298.2 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#4] prototype.html Cycles:180 Average:4491.04 Median:5086.10 stddev:1310.45 (25.8%) stddev-sans-first:1276.10 07:36:35 INFO - PROCESS | 4882 | Values: 315.4 320.7 324.1 332.0 338.8 4985.9 5290.5 5305.0 5320.8 5331.9 5214.2 5252.6 5266.6 5304.4 5308.7 4186.4 4188.4 4204.6 4209.5 4222.3 3892.2 4096.2 4199.3 4217.4 4224.5 3999.4 4022.4 4066.6 4074.4 4079.8 4030.7 4041.7 4044.4 4046.2 4088.0 3584.6 3587.7 3592.2 3593.6 3599.3 4991.9 5009.3 5064.3 5075.5 5079.0 4581.1 4581.2 4589.2 4597.5 4640.2 5410.7 5435.2 5435.5 5465.2 5473.3 3779.3 3843.9 3894.3 3894.8 3903.9 5387.8 5483.5 5656.8 5657.3 5666.0 3952.4 3953.6 3956.7 3968.4 3968.7 3833.5 3928.2 3977.2 3982.8 4009.9 4596.2 4606.0 4606.9 4620.5 4626.9 5426.3 5489.8 5507.3 5520.3 5529.6 1366.1 1366.3 1411.8 1413.5 1414.8 861.2 863.7 875.8 882.9 890.3 4793.8 4803.0 4809.7 4829.5 4835.3 5101.5 5102.9 5115.6 5144.4 5148.8 4475.2 4804.6 4805.7 4814.5 4846.9 2642.8 2645.2 2722.8 2732.8 2739.8 5143.4 5155.3 5159.5 5159.6 5160.5 4667.7 5046.7 5073.5 5093.2 5112.8 5096.8 5100.3 5141.2 5155.4 5199.4 5066.3 5067.7 5102.0 5108.2 5480.6 5395.0 5558.4 5571.8 5600.9 5631.8 5751.0 5753.8 5761.8 5786.2 5792.0 3872.2 3970.6 3973.8 3988.9 3999.5 5535.6 5568.0 5584.7 5587.0 5639.4 5433.4 5447.6 5470.7 5480.5 5492.3 5269.5 5449.9 5532.9 5552.3 5564.3 5310.0 5372.7 5389.8 5410.4 5411.7 5339.5 5532.2 5567.6 5572.0 5610.6 5449.7 5458.8 5472.6 5480.3 5482.2 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - PROCESS | 4882 | [#5] yui.html Cycles:180 Average:15425.63 Median:28330.42 stddev:19021.06 (67.1%) stddev-sans-first:19042.16 07:36:35 INFO - PROCESS | 4882 | Values: 675.2 676.8 714.9 767.4 789.7 15044.8 15373.6 15561.1 16185.2 16773.5 15371.8 15489.1 15489.6 15509.0 15524.2 695.9 792.0 817.9 823.5 824.9 821.7 824.2 827.9 828.5 828.8 856.9 862.9 863.0 863.6 863.8 721.6 815.1 838.9 857.7 859.9 614.3 614.7 615.7 616.0 616.3 14143.6 14248.1 14249.1 14264.2 14270.2 12393.8 12873.9 13028.7 13110.2 13207.7 12355.9 12626.8 12753.9 12821.1 13270.0 4293.6 4301.6 4401.1 4415.4 4420.9 51827.7 59777.7 59893.0 60150.7 60771.1 10811.4 10943.5 10978.3 11227.2 11240.4 19574.3 19579.2 19587.4 19607.5 19615.7 8523.0 8657.7 8682.0 8791.9 8886.3 4574.3 4680.2 4724.3 4773.6 4833.1 3488.9 3606.6 3623.9 3624.4 3625.8 638.2 646.9 651.4 652.6 668.4 592.5 708.1 769.9 770.8 777.2 9419.9 9433.9 9437.6 9490.3 9564.9 579.9 610.0 688.7 724.3 745.2 4482.0 4518.7 4609.7 4711.1 4820.3 68953.3 70573.6 72035.0 72240.6 73527.0 55370.4 60379.1 61677.4 62708.7 66478.7 55815.2 55861.7 56048.7 56170.0 56730.4 8840.6 8972.3 9038.7 9071.0 9084.8 17330.8 17387.6 17413.0 29174.0 38743.0 47535.3 51935.7 52157.0 52161.5 52564.7 10519.8 10798.6 10963.1 11301.4 11728.4 11424.3 11537.0 12057.6 12594.9 13002.2 10935.5 11427.1 12427.4 12488.7 12525.7 12166.5 12285.3 12633.2 12651.3 12671.1 11867.6 11891.2 12220.7 12264.7 12617.2 9481.5 9601.3 9725.7 9911.5 10450.1 9474.6 10103.8 10131.9 10196.3 10201.4 07:36:35 INFO - PROCESS | 4882 | -------- Summary: end -------- 07:36:35 INFO - PROCESS | 4882 | 07:36:35 INFO - TEST-INFO | 4882: exit 0 07:36:35 INFO - TEST-OK | dromaeo_css | took 1112887ms 07:36:35 INFO - TEST-START | kraken 07:36:35 INFO - operating with platform_type : linux_ 07:36:35 INFO - Initialising browser for kraken test... 07:36:35 INFO - TEST-INFO | started process 5065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrIVeG/profile http://localhost:46179/getInfo.html) 07:36:39 INFO - PROCESS | 5065 | __metrics Screen width/height:1600/1200 07:36:39 INFO - PROCESS | 5065 | colorDepth:24 07:36:39 INFO - PROCESS | 5065 | Browser inner width/height: 1024/697 07:36:39 INFO - PROCESS | 5065 | __metrics 07:36:40 ERROR - PROCESS | 5065 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:36:41 INFO - TEST-INFO | 5065: exit 0 07:36:41 INFO - Browser initialized. 07:36:41 INFO - Running cycle 1/1 for kraken test... 07:36:41 INFO - TEST-INFO | started process 5145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrIVeG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:53 INFO - PROCESS | 5145 | RSS: Main: 155934720 07:36:53 INFO - PROCESS | 5145 | 07:36:55 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46179/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:56 INFO - PROCESS | 5145 | RSS: Main: 214040576 07:36:56 INFO - PROCESS | 5145 | 07:36:59 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46179/tests/kraken/driver.html?testName=audio-dft) 07:37:00 INFO - PROCESS | 5145 | RSS: Main: 198328320 07:37:00 INFO - PROCESS | 5145 | 07:37:03 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46179/tests/kraken/driver.html?testName=audio-fft) 07:37:03 INFO - PROCESS | 5145 | RSS: Main: 268218368 07:37:03 INFO - PROCESS | 5145 | 07:37:06 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46179/tests/kraken/driver.html?testName=audio-oscillator) 07:37:06 INFO - PROCESS | 5145 | RSS: Main: 178987008 07:37:06 INFO - PROCESS | 5145 | 07:37:08 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:09 INFO - PROCESS | 5145 | RSS: Main: 183787520 07:37:09 INFO - PROCESS | 5145 | 07:37:12 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46179/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:13 INFO - PROCESS | 5145 | RSS: Main: 219414528 07:37:13 INFO - PROCESS | 5145 | 07:37:16 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46179/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:17 INFO - PROCESS | 5145 | RSS: Main: 220213248 07:37:17 INFO - PROCESS | 5145 | 07:37:19 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46179/tests/kraken/driver.html?testName=json-parse-financial) 07:37:20 INFO - PROCESS | 5145 | RSS: Main: 220545024 07:37:20 INFO - PROCESS | 5145 | 07:37:21 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:22 INFO - PROCESS | 5145 | RSS: Main: 207892480 07:37:22 INFO - PROCESS | 5145 | 07:37:24 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:24 INFO - PROCESS | 5145 | RSS: Main: 211976192 07:37:24 INFO - PROCESS | 5145 | 07:37:27 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:27 INFO - PROCESS | 5145 | RSS: Main: 217608192 07:37:27 INFO - PROCESS | 5145 | 07:37:30 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:30 INFO - PROCESS | 5145 | RSS: Main: 222601216 07:37:30 INFO - PROCESS | 5145 | 07:37:33 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:34 INFO - PROCESS | 5145 | RSS: Main: 223031296 07:37:34 INFO - PROCESS | 5145 | 07:37:35 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:46179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46179/tests/kraken/driver.html?testName=ai-astar) 07:37:36 INFO - PROCESS | 5145 | RSS: Main: 265228288 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | __start_tp_report 07:37:36 INFO - PROCESS | 5145 | _x_x_mozilla_page_load 07:37:36 INFO - PROCESS | 5145 | _x_x_mozilla_page_load_details 07:37:36 INFO - PROCESS | 5145 | |i|pagename|runs| 07:37:36 INFO - PROCESS | 5145 | |0;ai-astar;111;104;110;111;110;111;110;109;109;119 07:37:36 INFO - PROCESS | 5145 | |1;audio-beat-detection;154;129;127;191;125;129;163;124;167;130 07:37:36 INFO - PROCESS | 5145 | |2;audio-dft;163;161;160;162;164;159;160;161;161;161 07:37:36 INFO - PROCESS | 5145 | |3;audio-fft;75;73;76;126;76;75;75;73;97;75 07:37:36 INFO - PROCESS | 5145 | |4;audio-oscillator;84;84;114;84;83;83;125;83;83;133 07:37:36 INFO - PROCESS | 5145 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 07:37:36 INFO - PROCESS | 5145 | |6;imaging-darkroom;145;147;146;146;155;145;145;146;146;145 07:37:36 INFO - PROCESS | 5145 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 07:37:36 INFO - PROCESS | 5145 | |8;json-parse-financial;54;53;54;53;54;53;55;53;53;55 07:37:36 INFO - PROCESS | 5145 | |9;json-stringify-tinderbox;61;69;61;62;60;61;61;62;62;63 07:37:36 INFO - PROCESS | 5145 | |10;stanford-crypto-aes;79;80;80;80;83;81;81;82;113;81 07:37:36 INFO - PROCESS | 5145 | |11;stanford-crypto-ccm;132;131;137;126;129;129;123;126;125;125 07:37:36 INFO - PROCESS | 5145 | |12;stanford-crypto-pbkdf2;167;168;166;163;167;166;161;168;163;161 07:37:36 INFO - PROCESS | 5145 | |13;stanford-crypto-sha256-iterative;63;62;67;64;63;63;64;62;63;61 07:37:36 INFO - PROCESS | 5145 | __end_tp_report 07:37:36 INFO - PROCESS | 5145 | __start_cc_report 07:37:36 INFO - PROCESS | 5145 | _x_x_mozilla_cycle_collect,1630 07:37:36 INFO - PROCESS | 5145 | __end_cc_report 07:37:36 INFO - PROCESS | 5145 | __startTimestamp1464791856204__endTimestamp 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | ------- Summary: start ------- 07:37:36 INFO - PROCESS | 5145 | Number of tests: 14 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:3.66 (3.3%) stddev-sans-first:3.87 07:37:36 INFO - PROCESS | 5145 | Values: 111.0 104.0 110.0 111.0 110.0 111.0 110.0 109.0 109.0 119.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:142.00 stddev:23.32 (16.4%) stddev-sans-first:24.45 07:37:36 INFO - PROCESS | 5145 | Values: 154.0 129.0 127.0 191.0 125.0 129.0 163.0 124.0 167.0 130.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 07:37:36 INFO - PROCESS | 5145 | Values: 163.0 161.0 160.0 162.0 164.0 159.0 160.0 161.0 161.0 161.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:16.97 (22.6%) stddev-sans-first:17.80 07:37:36 INFO - PROCESS | 5145 | Values: 75.0 73.0 76.0 126.0 76.0 75.0 75.0 73.0 97.0 75.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.00 stddev:20.11 (24.2%) stddev-sans-first:20.89 07:37:36 INFO - PROCESS | 5145 | Values: 84.0 84.0 114.0 84.0 83.0 83.0 125.0 83.0 83.0 133.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:37:36 INFO - PROCESS | 5145 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:3.03 (2.1%) stddev-sans-first:3.15 07:37:36 INFO - PROCESS | 5145 | Values: 145.0 147.0 146.0 146.0 155.0 145.0 145.0 146.0 146.0 145.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:37:36 INFO - PROCESS | 5145 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 07:37:36 INFO - PROCESS | 5145 | Values: 54.0 53.0 54.0 53.0 54.0 53.0 55.0 53.0 53.0 55.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:2.53 (4.1%) stddev-sans-first:2.65 07:37:36 INFO - PROCESS | 5145 | Values: 61.0 69.0 61.0 62.0 60.0 61.0 61.0 62.0 62.0 63.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:10.25 (12.7%) stddev-sans-first:10.71 07:37:36 INFO - PROCESS | 5145 | Values: 79.0 80.0 80.0 80.0 83.0 81.0 81.0 82.0 113.0 81.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:129.00 stddev:4.19 (3.2%) stddev-sans-first:4.23 07:37:36 INFO - PROCESS | 5145 | Values: 132.0 131.0 137.0 126.0 129.0 129.0 123.0 126.0 125.0 125.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.50 stddev:2.75 (1.7%) stddev-sans-first:2.82 07:37:36 INFO - PROCESS | 5145 | Values: 167.0 168.0 166.0 163.0 167.0 166.0 161.0 168.0 163.0 161.0 07:37:36 INFO - PROCESS | 5145 | 07:37:36 INFO - PROCESS | 5145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:1.72 07:37:36 INFO - PROCESS | 5145 | Values: 63.0 62.0 67.0 64.0 63.0 63.0 64.0 62.0 63.0 61.0 07:37:36 INFO - PROCESS | 5145 | -------- Summary: end -------- 07:37:36 INFO - PROCESS | 5145 | 07:37:37 INFO - TEST-INFO | 5145: exit 0 07:37:37 INFO - TEST-OK | kraken | took 61447ms 07:37:37 INFO - SUITE-END | took 1174s 07:37:37 INFO - Completed test suite (00:19:34) 07:37:37 INFO - javascript benchmark 07:37:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.968690313096, 3143.8585263663135, 3173.7143657070865, 3198.6961238682316, 3220.259340351719, 5233.790648374061, 5315.335583052119, 5324.467553244684, 5470.398256191816, 5480.068388373976, 5355.571554275649, 5365.517103460687, 5368.436314187013, 5399.028174928511, 5440.863978400542, 4797.999999999991, 4934.111859865223, 4939.061578300129, 4939.333190019337, 5115.079285728568, 5027.069992051483, 5037.168867136918, 5080.923786143211, 5086.059079070365, 5093.159628661267, 4803.279508073782, 4834.0, 4852.6117910567245, 4920.261960705887, 4932.975335123338, 4867.829625963074, 4868.561829435368, 4882.096812089775, 4887.804487820518, 4996.7001979881325, 4928.852134435972, 4946.752662366867, 4953.702777833341, 4959.479254678243, 4972.5276098770555, 5215.687058776485, 5241.50205730455, 5280.9207861882105, 5297.629165958346, 5417.349918009824, 5788.363280039192, 5827.59206855516, 5845.736941837585, 5848.239728835267, 5857.941420585825, 5889.116632505158, 5890.440408161217, 5906.320773111104, 5912.083627037816, 5917.55618328627, 5219.269302297681, 5333.653312534711, 5361.195820626898, 5390.326209223807, 5422.3764267109, 5985.042393217064, 6003.159557661931, 6006.159137720722, 6006.969965150146, 6012.789552365646, 5527.336719593674, 5772.191893134965, 5778.855528611818, 5785.103308987113, 5793.913091303634, 5736.942630573641, 5806.390329015477, 5806.593538452268, 5841.912371314434, 5841.9415805842245, 5800.535957123504, 5813.09896965971, 5813.302403711582, 5820.650760954356, 5820.796272130455, 5585.944140558542, 5680.630759000652, 5758.2514273144225, 5816.1566572846705, 5820.039693450533, 4384.05742765307, 4401.889952751143, 4406.4051353066925, 4436.0906014267, 4442.089371678798, 3907.081835768592, 3923.0780766519847, 3924.843006279717, 3938.448617193595, 3967.6627486663956, 5285.894282114336, 5398.64908780928, 5428.2671839301975, 5511.366192887789, 5546.694931778791, 5792.391798861143, 5853.619514731528, 5872.324682661463, 5874.118882167709, 5931.525477961753, 5510.889782204334, 5515.586331025189, 5519.144532597454, 5520.171974203901, 5528.530074943675, 4892.608591312686, 4949.257611358253, 4967.130752118364, 5030.547250747451, 5079.3396858408905, 6028.186194863725, 6033.185519954838, 6034.336223015464, 6039.396060393926, 6067.666278354733, 5843.1235314701435, 5844.444777746107, 5857.619254748428, 5858.502027327725, 5859.179714840011, 5792.478676919098, 5926.170336152856, 5960.612560183574, 5986.4013598639785, 6009.158717779427, 5683.60214784961, 5727.198192253171, 5734.655920644775, 5738.971305143615, 5746.396628353963, 5834.649921004753, 5845.561582881216, 5845.620034697731, 5850.795222167204, 5851.502622277154, 5513.228148059195, 5629.437056294338, 5631.380548139619, 5692.715364231854, 5733.741981610921, 5690.402507736628, 5693.060644993695, 5699.686517241592, 5703.657780533182, 5709.22925405065, 5368.624196306221, 5545.805896793593, 5557.333120025461, 5560.19377190297, 5562.860928476659, 5648.745806438802, 5693.117566777156, 5730.799422020209, 5834.0, 5836.970815145897, 5581.079121944996, 5581.860453488695, 5583.664980101207, 5584.972075139598, 5627.352854421631], "value": 5347.994321303088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.2248234671354, 631.1353445779282, 642.7332656947367, 645.9321771214026, 654.6693919570616, 43146.352804707916, 45100.0, 45166.77416612912, 48252.51747482524, 48316.75841620796, 43908.341374879405, 44417.11165776682, 44429.33355999662, 44494.11011779762, 44538.109237815224, 8821.647134114628, 8996.77508062297, 9010.954945225265, 9017.504037277948, 9022.0, 8802.07578204289, 8887.155720206601, 8892.110788921089, 8894.155055269739, 8901.421407608485, 8881.555922203896, 8941.239994600433, 8946.105389461034, 8946.642134314652, 8946.910530894706, 8824.647014119428, 8861.202491775739, 8865.734027979106, 8894.199522042982, 8902.020777714479, 8730.86903696445, 8812.779680507974, 8813.735587932373, 8819.470831750052, 8821.779455513599, 43897.78051109724, 44250.0, 44270.0, 44417.0, 44452.777736111115, 3408.880689175867, 3658.2866341063504, 3734.402495600691, 4010.8796736097966, 4236.216299984513, 32264.516032259537, 32318.676813231803, 32903.506447403306, 33225.0, 33413.83293083544, 4207.495100587918, 4262.381954616594, 4263.232618128735, 4315.331123675835, 4495.595396414338, 322449.0, 323487.0, 324962.0, 325935.0, 326279.0, 54897.0, 58039.41960580424, 58643.0, 58790.41209587849, 58826.705866470395, 60901.69549152226, 62767.6861615689, 62786.37213627805, 68431.31568684349, 68619.3138068623, 16011.359545618045, 16278.75581866273, 16296.42962496307, 16361.509154725378, 16383.754243686355, 12636.0, 12656.620301390973, 12761.042921780903, 12762.553310634083, 12767.106302558732, 16838.747418788727, 18035.72946405805, 18364.173612187482, 18568.535786605175, 18576.907115464335, 5990.820275391745, 6278.121063051177, 6288.5598008138995, 6350.587211831216, 6353.3329000455215, 971.5725080964494, 1037.968860934173, 1066.5787014129376, 1146.3351256271342, 1159.049579344929, 30457.847710761303, 32486.67513324884, 32880.83559582187, 33206.16984575405, 33763.0, 1102.5479553383075, 1111.0944580167138, 1130.4234840231377, 1141.8686851012073, 1152.7982603044434, 17125.828741712674, 17313.480595582154, 17319.74843270367, 17340.393086242173, 17368.39210627622, 153892.0, 154435.0, 154780.0, 155605.0, 155610.22194888952, 58433.41566584365, 59740.0, 59755.40244597585, 59762.402375976555, 59819.70090149521, 1347.4408120630026, 1359.7620416427283, 1385.6535866033491, 1387.847336792972, 1388.0699931046224, 30696.232594185323, 32451.675483244864, 32544.674553254164, 32870.178245544055, 32938.67061329356, 51615.0, 51894.74052629713, 52058.21912671237, 52070.479295208075, 52090.47909521008, 472839.0, 474763.0, 475976.0, 476191.0, 477683.0, 37796.24407511889, 39597.40603891001, 42514.78742606391, 44724.10551789011, 44908.10183796371, 44494.555054450335, 48498.5150148494, 48930.5106948926, 49318.26022609736, 50329.245061323374, 38837.2232555353, 40930.17218569481, 41277.587224128576, 41744.582554175286, 42594.57405425906, 40408.59591404166, 40845.79577102095, 41145.17709645731, 41154.17691646091, 41742.165156696086, 40925.38611920883, 41263.793681031406, 41771.373429399195, 42118.1576368477, 42650.36024459574, 34908.47637285494, 37190.305475389774, 37327.81336093302, 37787.0, 37822.243555129295, 27880.721192788624, 28229.43541129207, 28650.840069385184, 28675.856620716764, 28818.567721483774], "value": 19836.80323503514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.29348200426244, 405.4830091633168, 405.7849339849881, 406.3295562322168, 424.59027038907465, 13743.725125497509, 18252.817471825278, 19724.112414941326, 19789.0, 19803.207871685132, 15691.529254122366, 18060.0, 18819.623607527843, 18854.434366969013, 18973.0, 5665.915011274824, 5823.621464604787, 5869.2369991901, 5879.941200588003, 5881.206037184968, 5789.507891829199, 5807.912881306784, 5808.8838223235725, 5844.853878653025, 5886.911696324559, 5703.57223208259, 5746.454086861741, 5760.596758226926, 5823.621464604808, 5841.299044114712, 5568.749406276747, 5718.885622287573, 5733.455321744427, 5742.397048309951, 5801.100829371433, 5087.821926232601, 5090.261912022773, 5106.106431374495, 5107.0, 5122.282880396748, 22217.0, 22455.663165052538, 23147.884260578758, 23272.65091023636, 23504.882475587514, 2358.714500597179, 2422.9636555451684, 2510.811689123323, 2520.5841036229, 2899.405621847516, 13604.387802548908, 14436.278186090654, 14563.0, 14632.41470341185, 15328.15695136767, 1901.1349835824667, 1987.3441764217773, 1994.768962510898, 2056.0, 2089.1225685212094, 79748.60125699392, 82691.58654206751, 83761.0, 84045.0, 85095.14904850934, 10660.41367724767, 10689.091427228617, 11085.113190944705, 11176.27354221973, 11425.571803524559, 15551.0, 15714.921425393028, 15726.21368931549, 15735.291911863993, 15744.92127539355, 7965.522068675898, 8110.675572977015, 8159.224873636995, 8162.591870406456, 8249.8350032999, 7283.198848126808, 7697.343761713141, 7749.8450030999065, 7864.0, 7885.29032387088, 6473.741050358027, 6801.319868013258, 6897.0, 7079.0, 7139.821504462326, 1913.3877159308888, 1958.7845337013202, 1971.5071232191951, 1984.3848406993877, 2011.7485314335709, 844.4511067805976, 980.460746589373, 1057.6139709006156, 1091.5742860284495, 1092.7541303206874, 19446.124924378437, 19539.80460195408, 19969.900150499154, 20403.0, 20542.589148216954, 1043.7442826507554, 1059.8463222832645, 1062.0866055192528, 1071.5820829876354, 1136.2784631758893, 10519.631812886511, 11706.648800535997, 11742.354170520703, 11776.646700598996, 11777.116716246315, 503901.0, 510553.0, 515678.0, 537795.0, 539134.0, 86432.56783716042, 87559.56220218858, 87607.0, 87988.0, 88037.11962880417, 1050.4642632257603, 1070.3363914373294, 1078.218291738499, 1093.8796732359433, 1100.5322737836389, 17656.646867062842, 17726.911365443608, 18094.185761640496, 18158.81841181571, 18474.168662409957, 28452.43095138127, 28819.423611528073, 36051.098722532144, 36954.815225923696, 40498.59501404948, 51391.48608514017, 54125.72937135289, 54151.458485414645, 54193.45806541884, 54247.0, 8871.467711937305, 8880.600372983361, 8994.730158095268, 9055.818883622422, 9235.953820230856, 8912.197902188835, 10036.64871729486, 13684.31578421055, 13829.723405532035, 13834.584962451143, 11521.251118677259, 11939.223950443193, 11942.044636428891, 11947.283163010246, 11988.100892433276, 11507.482163302504, 11554.94222528882, 11670.416479175838, 11688.94155529217, 11824.940875295568, 11788.410579470821, 11870.169088163746, 12091.879081209076, 12198.14612977083, 12346.13577049598, 7445.218252083453, 7903.9209607903185, 8128.674853005814, 8861.069587693199, 9081.0, 10770.946145269538, 11587.652370428901, 11638.592649257236, 11878.406079696153, 12007.81988270194], "value": 9411.957299556061, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.7122897348092, 1502.4516051641153, 1532.3410933298683, 1704.4375356132477, 1850.2876392588857, 8383.0, 8707.390482666216, 8734.956325218373, 8756.12438756124, 8770.210681038705, 8509.659613615464, 8676.26251768599, 8695.956520217405, 8696.47821130731, 8699.913000869989, 2060.9896950515226, 2309.1340747219792, 2399.1483023526657, 2405.1101092595763, 2412.2763171048705, 2368.348704106367, 2379.357573455166, 2380.8928598213124, 2382.5473160099527, 2387.462820865309, 2363.9881800590974, 2381.785639292463, 2391.6771235883107, 2395.700537432821, 2398.0527691561824, 1998.8201061904426, 2221.31139346803, 2280.338701776483, 2300.2639155470256, 2322.756110608387, 2314.0628045641542, 2328.93013209604, 2347.166755801683, 2352.5882970480097, 2353.976460235393, 8809.03100658927, 8857.512836793974, 8866.556672166365, 8871.733847984571, 8874.023857375749, 5123.820666276662, 5252.763625636855, 5256.92114618281, 5260.736963151865, 5264.578833693296, 3303.4549299365576, 3496.5104885316077, 3535.080878971486, 3576.9642303576893, 3578.8031658258788, 1120.9159313051555, 1134.217390000905, 1166.6208482243305, 1166.8016437205695, 1172.976540469186, 12131.636050918487, 12136.514539418413, 12172.391380430943, 12174.756504869942, 12318.5072597096, 4557.088582283556, 4696.647751418657, 4743.1225223333795, 4777.044591081798, 4778.331033655291, 10121.240906931862, 10136.239782016231, 10142.645007424704, 10145.782506099315, 10147.0, 5124.000819840096, 5188.273641690166, 5191.558717509054, 5193.350831146106, 5195.402528709171, 4238.618524332825, 4674.929876051862, 4788.712677239377, 4791.185498465269, 4858.198397264412, 4054.412110243998, 4060.451655989489, 4082.5509193988637, 4130.834766609302, 4145.150244199992, 1295.5724610878387, 1305.2103477396038, 1307.9673008174873, 1313.5730887461614, 1322.2463195978391, 919.1911118215927, 991.4844280973854, 1006.6225165562914, 1009.5961615353917, 1012.711377257478, 5783.479486846204, 5964.373740757244, 6062.060380641008, 6116.113163591254, 6177.722002509898, 477.1935429124768, 482.43795977686307, 493.1443944755846, 499.34835040272793, 499.8275594919747, 3948.822302996372, 4081.285774989365, 4105.958940410617, 4125.91748165035, 4174.060836311805, 10714.0, 11029.669109926715, 11086.445677716081, 11104.44477776124, 11120.054795342487, 10293.948530257301, 10893.237473376788, 10960.780784384267, 10986.780264394667, 10999.450027498753, 7935.365170786324, 8224.547649879314, 8267.131951145044, 8277.379196560281, 8282.792930176673, 5888.735006924784, 5950.910736339045, 5980.312264089685, 6042.1540984261355, 6049.864466354862, 9717.514124293615, 10036.447995360326, 10150.086492215736, 10207.132393746615, 10242.334248273839, 10160.644377446753, 10231.590736370461, 10330.638427655296, 10339.431331276852, 10345.586176552853, 7110.4667149965, 7614.124375696866, 7760.30157285847, 7799.688012479437, 7905.090914544901, 8566.871496927426, 8582.613782379683, 8633.69782057625, 8662.696805611773, 8663.436876603, 7494.962525187339, 7725.768226953201, 7821.061472623322, 7893.881591776013, 7967.920320796949, 7589.203133670885, 7613.200613935457, 7694.692212311445, 7735.613219338898, 7746.612669366622, 7145.82135446618, 7190.0, 7197.748078817216, 7225.096862892138, 7227.096612923385, 4884.3650325457465, 5035.622328325464, 5118.616103792156, 5146.202338637517, 5173.40505841833, 5186.222066690027, 5190.532852043334, 5192.610554208374, 5249.842504724865, 5298.2052692096495], "value": 4580.135577129725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.41490535057466, 320.68252430094196, 324.07799809541854, 331.9784214026089, 338.8124623195699, 4985.900281994358, 5290.523852853243, 5304.973475132619, 5320.813771517997, 5331.92002119968, 5214.165733482643, 5252.553532949704, 5266.605004624659, 5304.3634763828395, 5308.654937429064, 4186.351115577075, 4188.39268306097, 4204.621584057434, 4209.452771139755, 4222.282212023963, 3892.2020985698005, 4096.201240758053, 4199.349100889367, 4217.40956266123, 4224.549761138547, 3999.400239904047, 4022.356422972325, 4066.6340029397347, 4074.409210664452, 4079.776067179834, 4030.7380020298588, 4041.6564592009713, 4044.4337792709043, 4046.190761847642, 4087.9795601021806, 3584.605693373727, 3587.65917237862, 3592.167994322888, 3593.568771747381, 3599.2801439711902, 4991.875203119951, 5009.298698182258, 5064.3163172971545, 5075.467075957008, 5078.958813443272, 4581.129585378767, 4581.198290299184, 4589.196890544142, 4597.54024597541, 4640.2343613303765, 5410.729463526808, 5435.1737096709885, 5435.456454354572, 5465.152901300305, 5473.31583552056, 3779.263043706478, 3843.9231215375817, 3894.2600905828085, 3894.8315505348564, 3903.902402439933, 5387.78448862045, 5483.506484416422, 5656.830295091154, 5657.321121465409, 5666.008448521492, 3952.3873799561115, 3953.604639536081, 3956.6942908840015, 3968.404739289072, 3968.722189446711, 3833.50164478616, 3928.194720082376, 3977.204559088194, 3982.7809470478824, 4009.8797036088963, 4596.2186428306595, 4605.976970115128, 4606.930896036562, 4620.53794620542, 4626.86119416418, 5426.321709786277, 5489.7648029193915, 5507.311586051744, 5520.282363292827, 5529.585281103853, 1366.125679565079, 1366.349282392156, 1411.7882317652434, 1413.4558195094962, 1414.8231471066117, 861.1818772166467, 863.7322430046705, 875.8292133033997, 882.92495137914, 890.2744263425287, 4793.760311984387, 4803.0, 4809.687370320918, 4829.492903245179, 4835.28347436662, 5101.5408613224245, 5102.897942041139, 5115.590752739772, 5144.356955380577, 5148.768305426265, 4475.216837053567, 4804.639652026112, 4805.693267231748, 4814.542618451242, 4846.903061938812, 2642.775364094035, 2645.20643806861, 2722.7883591801856, 2732.7540521353176, 2739.821911575741, 5143.379835351852, 5155.252488389237, 5159.458256883048, 5159.638825282194, 5160.522948984433, 4667.696599721007, 5046.722430266371, 5073.543381095719, 5093.2360145977655, 5112.821051263262, 5096.770645320969, 5100.336956195745, 5141.203113517411, 5155.407128180307, 5199.376074871039, 5066.265391518135, 5067.746612669425, 5101.974490127525, 5108.233764935289, 5480.643758155867, 5394.973025134849, 5558.388577256579, 5571.832845014656, 5600.8716687658425, 5631.831045068655, 5750.971245143747, 5753.827385178452, 5761.769529218952, 5786.218860453785, 5792.0, 3872.225554888977, 3970.642642162219, 3973.841046358229, 3988.900277493086, 3999.5200575931076, 5535.557155427476, 5567.972160139336, 5584.664920104807, 5587.0, 5639.351474580476, 5433.402325744244, 5447.564194864322, 5470.72646367688, 5480.479354461319, 5492.313460817398, 5269.499397557226, 5449.918251226314, 5532.91700624499, 5552.250446189874, 5564.276644036249, 5309.973450132725, 5372.689743410371, 5389.83830485086, 5410.3507579090765, 5411.702356370437, 5339.492748188916, 5532.1701744737, 5567.582431317748, 5571.9721401392735, 5610.607257491936, 5449.7275136243825, 5458.836234912959, 5472.604485856081, 5480.287562616834, 5482.150266708666], "value": 4072.5087559829135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2336098528169, 676.8003438985498, 714.8847797435997, 767.4052609227848, 789.6880732110816, 15044.849551504496, 15373.615659608515, 15561.066336019847, 16185.19074046296, 16773.496795096136, 15371.769423458629, 15489.148096854697, 15489.612759681013, 15509.0, 15524.223788810543, 695.9025736396909, 791.9643616037292, 817.8936738224022, 823.5058964621239, 824.8721448175543, 821.6795449774593, 824.1840577827967, 827.9254867061964, 828.4615000249855, 828.8135169586825, 856.8671855862351, 862.8576284912982, 862.9741107766777, 863.6459051788768, 863.7840539865034, 721.6463932673005, 815.09524427885, 838.9203025712609, 857.7255278310943, 859.8710193470998, 614.3181069013392, 614.6895817612077, 615.698307829165, 616.0482055224688, 616.303576958039, 14143.575692729235, 14248.073875198079, 14249.145051296955, 14264.215468149248, 14270.215138167398, 12393.814092788616, 12873.87126128736, 13028.739425211537, 13110.213387196798, 13207.669808254774, 12355.93822030884, 12626.81059784104, 12753.936230318788, 12821.102522823407, 13270.0, 4293.57359272843, 4301.634361079312, 4401.119776044772, 4415.359772832953, 4420.889477763049, 51827.74086129621, 59777.7011114946, 59893.0, 60150.699246503485, 60771.08843367353, 10811.35131892089, 10943.4528273586, 10978.286411383235, 11227.208766204618, 11240.38177900207, 19574.314898978468, 19579.16102165178, 19587.412377628694, 19607.509812254808, 19615.705764413546, 8522.957385213034, 8657.653693852175, 8682.0, 8791.912080879109, 8886.289096872235, 4574.268117101248, 4680.157571637138, 4724.314974328703, 4773.641976851681, 4833.10587541306, 3488.947665785015, 3606.6032736398975, 3623.8912832614537, 3624.4382120771324, 3625.818709064589, 638.2341190571241, 646.9385408386196, 651.3616655677463, 652.6114421218318, 668.358375959075, 592.523018969725, 708.0830324729385, 769.8960640313599, 770.7995921060565, 777.1956025513566, 9419.929109084387, 9433.858492122623, 9437.622495100257, 9490.335676502717, 9564.90435095654, 579.939106393831, 610.0330975404034, 688.6728803818146, 724.2669157058597, 745.198911170494, 4481.955180448219, 4518.728876267434, 4609.723416595015, 4711.104890070876, 4820.301056346881, 68953.3104668957, 70573.64713176401, 72035.0, 72240.63879680673, 73527.0, 55370.44629553653, 60379.056408512704, 61677.38322616716, 62708.686456568335, 66478.66760666262, 55815.16277255845, 55861.72069139628, 56048.719756400955, 56170.0, 56730.43269567334, 8840.557972101498, 8972.28221742272, 9038.728838134866, 9070.954645226731, 9084.772880678036, 17330.826691733426, 17387.56531086733, 17413.0, 29174.0, 38742.963414755905, 47535.286970694775, 51935.74032129815, 52157.0, 52161.47838521566, 52564.73717631387, 10519.78960420772, 10798.622048228275, 10963.122950163808, 11301.378424186749, 11728.41357932083, 11424.257423267461, 11537.0, 12057.638270851889, 12594.87405125937, 13002.154859934075, 10935.507902144263, 11427.085833133495, 12427.378631068592, 12488.687782805502, 12525.749485010067, 12166.45250963691, 12285.324307163191, 12633.17884337552, 12651.304178270284, 12671.113022088733, 11867.58463453775, 11891.227070240408, 12220.694482638006, 12264.693382665504, 12617.179883307555, 9481.478518681539, 9601.32790704672, 9725.67711824439, 9911.504424778876, 10450.111740502143, 9474.621015159317, 10103.797924041331, 10131.949340253252, 10196.3372380795, 10201.438920859424], "value": 6788.775005167973, "unit": "score"}], "name": "dromaeo_css", "value": 7084.679389662958, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 111.0, 110.0, 111.0, 110.0, 109.0, 109.0, 119.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 127.0, 191.0, 125.0, 129.0, 163.0, 124.0, 167.0, 130.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 162.0, 164.0, 159.0, 160.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 76.0, 126.0, 76.0, 75.0, 75.0, 73.0, 97.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 83.0, 83.0, 125.0, 83.0, 83.0, 133.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 155.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 69.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 83.0, 81.0, 81.0, 82.0, 113.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 137.0, 126.0, 129.0, 129.0, 123.0, 126.0, 125.0, 125.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 163.0, 167.0, 166.0, 161.0, 168.0, 163.0, 161.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 67.0, 64.0, 63.0, 63.0, 64.0, 62.0, 63.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1508.0000000000002, "alertThreshold": 2.0}]} 07:37:37 INFO - Return code: 0 07:37:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:37:37 ERROR - # TBPL SUCCESS # 07:37:37 INFO - Running post-action listener: _resource_record_post_action 07:37:37 INFO - ##### 07:37:37 INFO - ##### Finished run-tests step (success) 07:37:37 INFO - ##### 07:37:37 INFO - Running post-run listener: _resource_record_post_run 07:37:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289734656; Read time: 16; Write time: 227856 07:37:37 INFO - TinderboxPrint: CPU usage
13.2% 07:37:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:37:37 INFO - TinderboxPrint: I/O write bytes / time
289,734,656 / 227,856 07:37:37 INFO - TinderboxPrint: CPU idle
8,258.2 (86.8%) 07:37:37 INFO - TinderboxPrint: CPU user
1,211.9 (12.7%) 07:37:37 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1241088; Read time: 0; Write time: 60 07:37:37 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288493568; Read time: 16; Write time: 227796 07:37:38 INFO - Running post-run listener: _upload_blobber_files 07:37:38 INFO - Blob upload gear active. 07:37:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:41 INFO - (blobuploader) - INFO - Done attempting. 07:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:43 INFO - (blobuploader) - INFO - Done attempting. 07:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:53 INFO - (blobuploader) - INFO - Done attempting. 07:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:53 INFO - Return code: 0 07:37:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b082adf63869dad07083356f0b9fa84f5b44d152b3a486933c73f56ddf17820f68766a11b101a8caa96c248d4e79ca783742d8edaabe5867ec474cd2497056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61d71c56401e20443ed17cf7730157aed1233a3973320c90c7c529ad9e59857e329f49fbceed14ec21f5c8f2eefca6481fcf8db766ad4d579c761bc337177b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c86e4b63e7051fa62664e7e3d654a3a757e0ac5bbe4326eec3af2c1fadf4a39aae8afa9dc7eeff909806f3763fb6d8b8924e1becfd6d7290796cd0009542282"} 07:37:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:53 INFO - Contents: 07:37:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b082adf63869dad07083356f0b9fa84f5b44d152b3a486933c73f56ddf17820f68766a11b101a8caa96c248d4e79ca783742d8edaabe5867ec474cd2497056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61d71c56401e20443ed17cf7730157aed1233a3973320c90c7c529ad9e59857e329f49fbceed14ec21f5c8f2eefca6481fcf8db766ad4d579c761bc337177b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c86e4b63e7051fa62664e7e3d654a3a757e0ac5bbe4326eec3af2c1fadf4a39aae8afa9dc7eeff909806f3763fb6d8b8924e1becfd6d7290796cd0009542282"} 07:37:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:53 INFO - Copying logs to upload dir... 07:37:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.691701 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-01 07:37:53.799462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:37:53.803103) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 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/33b082adf63869dad07083356f0b9fa84f5b44d152b3a486933c73f56ddf17820f68766a11b101a8caa96c248d4e79ca783742d8edaabe5867ec474cd2497056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61d71c56401e20443ed17cf7730157aed1233a3973320c90c7c529ad9e59857e329f49fbceed14ec21f5c8f2eefca6481fcf8db766ad4d579c761bc337177b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c86e4b63e7051fa62664e7e3d654a3a757e0ac5bbe4326eec3af2c1fadf4a39aae8afa9dc7eeff909806f3763fb6d8b8924e1becfd6d7290796cd0009542282"} build_url:https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/ZZBI_sGISqCUzT2OhkRqYQ/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/33b082adf63869dad07083356f0b9fa84f5b44d152b3a486933c73f56ddf17820f68766a11b101a8caa96c248d4e79ca783742d8edaabe5867ec474cd2497056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61d71c56401e20443ed17cf7730157aed1233a3973320c90c7c529ad9e59857e329f49fbceed14ec21f5c8f2eefca6481fcf8db766ad4d579c761bc337177b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c86e4b63e7051fa62664e7e3d654a3a757e0ac5bbe4326eec3af2c1fadf4a39aae8afa9dc7eeff909806f3763fb6d8b8924e1becfd6d7290796cd0009542282"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:37:53.828203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:37:53.828534) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464790626.491451-1432264256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:37:53.912801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:37:53.913149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:37:53.913466) ========= ========= Total master_lag: 0.26 =========