builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1464292773.07 results: success (0) buildid: 20160526103017 builduid: 35cb521606fd4499aaa9549316f08b18 revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.072634) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.073225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.073604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.090985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.091505) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 12:59:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-26 12:59:33 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.334266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.441671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.442061) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015020 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.493229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:33.493657) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0096c5c727749ad3e79cbdf20d2e96bd179c213 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b0096c5c727749ad3e79cbdf20d2e96bd179c213 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 12:59:33,574 truncating revision to first 12 chars 2016-05-26 12:59:33,574 Setting DEBUG logging. 2016-05-26 12:59:33,574 attempt 1/10 2016-05-26 12:59:33,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0096c5c7277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 12:59:33,880 unpacking tar archive at: mozilla-central-b0096c5c7277/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:34.139401) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:34.139782) ========= script_repo_revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:34.140256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:34.140604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 12:59:34.150506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-26 12:59:34.150847) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:34 INFO - MultiFileLogger online at 20160526 12:59:34 in /builds/slave/test 12:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:34 INFO - {'append_to_log': False, 12:59:34 INFO - 'base_work_dir': '/builds/slave/test', 12:59:34 INFO - 'blob_upload_branch': 'Firefox', 12:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:34 INFO - 'branch': 'Firefox', 12:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:34 INFO - 'config_files': ('talos/linux_config.py',), 12:59:34 INFO - 'default_actions': ('clobber', 12:59:34 INFO - 'read-buildbot-config', 12:59:34 INFO - 'download-and-extract', 12:59:34 INFO - 'populate-webroot', 12:59:34 INFO - 'create-virtualenv', 12:59:34 INFO - 'install', 12:59:34 INFO - 'run-tests'), 12:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:34 INFO - 'download_minidump_stackwalk': True, 12:59:34 INFO - 'download_symbols': 'ondemand', 12:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:34 INFO - 'installer_path': 'installer.exe', 12:59:34 INFO - 'log_level': 'info', 12:59:34 INFO - 'log_name': 'talos', 12:59:34 INFO - 'log_to_console': True, 12:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:34 INFO - 'opt_config_files': (), 12:59:34 INFO - 'pip_index': False, 12:59:34 INFO - 'sps_profile': False, 12:59:34 INFO - 'sps_profile_interval': 0, 12:59:34 INFO - 'suite': 'dromaeojs-e10s', 12:59:34 INFO - 'system_bits': '32', 12:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:34 INFO - 'title': 'talos-linux64-ix-026', 12:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:34 INFO - 'use_talos_json': True, 12:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:34 INFO - 'work_dir': 'build'} 12:59:34 INFO - ##### 12:59:34 INFO - ##### Running clobber step. 12:59:34 INFO - ##### 12:59:34 INFO - Running pre-action listener: _resource_record_pre_action 12:59:34 INFO - Running main action method: clobber 12:59:34 INFO - rmtree: /builds/slave/test/build 12:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:35 INFO - Running post-action listener: _resource_record_post_action 12:59:35 INFO - ##### 12:59:35 INFO - ##### Finished clobber step (success) 12:59:35 INFO - ##### 12:59:35 INFO - ##### 12:59:35 INFO - ##### Running read-buildbot-config step. 12:59:35 INFO - ##### 12:59:35 INFO - Running pre-action listener: _resource_record_pre_action 12:59:35 INFO - Running main action method: read_buildbot_config 12:59:35 INFO - Using buildbot properties: 12:59:35 INFO - { 12:59:35 INFO - "project": "", 12:59:35 INFO - "product": "firefox", 12:59:35 INFO - "script_repo_revision": "production", 12:59:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:59:35 INFO - "repository": "", 12:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:59:35 INFO - "buildid": "20160526103017", 12:59:35 INFO - "pgo_build": "True", 12:59:35 INFO - "basedir": "/builds/slave/test", 12:59:35 INFO - "buildnumber": 42, 12:59:35 INFO - "slavename": "talos-linux64-ix-026", 12:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:59:35 INFO - "platform": "ubuntu64_hw", 12:59:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:59:35 INFO - "branch": "mozilla-central", 12:59:35 INFO - "repo_path": "mozilla-central", 12:59:35 INFO - "revision": "b0096c5c727749ad3e79cbdf20d2e96bd179c213", 12:59:35 INFO - "stage_platform": "linux64-pgo", 12:59:35 INFO - "builduid": "35cb521606fd4499aaa9549316f08b18", 12:59:35 INFO - "slavebuilddir": "test" 12:59:35 INFO - } 12:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:59:35 INFO - Running post-action listener: _resource_record_post_action 12:59:35 INFO - ##### 12:59:35 INFO - ##### Finished read-buildbot-config step (success) 12:59:35 INFO - ##### 12:59:35 INFO - ##### 12:59:35 INFO - ##### Running download-and-extract step. 12:59:35 INFO - ##### 12:59:35 INFO - Running pre-action listener: _resource_record_pre_action 12:59:35 INFO - Running main action method: download_and_extract 12:59:35 INFO - mkdir: /builds/slave/test/build/tests 12:59:35 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')]} 12:59:35 INFO - https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:35 INFO - Downloaded 1361 bytes. 12:59:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:35 INFO - Using the following test package requirements: 12:59:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:59:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'jsshell-linux-x86_64.zip'], 12:59:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:59:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:59:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:35 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')]} 12:59:35 INFO - https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:37 INFO - Downloaded 24408330 bytes. 12:59:37 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'] 12:59:37 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 12:59:39 INFO - Return code: 0 12:59:39 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 12:59:39 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')]} 12:59:39 INFO - https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:40 INFO - Downloaded 24408330 bytes. 12:59:40 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'] 12:59:40 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 12:59:41 INFO - Return code: 0 12:59: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')]} 12:59:41 INFO - https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:42 INFO - Downloaded 10834034 bytes. 12:59:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:59:42 INFO - Return code: 0 12:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:42 INFO - https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BALCI71lSuCykOu6xFsdeA/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 12:59:44 INFO - Downloaded 58674428 bytes. 12:59:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:44 INFO - mkdir: /builds/slave/test/properties 12:59:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:59:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:59:44 INFO - Contents: 12:59:44 INFO - build_url:https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:59:45 INFO - Running post-action listener: _resource_record_post_action 12:59:45 INFO - Running post-action listener: set_extra_try_arguments 12:59:45 INFO - ##### 12:59:45 INFO - ##### Finished download-and-extract step (success) 12:59:45 INFO - ##### 12:59:45 INFO - ##### 12:59:45 INFO - ##### Running populate-webroot step. 12:59:45 INFO - ##### 12:59:45 INFO - Running pre-action listener: _resource_record_pre_action 12:59:45 INFO - Running main action method: populate_webroot 12:59:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:45 INFO - '--tppagecycles', 12:59:45 INFO - '7'], 12:59:45 INFO - 'tests': ['tsvgm']}}, 12:59:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:59:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:59:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:59:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['damp', 'tps']}, 12:59:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'tests': ['damp', 'tps']}, 12:59:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['dromaeo_dom']}, 12:59:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['a11yr', 12:59:45 INFO - 'ts_paint', 12:59:45 INFO - 'tpaint', 12:59:45 INFO - 'sessionrestore', 12:59:45 INFO - 'sessionrestore_no_auto_restore', 12:59:45 INFO - 'tabpaint']}, 12:59:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['tsvgx', 12:59:45 INFO - 'tsvgr_opacity', 12:59:45 INFO - 'tart', 12:59:45 INFO - 'tscrollx', 12:59:45 INFO - 'cart']}, 12:59:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:59:45 INFO - 'tsvgr_opacity', 12:59:45 INFO - 'tart', 12:59:45 INFO - 'tscrollx', 12:59:45 INFO - 'cart']}, 12:59:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'talos_options': ['--disable-e10s'], 12:59:45 INFO - 'tests': ['tp5o']}, 12:59:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'tests': ['tp5o']}, 12:59:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'talos_options': ['--disable-e10s', 12:59:45 INFO - '--xperf_path', 12:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:45 INFO - 'tests': ['tp5n']}, 12:59:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:45 INFO - 'talos_options': ['--xperf_path', 12:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:45 INFO - 'tests': ['tp5n']}}, 12:59:45 INFO - 'talos.zip': {'path': '', 12:59:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:45 INFO - Running post-action listener: _resource_record_post_action 12:59:45 INFO - ##### 12:59:45 INFO - ##### Finished populate-webroot step (success) 12:59:45 INFO - ##### 12:59:45 INFO - ##### 12:59:45 INFO - ##### Running create-virtualenv step. 12:59:45 INFO - ##### 12:59:45 INFO - Running pre-action listener: _resource_record_pre_action 12:59:45 INFO - Running main action method: create_virtualenv 12:59:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:59:45 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 12:59:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:45 INFO - Using real prefix '/usr' 12:59:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:59:45 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:47 INFO - Installing pip.................done. 12:59:47 INFO - Return code: 0 12:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:59:47 INFO - Using env: {'DISPLAY': ':0', 12:59:47 INFO - 'HOME': '/home/cltbld', 12:59:47 INFO - 'LANG': 'en_US.UTF-8', 12:59:47 INFO - 'LANGUAGE': 'en_US:en', 12:59:47 INFO - 'LOGNAME': 'cltbld', 12:59:47 INFO - 'MAIL': '/var/mail/cltbld', 12:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:47 INFO - 'MOZ_NO_REMOTE': '1', 12:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:47 INFO - 'NO_EM_RESTART': '1', 12:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:47 INFO - 'PWD': '/builds/slave/test', 12:59:47 INFO - 'SHELL': '/bin/bash', 12:59:47 INFO - 'SHLVL': '1', 12:59:47 INFO - 'TERM': 'linux', 12:59:47 INFO - 'TMOUT': '86400', 12:59:47 INFO - 'USER': 'cltbld', 12:59:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:47 INFO - '_': '/tools/buildbot/bin/python'} 12:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:48 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 12:59:48 INFO - Cleaning up... 12:59:48 INFO - Return code: 0 12:59:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:59:48 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')]} 12:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:48 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')]} 12:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:48 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 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:48 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 12:59:48 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 12:59:48 INFO - Using env: {'DISPLAY': ':0', 12:59:48 INFO - 'HOME': '/home/cltbld', 12:59:48 INFO - 'LANG': 'en_US.UTF-8', 12:59:48 INFO - 'LANGUAGE': 'en_US:en', 12:59:48 INFO - 'LOGNAME': 'cltbld', 12:59:48 INFO - 'MAIL': '/var/mail/cltbld', 12:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:48 INFO - 'MOZ_NO_REMOTE': '1', 12:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:48 INFO - 'NO_EM_RESTART': '1', 12:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:48 INFO - 'PWD': '/builds/slave/test', 12:59:48 INFO - 'SHELL': '/bin/bash', 12:59:48 INFO - 'SHLVL': '1', 12:59:48 INFO - 'TERM': 'linux', 12:59:48 INFO - 'TMOUT': '86400', 12:59:48 INFO - 'USER': 'cltbld', 12:59:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:48 INFO - '_': '/tools/buildbot/bin/python'} 12:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:48 INFO - Downloading/unpacking psutil>=3.1.1 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:48 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 12:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:50 INFO - Installing collected packages: psutil 12:59:50 INFO - Running setup.py install for psutil 12:59:50 INFO - building 'psutil._psutil_linux' extension 12:59:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:59:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:59:50 INFO - building 'psutil._psutil_posix' extension 12:59:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:59:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:50 INFO - Successfully installed psutil 12:59:50 INFO - Cleaning up... 12:59:50 INFO - Return code: 0 12:59:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:59:50 INFO - Using env: {'DISPLAY': ':0', 12:59:50 INFO - 'HOME': '/home/cltbld', 12:59:50 INFO - 'LANG': 'en_US.UTF-8', 12:59:50 INFO - 'LANGUAGE': 'en_US:en', 12:59:50 INFO - 'LOGNAME': 'cltbld', 12:59:50 INFO - 'MAIL': '/var/mail/cltbld', 12:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:50 INFO - 'MOZ_NO_REMOTE': '1', 12:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:50 INFO - 'NO_EM_RESTART': '1', 12:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:50 INFO - 'PWD': '/builds/slave/test', 12:59:50 INFO - 'SHELL': '/bin/bash', 12:59:50 INFO - 'SHLVL': '1', 12:59:50 INFO - 'TERM': 'linux', 12:59:50 INFO - 'TMOUT': '86400', 12:59:50 INFO - 'USER': 'cltbld', 12:59:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:50 INFO - '_': '/tools/buildbot/bin/python'} 12:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:59:53 INFO - Installing collected packages: mozsystemmonitor 12:59:53 INFO - Running setup.py install for mozsystemmonitor 12:59:53 INFO - Successfully installed mozsystemmonitor 12:59:53 INFO - Cleaning up... 12:59:53 INFO - Return code: 0 12:59:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:59:53 INFO - Using env: {'DISPLAY': ':0', 12:59:53 INFO - 'HOME': '/home/cltbld', 12:59:53 INFO - 'LANG': 'en_US.UTF-8', 12:59:53 INFO - 'LANGUAGE': 'en_US:en', 12:59:53 INFO - 'LOGNAME': 'cltbld', 12:59:53 INFO - 'MAIL': '/var/mail/cltbld', 12:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:53 INFO - 'MOZ_NO_REMOTE': '1', 12:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:53 INFO - 'NO_EM_RESTART': '1', 12:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:53 INFO - 'PWD': '/builds/slave/test', 12:59:53 INFO - 'SHELL': '/bin/bash', 12:59:53 INFO - 'SHLVL': '1', 12:59:53 INFO - 'TERM': 'linux', 12:59:53 INFO - 'TMOUT': '86400', 12:59:53 INFO - 'USER': 'cltbld', 12:59:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:53 INFO - '_': '/tools/buildbot/bin/python'} 12:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:55 INFO - Downloading docopt-0.6.1.tar.gz 12:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:56 INFO - Running setup.py install for blobuploader 12:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:59:56 INFO - Running setup.py install for requests 12:59:56 INFO - Running setup.py install for docopt 12:59:56 INFO - Successfully installed blobuploader requests docopt 12:59:56 INFO - Cleaning up... 12:59:56 INFO - Return code: 0 12:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:59:56 INFO - Using env: {'DISPLAY': ':0', 12:59:56 INFO - 'HOME': '/home/cltbld', 12:59:56 INFO - 'LANG': 'en_US.UTF-8', 12:59:56 INFO - 'LANGUAGE': 'en_US:en', 12:59:56 INFO - 'LOGNAME': 'cltbld', 12:59:56 INFO - 'MAIL': '/var/mail/cltbld', 12:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:56 INFO - 'MOZ_NO_REMOTE': '1', 12:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:56 INFO - 'NO_EM_RESTART': '1', 12:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:56 INFO - 'PWD': '/builds/slave/test', 12:59:56 INFO - 'SHELL': '/bin/bash', 12:59:56 INFO - 'SHLVL': '1', 12:59:56 INFO - 'TERM': 'linux', 12:59:56 INFO - 'TMOUT': '86400', 12:59:56 INFO - 'USER': 'cltbld', 12:59:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:56 INFO - '_': '/tools/buildbot/bin/python'} 12:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:56 INFO - Running setup.py (path:/tmp/pip-v3VGwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:56 INFO - Running setup.py (path:/tmp/pip-Dv4M6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:57 INFO - Running setup.py (path:/tmp/pip-a5rR5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:57 INFO - Running setup.py (path:/tmp/pip-KWyYef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:57 INFO - Running setup.py (path:/tmp/pip-2VJcwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:57 INFO - Running setup.py (path:/tmp/pip-G5olPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:57 INFO - Running setup.py (path:/tmp/pip-ZJCF0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:57 INFO - Running setup.py (path:/tmp/pip-CmdhyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:57 INFO - Running setup.py (path:/tmp/pip-rKpKsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:57 INFO - Running setup.py (path:/tmp/pip-K0W8qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:57 INFO - Running setup.py (path:/tmp/pip-o3kOJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:57 INFO - Running setup.py (path:/tmp/pip-XyJoFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:57 INFO - Running setup.py (path:/tmp/pip-80jycK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:57 INFO - Running setup.py (path:/tmp/pip-6bRC6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:57 INFO - Running setup.py (path:/tmp/pip-eLPxIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:57 INFO - Running setup.py (path:/tmp/pip-MsuFws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:58 INFO - Running setup.py (path:/tmp/pip-VymoVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:59:58 INFO - Running setup.py install for manifestparser 12:59:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Running setup.py install for mozcrash 12:59:58 INFO - Running setup.py install for mozdebug 12:59:58 INFO - Running setup.py install for mozdevice 12:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Running setup.py install for mozfile 12:59:58 INFO - Running setup.py install for mozhttpd 12:59:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Running setup.py install for mozinfo 12:59:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Running setup.py install for mozInstall 12:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:59:58 INFO - Running setup.py install for mozleak 12:59:58 INFO - Running setup.py install for mozlog 12:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Running setup.py install for moznetwork 12:59:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Running setup.py install for mozprocess 12:59:59 INFO - Running setup.py install for mozprofile 12:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Running setup.py install for mozrunner 12:59:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Running setup.py install for mozscreenshot 12:59:59 INFO - Running setup.py install for moztest 12:59:59 INFO - Running setup.py install for mozversion 12:59:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:59:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:59:59 INFO - Cleaning up... 12:59:59 INFO - Return code: 0 12:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 12:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:59:59 INFO - Using env: {'DISPLAY': ':0', 12:59:59 INFO - 'HOME': '/home/cltbld', 12:59:59 INFO - 'LANG': 'en_US.UTF-8', 12:59:59 INFO - 'LANGUAGE': 'en_US:en', 12:59:59 INFO - 'LOGNAME': 'cltbld', 12:59:59 INFO - 'MAIL': '/var/mail/cltbld', 12:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:59 INFO - 'MOZ_NO_REMOTE': '1', 12:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:59 INFO - 'NO_EM_RESTART': '1', 12:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:59 INFO - 'PWD': '/builds/slave/test', 12:59:59 INFO - 'SHELL': '/bin/bash', 12:59:59 INFO - 'SHLVL': '1', 12:59:59 INFO - 'TERM': 'linux', 12:59:59 INFO - 'TMOUT': '86400', 12:59:59 INFO - 'USER': 'cltbld', 12:59:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 12:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:59 INFO - '_': '/tools/buildbot/bin/python'} 13:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:00 INFO - Running setup.py (path:/tmp/pip-sqvC7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:00 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)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:00 INFO - Running setup.py (path:/tmp/pip-IhrxTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:00 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)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:00 INFO - Running setup.py (path:/tmp/pip-SobjwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:00 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)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:00 INFO - Running setup.py (path:/tmp/pip-OMNenI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:00 INFO - Running setup.py (path:/tmp/pip-fLRvG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:00 INFO - Running setup.py (path:/tmp/pip-OVRyag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:00 INFO - Running setup.py (path:/tmp/pip-02tSGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:00 INFO - Running setup.py (path:/tmp/pip-dtMhuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:00 INFO - Running setup.py (path:/tmp/pip-Mwkfsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:00 INFO - Running setup.py (path:/tmp/pip-mMWSvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:00 INFO - Running setup.py (path:/tmp/pip-eXLUVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:00 INFO - Running setup.py (path:/tmp/pip-8OusYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:00 INFO - Running setup.py (path:/tmp/pip-nlBeox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:01 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)) 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:01 INFO - Running setup.py (path:/tmp/pip-1HQc2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:01 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)) 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:01 INFO - Running setup.py (path:/tmp/pip-CGcgMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:01 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)) 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:01 INFO - Running setup.py (path:/tmp/pip-usI4xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:01 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)) 13:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:01 INFO - Running setup.py (path:/tmp/pip-rtTL9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:01 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)) 13:00:01 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)) 13:00:01 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)) 13:00:01 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)) 13:00:01 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)) 13:00:01 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)) 13:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:01 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 13:00:01 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 13:00:01 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 13:00:01 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 13:00:01 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 13:00:01 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 13:00:03 INFO - Downloading blessings-1.6.tar.gz 13:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:03 INFO - Installing collected packages: blessings 13:00:03 INFO - Running setup.py install for blessings 13:00:03 INFO - Successfully installed blessings 13:00:03 INFO - Cleaning up... 13:00:03 INFO - Return code: 0 13:00:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:03 INFO - Reading from file tmpfile_stdout 13:00:03 INFO - Current package versions: 13:00:03 INFO - argparse == 1.2.1 13:00:03 INFO - blessings == 1.6 13:00:03 INFO - blobuploader == 1.2.4 13:00:03 INFO - docopt == 0.6.1 13:00:03 INFO - manifestparser == 1.1 13:00:03 INFO - mozInstall == 1.12 13:00:03 INFO - mozcrash == 0.17 13:00:03 INFO - mozdebug == 0.1 13:00:03 INFO - mozdevice == 0.48 13:00:03 INFO - mozfile == 1.2 13:00:03 INFO - mozhttpd == 0.7 13:00:03 INFO - mozinfo == 0.9 13:00:03 INFO - mozleak == 0.1 13:00:03 INFO - mozlog == 3.2 13:00:03 INFO - moznetwork == 0.27 13:00:03 INFO - mozprocess == 0.22 13:00:03 INFO - mozprofile == 0.28 13:00:03 INFO - mozrunner == 6.11 13:00:03 INFO - mozscreenshot == 0.1 13:00:03 INFO - mozsystemmonitor == 0.3 13:00:03 INFO - moztest == 0.7 13:00:03 INFO - mozversion == 1.4 13:00:03 INFO - psutil == 3.1.1 13:00:03 INFO - requests == 1.2.3 13:00:03 INFO - wsgiref == 0.1.2 13:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 13:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:00:03 INFO - Using env: {'DISPLAY': ':0', 13:00:03 INFO - 'HOME': '/home/cltbld', 13:00:03 INFO - 'LANG': 'en_US.UTF-8', 13:00:03 INFO - 'LANGUAGE': 'en_US:en', 13:00:03 INFO - 'LOGNAME': 'cltbld', 13:00:03 INFO - 'MAIL': '/var/mail/cltbld', 13:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:03 INFO - 'MOZ_NO_REMOTE': '1', 13:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:03 INFO - 'NO_EM_RESTART': '1', 13:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:03 INFO - 'PWD': '/builds/slave/test', 13:00:03 INFO - 'SHELL': '/bin/bash', 13:00:03 INFO - 'SHLVL': '1', 13:00:03 INFO - 'TERM': 'linux', 13:00:03 INFO - 'TMOUT': '86400', 13:00:03 INFO - 'USER': 'cltbld', 13:00:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 13:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:03 INFO - '_': '/tools/buildbot/bin/python'} 13:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:00:03 INFO - Cleaning up... 13:00:03 INFO - Return code: 0 13:00:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 13:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:00:03 INFO - Using env: {'DISPLAY': ':0', 13:00:03 INFO - 'HOME': '/home/cltbld', 13:00:03 INFO - 'LANG': 'en_US.UTF-8', 13:00:03 INFO - 'LANGUAGE': 'en_US:en', 13:00:03 INFO - 'LOGNAME': 'cltbld', 13:00:03 INFO - 'MAIL': '/var/mail/cltbld', 13:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:03 INFO - 'MOZ_NO_REMOTE': '1', 13:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:03 INFO - 'NO_EM_RESTART': '1', 13:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:03 INFO - 'PWD': '/builds/slave/test', 13:00:03 INFO - 'SHELL': '/bin/bash', 13:00:03 INFO - 'SHLVL': '1', 13:00:03 INFO - 'TERM': 'linux', 13:00:03 INFO - 'TMOUT': '86400', 13:00:03 INFO - 'USER': 'cltbld', 13:00:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 13:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:03 INFO - '_': '/tools/buildbot/bin/python'} 13:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:04 INFO - Downloading/unpacking jsonschema 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:06 INFO - warning: no files found matching '*.txt' 13:00:06 INFO - no previously-included directories found matching 'build' 13:00:06 INFO - no previously-included directories found matching 'dist' 13:00:06 INFO - no previously-included directories found matching '.git*' 13:00:06 INFO - Installing collected packages: jsonschema, functools32 13:00:06 INFO - Running setup.py install for functools32 13:00:06 INFO - warning: no files found matching '*.txt' 13:00:06 INFO - no previously-included directories found matching 'build' 13:00:06 INFO - no previously-included directories found matching 'dist' 13:00:06 INFO - no previously-included directories found matching '.git*' 13:00:06 INFO - Successfully installed jsonschema functools32 13:00:06 INFO - Cleaning up... 13:00:06 INFO - Return code: 0 13:00:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b9568f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', '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 13:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:00:06 INFO - Using env: {'DISPLAY': ':0', 13:00:06 INFO - 'HOME': '/home/cltbld', 13:00:06 INFO - 'LANG': 'en_US.UTF-8', 13:00:06 INFO - 'LANGUAGE': 'en_US:en', 13:00:06 INFO - 'LOGNAME': 'cltbld', 13:00:06 INFO - 'MAIL': '/var/mail/cltbld', 13:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:06 INFO - 'MOZ_NO_REMOTE': '1', 13:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:06 INFO - 'NO_EM_RESTART': '1', 13:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:06 INFO - 'PWD': '/builds/slave/test', 13:00:06 INFO - 'SHELL': '/bin/bash', 13:00:06 INFO - 'SHLVL': '1', 13:00:06 INFO - 'TERM': 'linux', 13:00:06 INFO - 'TMOUT': '86400', 13:00:06 INFO - 'USER': 'cltbld', 13:00:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 13:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:06 INFO - '_': '/tools/buildbot/bin/python'} 13:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:06 INFO - Downloading/unpacking flake8 13:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:00:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:00:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:00:09 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 13:00:09 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 13:00:09 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 13:00:09 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 13:00:09 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 13:00:09 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 13:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:09 INFO - no previously-included directories found matching 'docs/_build' 13:00:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:00:09 INFO - Running setup.py install for pep8 13:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:09 INFO - no previously-included directories found matching 'docs/_build' 13:00:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:00:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:00:09 INFO - Cleaning up... 13:00:09 INFO - Return code: 0 13:00:09 INFO - Running post-action listener: _resource_record_post_action 13:00:09 INFO - Running post-action listener: _start_resource_monitoring 13:00:09 INFO - Starting resource monitoring. 13:00:09 INFO - ##### 13:00:09 INFO - ##### Finished create-virtualenv step (success) 13:00:09 INFO - ##### 13:00:09 INFO - ##### 13:00:09 INFO - ##### Running install step. 13:00:09 INFO - ##### 13:00:09 INFO - Running pre-action listener: _resource_record_pre_action 13:00:09 INFO - Running main action method: install 13:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:09 INFO - Reading from file tmpfile_stdout 13:00:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:10 INFO - Reading from file tmpfile_stdout 13:00:10 INFO - Output received: 13:00:10 INFO - Usage: mozinstall [options] installer 13:00:10 INFO - Options: 13:00:10 INFO - -h, --help show this help message and exit 13:00:10 INFO - -d DEST, --destination=DEST 13:00:10 INFO - Directory to install application into. [default: 13:00:10 INFO - "/builds/slave/test"] 13:00:10 INFO - --app=APP Application being installed. [default: firefox] 13:00:10 INFO - mkdir: /builds/slave/test/build/application 13:00:10 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'] 13:00:10 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 13:00:26 INFO - Reading from file tmpfile_stdout 13:00:26 INFO - Output received: 13:00:26 INFO - /builds/slave/test/build/application/firefox/firefox 13:00:26 INFO - Running post-action listener: _resource_record_post_action 13:00:26 INFO - ##### 13:00:26 INFO - ##### Finished install step (success) 13:00:26 INFO - ##### 13:00:26 INFO - ##### 13:00:26 INFO - ##### Running run-tests step. 13:00:26 INFO - ##### 13:00:26 INFO - Running pre-action listener: _resource_record_pre_action 13:00:26 INFO - Running main action method: run_tests 13:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:00:26 INFO - Python 2.7.3 13:00:26 INFO - Return code: 0 13:00:26 INFO - grabbing minidump binary from tooltool 13:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:26 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 0x23ae9c0>, '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 0x23af8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23afd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:00:26 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 13:00:26 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 13:00:26 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 13:00:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:26 INFO - Return code: 0 13:00:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:00:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:00:27 INFO - Return code: 0 13:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:00:27 INFO - Using env: {'DISPLAY': ':0', 13:00:27 INFO - 'HOME': '/home/cltbld', 13:00:27 INFO - 'LANG': 'en_US.UTF-8', 13:00:27 INFO - 'LANGUAGE': 'en_US:en', 13:00:27 INFO - 'LOGNAME': 'cltbld', 13:00:27 INFO - 'MAIL': '/var/mail/cltbld', 13:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:27 INFO - 'MOZ_NO_REMOTE': '1', 13:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:27 INFO - 'NO_EM_RESTART': '1', 13:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:27 INFO - 'PWD': '/builds/slave/test', 13:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:27 INFO - 'SHELL': '/bin/bash', 13:00:27 INFO - 'SHLVL': '1', 13:00:27 INFO - 'TERM': 'linux', 13:00:27 INFO - 'TMOUT': '86400', 13:00:27 INFO - 'USER': 'cltbld', 13:00:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842', 13:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:27 INFO - '_': '/tools/buildbot/bin/python'} 13:00:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:00:27 INFO - mozversion application_buildid: 20160526103017 13:00:27 INFO - mozversion application_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 13:00:27 INFO - mozversion application_display_name: Nightly 13:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:27 INFO - mozversion application_name: Firefox 13:00:27 INFO - mozversion application_remotingname: firefox 13:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:00:27 INFO - mozversion application_vendor: Mozilla 13:00:27 INFO - mozversion application_version: 49.0a1 13:00:27 INFO - mozversion platform_buildid: 20160526103017 13:00:27 INFO - mozversion platform_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 13:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:00:27 INFO - mozversion platform_version: 49.0a1 13:00:27 INFO - using testdate: 1464292827 13:00:27 INFO - actual date: 1464292827 13:00:27 INFO - starting webserver on 'localhost:58290' 13:00:27 INFO - SUITE-START | Running 2 tests 13:00:27 INFO - TEST-START | dromaeo_css 13:00:27 INFO - operating with platform_type : linux_ 13:00:27 INFO - Initialising browser for dromaeo_css test... 13:00:27 INFO - TEST-INFO | started process 10930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUIfduG/profile http://localhost:58290/getInfo.html) 13:00:31 INFO - PROCESS | 10930 | 13:00:31 INFO - PROCESS | 10930 | (process:10998): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:00:32 INFO - PROCESS | 10930 | __metrics Screen width/height:1600/1200 13:00:32 INFO - PROCESS | 10930 | colorDepth:24 13:00:32 INFO - PROCESS | 10930 | Browser inner width/height: 1024/697 13:00:32 INFO - PROCESS | 10930 | __metrics 13:00:33 ERROR - PROCESS | 10930 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:00:34 INFO - TEST-INFO | 10930: exit 0 13:00:34 INFO - Browser initialized. 13:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:00:34 INFO - TEST-INFO | started process 11049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUIfduG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:35 INFO - PROCESS | 11049 | 13:00:35 INFO - PROCESS | 11049 | (process:11110): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:00:45 INFO - PROCESS | 11049 | RSS: Main: 166047744 13:00:45 INFO - PROCESS | 11049 | 13:01:35 INFO - PROCESS | 11049 | 1464292895546 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] 13:03:42 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58290/tests/dromaeo/cssquery-ext.html) 13:03:43 INFO - PROCESS | 11049 | RSS: Main: 169951232 13:03:43 INFO - PROCESS | 11049 | 13:06:45 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-ext.html (next: http://localhost:58290/tests/dromaeo/cssquery-jquery.html) 13:06:46 INFO - PROCESS | 11049 | RSS: Main: 169631744 13:06:46 INFO - PROCESS | 11049 | 13:09:48 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58290/tests/dromaeo/cssquery-mootools.html) 13:09:48 INFO - PROCESS | 11049 | RSS: Main: 170381312 13:09:48 INFO - PROCESS | 11049 | 13:12:50 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58290/tests/dromaeo/cssquery-prototype.html) 13:12:51 INFO - PROCESS | 11049 | RSS: Main: 168292352 13:12:51 INFO - PROCESS | 11049 | 13:15:53 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58290/tests/dromaeo/cssquery-yui.html) 13:15:54 INFO - PROCESS | 11049 | RSS: Main: 169533440 13:15:54 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | Cycle 1(1): loaded http://localhost:58290/tests/dromaeo/cssquery-yui.html (next: http://localhost:58290/tests/dromaeo/cssquery-dojo.html) 13:18:57 INFO - PROCESS | 11049 | RSS: Main: 171511808 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | __start_tp_report 13:18:57 INFO - PROCESS | 11049 | _x_x_mozilla_page_load 13:18:57 INFO - PROCESS | 11049 | _x_x_mozilla_page_load_details 13:18:57 INFO - PROCESS | 11049 | |i|pagename|runs| 13:18:57 INFO - PROCESS | 11049 | |0;dojo.html;3124.968750312496;3127.890523831666;3156.921076973076;3162.620485541734;3170.651228364881;5345.91981120283;5377.2203030560595;5394.1908713692965;5443.428440013801;5473.917891231635;5332.546733527654;5394.083005888999;5454.427285135063;5458.972705136469;5505.587080968923;4898.804047838091;4935.80256789728;5054.090263752523;5080;5168.767405466763;782.7813065735412;4979.153543897546;4988.152014157602;5019.196928491442;5019.573336266403;4943.678660887049;4947.208446648519;4969.925451118236;4970.055689419017;5005.424376196729;4817.253325734517;4950.529699678525;4953.356063711731;4986.5013498650205;5034.773435195425;4876.439209490918;4885.658003939726;4896.706197628154;4905.558499735041;4916.360873086476;5324.068288049576;5422.891542169174;5433.049216387117;5438.972805135989;5450;5712.485876271114;5736.56975726818;5910.143029260733;5918.40815918409;5927.3776253493625;5777.335606405233;5833.82498525045;5846.941530584682;5869.148973398876;5888.499477544414;5405.567554595662;5431.8098866539485;5443.156310771837;5446.1558458439;5451.863703407446;5786;5976.282846058414;5982.850428739316;6061;6090.908636370458;5860.3260625027815;5872.29532456108;5873.148393482921;5873.618214816023;5898.115282707542;5936.495397891142;5964.701764911737;5965.612235204784;5969.641821490724;5974.671393073336;5682.261306030189;5760.913586296209;5766.423357664284;5795.768169273182;5849.94150058494;5683.062294721407;5722.2561067061015;5766.135079738073;5778.422157784188;5873.295204575393;4396.780160991938;4398.2962725964335;4408.052268762167;4415.602595766332;4440.267355886307;3869.6710779583486;3911.1395492991496;3924.7841368724994;3926.6662333701383;3958.4656071430563;5586.944130558642;5647.774089036475;5656.886862262814;5661.971690141523;5693.800716974886;5870.207521984563;5942.168096466498;5949.672767997802;5953.136795164677;5954.225950626477;5416.91874621881;5506.394296627368;5528.143137813645;5556.611037227436;5606.103023516218;4982.7010379376625;5046.44489106198;5050.545450909436;5053.797848086109;5055.165897626924;6072.483838873745;6076.361981991916;6078.483328917003;6079;6098.32918378978;5694.743736531866;5867.178594996619;5879;5926.703664816656;5967.76128954837;6114.602550834182;6124.601900876429;6138.294096178996;6156.876862462636;6159.137720719193;5642.633228840113;5815.41845815415;5837.970810145922;5845.620034697731;5846.766129354948;5833.241678581757;5878.647281163144;5898.439648233411;5920.79277225295;5937.2578427696535;5746.109353050284;5778.711064446845;5793.304803423616;5803;5804.245448091721;5593.440655934537;5614.326280846324;5631.929933312657;5703.572232082527;5710.714464276686;5496.890062198813;5550.58370622213;5578.888422231452;5618.578606604439;5622.381538030895;5739.081746920473;5740.540756739534;5741.91387129185;5789.942100579109;5798.855028624318;5497.642653227527;5648.717564121695;5654.85862853432;5667.2349232854685;5673.602847800615 13:18:57 INFO - PROCESS | 11049 | |1;ext.html;594.3996563470893;636.5416899832121;651.2282944710519;653.5392548253482;656.1044174701534;43756.343654845165;44475.110497790025;44581.33128003083;44693.10613787722;49378;47078.76460617692;47403.28895066577;47706.28440573394;47734.283985740156;48003.759981200135;8711.346649001334;8938.28493720504;8958.059403762609;8975.237104846095;8985.056569060253;8751.3436492263;8814.030456649763;8834.249088827426;8899.68851090212;8902;8936.597853096593;8954.86567701485;8988.550572471382;8991.910080899206;9003.729888103368;8843.380963332569;8883.689070882521;8921.01868794432;8929.553522323858;8963.731088067369;8445.113263107347;8445.324374050062;8529.061803201643;8561.357898157663;8563.657453701844;42844.57155428468;43368.3494747579;43376;43479;43569.56430435687;3492.004778638076;3597.5323207983056;3617.0595645132194;4028.194361127786;4306.0311429928015;31605;33535;33589;33609.83195084034;33619.663803361895;4234.661227101825;4264.360345948133;4364.127174565099;4391.989842336248;4425.033786469514;343246;343459;343583;343825;343916.9999999975;60903;61315;61604.69197653983;61644.38355616386;61902;64342;64701;64796.67601661962;65358.67320663366;65524;15800.60498487547;15930.681386372207;15984.120873352078;15984.200789960456;15988.76016859748;11874.762504749857;11912.821307680391;11967.521299147937;11994.760104797855;12037.277763334228;18430.5811413687;19882.005899704956;19985;20017.899910500644;20118.69821952672;7241.456890733216;7287.781366559012;7464.216257293015;7583.696652133964;7587.203343648837;1018.5060245780791;1020.642775028734;1084.5715942202944;1105.9447027648584;1115.3809635652128;33747.83126084403;33776.66223337784;33781.83109084488;33836.49245261323;33892.32215355679;1079.2229594691967;1095.7151140703315;1116.4306203836102;1117.1565468071553;1172.454808514045;17381.130943452776;17540.561485962953;17667.823321766617;17677.292908283784;17859.821401786077;550195;557893;558730;559426;560176;57526.424735752946;59344.70327648421;59375.40624593699;59386.40613593809;59590.70204648949;1348.440397235156;1368.3705495472195;1380.7721725915312;1383.3567391163158;1395.0722769358263;31311.843440783563;33165.50251746274;33409.331813364086;33436;33625;46325.53674463347;52778.472215277354;52875;53121.734391327795;53259;342035;345888;347632;347749;348392;28542.85728571344;28799.56800648034;28946.27634309159;28985;29016.274593134494;48772.5122748768;49339;49659.255111172635;49763;50478.747606261735;42195;42220;42367.36448953207;42607.1478570433;43761.56238437575;41094.58905410908;41912.580874192085;42396.364054538586;42516.149677006906;42952.35571466493;41791.37312940248;42080.36879446872;42541;42994.57005429906;44401.33397998968;33071.50392744159;39164;40312.19375612413;41060.79469602633;41412.792936036334;28804.855975719987;28897.56653650239;29083.966031719025;29144.417111658073;29532.557011645273 13:18:57 INFO - PROCESS | 11049 | |2;jquery.html;383.8925100971728;396.91466334738027;400.5673872218007;407.9796010199489;414.6330497509703;18274.360397386077;19544.31594894179;19813.504662383428;19992.70010949835;20284.391468255977;11118.277311974716;11561.479733411996;11905.702357441069;19210.327638532654;19553.51116222095;5092.592592592593;5238.397584277819;5248.265242866002;5270.7628156733035;5346.304980352549;5599.608027438081;5627.6060675752715;5694.800681976131;5701.287339082614;5721.713914304268;5182.689038657673;5655.123455864347;5680.403557626451;5692.943070569283;5696.77212911483;5220.712860792655;5246.7901283948595;5269.920951185735;5289.735513224324;5297.258383826248;4912.656114072016;5002.0246052019875;5122.615803814729;5127.359080114986;5133.948660513384;12849.614511564669;12917.741645167043;12956.287404192766;13105.344732763324;13197.736045279136;2068;2144.57108578285;2152.6986221928787;2200.9009594568283;2216.3018649125474;9822.950885245527;10274.691759247235;10306.330088544295;10453.68638940833;10598.0991615712;1937.6609093408738;1986.4338663480983;2013.476496111007;2098.9685154722692;2150.7741687122784;77684.61157694232;79150.20849791543;79542;79783;80006;10369.63706270277;11003.21360208296;11232.831507527393;11258.21192516516;11337.72027549598;15515.301811418512;15629.218539073001;15645.843541564438;15708.21458927049;15770.290336934866;7633.274838890296;7951.681932722627;7990.880136797953;8072.757817265491;8173.223543763333;7607.847843043219;7669;7694.461387702919;7812.414068944852;7854.960725196337;4484.775761211927;4542.432195975503;4550.681452298373;4588.220002599566;4631.95368046322;1881.1534809335853;1882.8399586035341;1899.259288877339;1941.6505029094617;1949.697796841492;900.9819803603891;996.6710985374809;1030.922680798943;1069.8662667166604;1122.5397586989295;19025.714614280798;19482;19645.50886227827;19720.30978915731;19984.500387490138;953.5041778275258;1004.6885465505717;1027.9280450368403;1028.2236911132047;1042.9791404171874;10961.671149865517;10999.23005389631;11121.610743623934;11175.888241117647;11195.832062518906;417300;418293;450741;451279;451599;87367.56316218378;87876.5606171965;87880;88846;89602;960.4621412009298;973.4597298499401;979.7207795778169;981.3964411886781;1000.869886914711;16503.91748041252;17206.225719842387;17654.823451765318;17706.5573360667;17930.282788688306;40064.99350065087;41302.1739565213;41577;42027;42371.576284238;54420.727896360266;55927.16109258283;58043.70978145082;58103.70948145232;58628.4137158623;8348.165183481846;8367.539785311867;8637.179467950535;8777;8781.91218087811;12548.494180698375;12871.678208044874;13304.401301941629;13454.46182152742;13523.797143043059;6206.72069756871;7221.747238846615;11292.86969994949;11784.941075294568;11817.586384476503;9463.716088517356;11210.215284929976;11290.983811457008;11297.26567773092;11591.884081159418;11186.664400068012;11193.160512961398;11322.264052836868;11409.087273017973;12040.21738586989;8088.63601137962;8448.577571121297;8568.700095496628;8582.270507006975;8655.221030107321;10653.295472724327;10725.141988641046;11226;11526.308421494738;11741 13:18:57 INFO - PROCESS | 11049 | |3;mootools.html;1402.3198748606926;1457.2786470697004;1626.235669235459;1835.1466568045855;1836.0911348882305;7982.32150267228;8760.912390876088;8773.25427338677;9201.217896478798;9331.346805723602;8819.779505512366;8988.460692358447;9088.409253398524;9103.180713735763;9106.453612783238;2362.799162071226;2406.639004149374;2418.2382549496942;2423.672804171441;2428.64784606232;2307.3654744945106;2314.190033488274;2382.892769825362;2386.4630458146867;2392.629142482909;2322.2104484475276;2343.7187537495524;2356.9764302357016;2393.6050551658955;2395.089865850974;2249.898754556049;2259.039908039085;2272.136588096529;2273.783990520898;2331.825113116506;2320.825938054653;2337.7077865266842;2342.7540108288554;2344.5193735284224;2347.7769611886843;9036.683716069905;9105.908940910573;9146.771330716785;9150.267978561698;9152.633894644207;5283.471652834724;5322.654027488201;5382.838514844561;5399.055165346088;5402.837914862561;3268.6404495505476;3269.29710112327;3340.682635149657;3436.1581412553833;3443.070370999816;1004.1264100232771;1024.620890270597;1038.2835843268197;1044.253358848427;1052.8894466081028;12533.623991280276;12636.305003224727;12691.74616507674;12694.80957785634;12723.618291451272;4640.468645347028;4648;4726.456457507431;4751.287306903992;4777.856664300007;10631.096356809603;10632.096271816827;10664.040236378763;10664.680059598224;10675.306105103144;5322.121849894724;5396.541293989976;5429.56563474921;5433.809816656398;5458.945410545924;4418.779061046935;4884.4871288514905;4940.308356830046;5069.138246498104;5085.64400491962;4092.877213683594;4134.583695359029;4181.059261666162;4204.8528301509305;4215.051613386963;1279.1685404487157;1288.491046036829;1296.2222666400085;1315.81578578999;1319.630503459033;927.2628260532892;935.4013431403907;950.2113246005937;958.2046901072093;982.6069572171189;5876.676782776988;5890.49930755882;5971.5222782177325;5991.700414979234;6036.245469316335;427.45926403100106;428.8891770314837;429.6713014543876;430.1483063534157;1040.3913710479303;4136.5863413659;4235.428217190702;4245.129748401632;4250.234957707642;4255.1915136124035;11501.42492875353;11679.532818687327;11683.182177247681;11697.649070527897;11811.645650630495;10956.12351011917;11349.432528373549;11402.372869492257;11663.066954643607;11753.941230293794;8374.958125209458;8542.231199192103;8587.313014958789;8589.613467394107;8610.95694521536;6049.848753781191;6267.561270711189;6278.717457714505;6307.621542707452;6352.0789485525265;10276.743081422725;10623.521941512496;10640.255182137176;10745.140388769036;10772.407517586607;10828.566857325619;10963.890361096606;10964.890351096386;10975.835362469728;10986.780264394827;7250.782476525713;7905.090914544901;8111.959440202997;8149.633266502903;8249.216324449168;8979.236764875059;9007.099290071203;9017.864732028893;9135.497547634945;9136.040715724754;7912.9208707912185;7984.401169912164;8050.718224862102;8118.634661440131;8144.674213031412;7880.133185349492;7933.9603301983125;8034.758957231293;8101.392395570238;8170.83658326842;6871.656417179021;7071.504994650325;7149.7497587584185;7201.099862517185;7223.422126229784;4941.43173535048;4965.379327584052;5069.467705890976;5073.898522029613;5108.79564817418;5023.8492845214705;5064.265681476091;5215.322008138917;5233.842984710464;5346.919796202982 13:18:57 INFO - PROCESS | 11049 | |4;prototype.html;337.10834841843325;339.90142858571016;346.63083815736223;346.70530049457966;347.4597001662415;5631.5076504726285;5660.773569057238;5665;5665.71671416429;5697.088465845465;5532.225488431623;5568.638038527492;5586.469285417878;5617.129344951529;5671.886562268752;4274.893127671818;4313.15893400787;4328.350747387885;4334.306510958248;4392.209402307575;4331.545187755288;4345.78271086446;4348;4360.56394360563;4389.231884420214;4119.361498967664;4303.483581970152;4332.653387728974;4346.326319420479;4348.195583816988;4235.470566179212;4306.224879521685;4307.53543795108;4320.589543993316;4336.804843782006;3795.2788970095594;3797.145642230476;3801.1067399161175;3809.5999920008276;3833.099221682902;5317.229001794718;5532.6680399176175;5536.612437129403;5543.059929024809;5549.472800083986;5025.271335656346;5033.119204139261;5042.773075211624;5051.722155281458;5057.291979122926;5900.645961242296;5917;5939.168516407663;5957.1957785698805;5970.462658360769;4128.60778226068;4193.454850869368;4203.936940945889;4238.152369526077;4239.491261048663;6058.242719660043;6089.817305480843;6112.297085835097;6123.510119190454;6131.448169664752;4287.228298906164;4302.633551546637;4314.827406903689;4316;4318.805653745589;4223.619874211336;4353.673474489426;4403.581659742319;4413.322937283876;4425.269830478;4950.628702847301;4965.577925876341;4990.600751939836;4993.700377977333;5004.974975125101;5888.558358123158;5900.527957763368;5912.70436478183;5936.168936348915;5965.194698715704;1480.1267252321181;1499.6925630245773;1516.1888389711671;1517.9298594490858;1523.474401331539;938.6526985015588;952.0431965874252;958.8705524754208;964.9469279189572;976.8730065091635;5139.280500729901;5145.871353216199;5157.6647517911215;5188.9740551297755;5212;5241.449647787003;5299;5325.813596524103;5364.704941228192;5427.891442171134;5443.510084092451;5537.723113844291;5656.943430565724;5669.801556945487;5696.886062278814;3153.1644114309725;3170.3183815479783;3208.502682084281;3210.229544909205;3214.0197239841605;6192.380761923771;6249.25008998923;6249.312575616678;6254.437100660963;6319.715612797435;6155.507559395238;6169.167162433014;6190.2571691397325;6222.191115155091;6238.313785483593;6169.753209871645;6272.560920735596;6295.842603934847;6339.270983836917;6391.6804159792755;6096.481799047131;6108.877822443437;6110.1445797587485;6113.23584551931;6138.618810767542;5973.074173503114;6020.247469066367;6029.577929545065;6039.547033972557;6067.211262535842;5926.407359264039;6291.748330066929;6304.6847657617855;6308.432241098323;6326.43062124411;4325.4593175853015;4331.848385306499;4344.956550434582;4352.651787857028;4354.825806967686;5846.94153058464;6039.15451836752;6063.8180854572665;6096.817095487142;6189.81430557066;5823.621464604787;5909.793157239476;5925.881482370414;5949.672767997802;5954.821355359346;5870.530357571299;5874.324452687995;5887.4406931341455;5895.702945352015;5928.288605367384;5631.802886898939;5679.233303503974;5772.5959182856795;5812.76748930055;5813.709314534341;5953.958057340034;5992.250968628921;6008.519318454601;6011.977963746261;6032.607880487754;5699.401562836008;5836.533077353886;5872.647641141374;5908.556858235564;5936.011436168932 13:18:57 INFO - PROCESS | 11049 | |5;yui.html;820.7045463633093;831.908490066093;833.9708110216144;859.5487369131209;878.2315473960281;14865.925670371647;15372.231388430575;15372.23138843059;15418.460353887602;15446.150461724601;14461.493847715332;14534.200618965953;14574.271286435689;14589.927050364733;14614.342354594042;668.9264180940093;785.5365334452672;811.1442428238206;814.1817473439215;819.9385046121535;807.2411932783165;813.4712436916022;815.2784785464847;815.8205194857152;818.4843548564396;876.0144837058309;877.9824403511926;878.086789738671;879.3624622148955;881.3345923827534;862.8446879561676;870.1124852650292;871.1071152069117;874.8600223964136;875.0243478521435;629.6505439481086;631.3181763695244;633.8225296916825;634.0299342006737;634.8857205702972;14509.637259068502;14521.128732276096;14538.491152809602;14559.199244041574;14586;13955.302234888317;14300;14314.570562883131;14333.21167335796;14334.64163395913;11455;11478.713032174262;11525.135614828838;11714.941425292904;12184.08619353552;3848.422736589534;3986.960130398688;4070.9569076975617;4104.938425923614;4106.240345536085;58264.41735582632;58313.41686583123;59872.70063649697;60126.69936650332;60148;10913.672589822318;10962.342259464298;11233.10135189183;11338.43307834605;11810.291382517076;20741.27405540799;20798.064087116116;20808.167673292897;20843.895780521;20857.165713371294;8394.79013024667;8794.120587941155;8844.292456603585;8966.820663586692;9083.818323633623;4733.266343716729;4816.927746083811;4838.153323168432;4899.510048995072;4961.82633607822;3324.9335013299597;3540.6282340354405;3606.477060826218;3641.16253261746;3642.9635703643153;684.4148253243504;696.860627874417;698.6332175607846;698.7519430602165;703.3212949503753;576.7577617400618;588.7438964050651;661.424560632253;689.5035574386434;723.884178531443;8559.443636163629;8726.258268047288;8807.551608305082;8846.557672116369;9041.141091596288;522.5088416888113;610.4353473037511;641.5669423139362;725.0682872508801;725.5354788831486;4157.625813676784;4247.235497610398;4347.217500849877;4364.345348197796;4393.956060439355;72997.6350118246;73830;74679.62660186773;75358.62320688361;77877.61061194658;65289.34710652833;65492.67253663701;65726;65822.34177658257;66024;55403.72298138564;56202.71898640563;56761.43238567562;58531.12203316954;58598.7070064647;8620.78448038804;8624.310055195443;8810.25112865388;8833.425827321204;8930.19628233462;37915;38921.610783891796;39136.60863391444;39223.41164882586;39394.6060539391;49744;51560.22659660033;51815;52327.47672523226;52331.03942082036;11574.841443927242;11668.124890633406;11712.297262164297;11916.812230334017;11995.700107497383;12924.483020679067;13468.326583670581;13677.794833077312;13833.446662133805;14063.156210627396;11483;11516.654500365003;11642.126840487166;11870;12081.697957551132;12068.396580171131;12235.510579576718;12247.203931744409;12479.126461147633;12699.047571431995;10609.098226650822;10887.302776138282;10946.56213751473;11186.049185819296;11206.775864482828;9876.45679487635;10176.694699159038;10177.236707246839;10249.59001639956;10284.331518451278;9599.664011759554;9866.260030497599;9884.406935583887;9884.901150988399;9895.158911492315 13:18:57 INFO - PROCESS | 11049 | __end_tp_report 13:18:57 INFO - PROCESS | 11049 | __start_cc_report 13:18:57 INFO - PROCESS | 11049 | _x_x_mozilla_cycle_collect,345 13:18:57 INFO - PROCESS | 11049 | __end_cc_report 13:18:57 INFO - PROCESS | 11049 | __startTimestamp1464293937894__endTimestamp 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | ------- Summary: start ------- 13:18:57 INFO - PROCESS | 11049 | Number of tests: 6 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#0] dojo.html Cycles:165 Average:5409.70 Median:5654.86 stddev:732.31 (13.0%) stddev-sans-first:712.28 13:18:57 INFO - PROCESS | 11049 | Values: 3125.0 3127.9 3156.9 3162.6 3170.7 5345.9 5377.2 5394.2 5443.4 5473.9 5332.5 5394.1 5454.4 5459.0 5505.6 4898.8 4935.8 5054.1 5080.0 5168.8 782.8 4979.2 4988.2 5019.2 5019.6 4943.7 4947.2 4969.9 4970.1 5005.4 4817.3 4950.5 4953.4 4986.5 5034.8 4876.4 4885.7 4896.7 4905.6 4916.4 5324.1 5422.9 5433.0 5439.0 5450.0 5712.5 5736.6 5910.1 5918.4 5927.4 5777.3 5833.8 5846.9 5869.1 5888.5 5405.6 5431.8 5443.2 5446.2 5451.9 5786.0 5976.3 5982.9 6061.0 6090.9 5860.3 5872.3 5873.1 5873.6 5898.1 5936.5 5964.7 5965.6 5969.6 5974.7 5682.3 5760.9 5766.4 5795.8 5849.9 5683.1 5722.3 5766.1 5778.4 5873.3 4396.8 4398.3 4408.1 4415.6 4440.3 3869.7 3911.1 3924.8 3926.7 3958.5 5586.9 5647.8 5656.9 5662.0 5693.8 5870.2 5942.2 5949.7 5953.1 5954.2 5416.9 5506.4 5528.1 5556.6 5606.1 4982.7 5046.4 5050.5 5053.8 5055.2 6072.5 6076.4 6078.5 6079.0 6098.3 5694.7 5867.2 5879.0 5926.7 5967.8 6114.6 6124.6 6138.3 6156.9 6159.1 5642.6 5815.4 5838.0 5845.6 5846.8 5833.2 5878.6 5898.4 5920.8 5937.3 5746.1 5778.7 5793.3 5803.0 5804.2 5593.4 5614.3 5631.9 5703.6 5710.7 5496.9 5550.6 5578.9 5618.6 5622.4 5739.1 5740.5 5741.9 5789.9 5798.9 5497.6 5648.7 5654.9 5667.2 5673.6 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#1] ext.html Cycles:180 Average:58997.08 Median:23435.75 stddev:113313.78 (483.5%) stddev-sans-first:113546.81 13:18:57 INFO - PROCESS | 11049 | Values: 594.4 636.5 651.2 653.5 656.1 43756.3 44475.1 44581.3 44693.1 49378.0 47078.8 47403.3 47706.3 47734.3 48003.8 8711.3 8938.3 8958.1 8975.2 8985.1 8751.3 8814.0 8834.2 8899.7 8902.0 8936.6 8954.9 8988.6 8991.9 9003.7 8843.4 8883.7 8921.0 8929.6 8963.7 8445.1 8445.3 8529.1 8561.4 8563.7 42844.6 43368.3 43376.0 43479.0 43569.6 3492.0 3597.5 3617.1 4028.2 4306.0 31605.0 33535.0 33589.0 33609.8 33619.7 4234.7 4264.4 4364.1 4392.0 4425.0 343246.0 343459.0 343583.0 343825.0 343917.0 60903.0 61315.0 61604.7 61644.4 61902.0 64342.0 64701.0 64796.7 65358.7 65524.0 15800.6 15930.7 15984.1 15984.2 15988.8 11874.8 11912.8 11967.5 11994.8 12037.3 18430.6 19882.0 19985.0 20017.9 20118.7 7241.5 7287.8 7464.2 7583.7 7587.2 1018.5 1020.6 1084.6 1105.9 1115.4 33747.8 33776.7 33781.8 33836.5 33892.3 1079.2 1095.7 1116.4 1117.2 1172.5 17381.1 17540.6 17667.8 17677.3 17859.8 550195.0 557893.0 558730.0 559426.0 560176.0 57526.4 59344.7 59375.4 59386.4 59590.7 1348.4 1368.4 1380.8 1383.4 1395.1 31311.8 33165.5 33409.3 33436.0 33625.0 46325.5 52778.5 52875.0 53121.7 53259.0 342035.0 345888.0 347632.0 347749.0 348392.0 28542.9 28799.6 28946.3 28985.0 29016.3 48772.5 49339.0 49659.3 49763.0 50478.7 42195.0 42220.0 42367.4 42607.1 43761.6 41094.6 41912.6 42396.4 42516.1 42952.4 41791.4 42080.4 42541.0 42994.6 44401.3 33071.5 39164.0 40312.2 41060.8 41412.8 28804.9 28897.6 29084.0 29144.4 29532.6 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#2] jquery.html Cycles:180 Average:26839.08 Median:398.74 stddev:72516.37 (18186.3%) stddev-sans-first:72692.59 13:18:57 INFO - PROCESS | 11049 | Values: 383.9 396.9 400.6 408.0 414.6 18274.4 19544.3 19813.5 19992.7 20284.4 11118.3 11561.5 11905.7 19210.3 19553.5 5092.6 5238.4 5248.3 5270.8 5346.3 5599.6 5627.6 5694.8 5701.3 5721.7 5182.7 5655.1 5680.4 5692.9 5696.8 5220.7 5246.8 5269.9 5289.7 5297.3 4912.7 5002.0 5122.6 5127.4 5133.9 12849.6 12917.7 12956.3 13105.3 13197.7 2068.0 2144.6 2152.7 2200.9 2216.3 9823.0 10274.7 10306.3 10453.7 10598.1 1937.7 1986.4 2013.5 2099.0 2150.8 77684.6 79150.2 79542.0 79783.0 80006.0 10369.6 11003.2 11232.8 11258.2 11337.7 15515.3 15629.2 15645.8 15708.2 15770.3 7633.3 7951.7 7990.9 8072.8 8173.2 7607.8 7669.0 7694.5 7812.4 7855.0 4484.8 4542.4 4550.7 4588.2 4632.0 1881.2 1882.8 1899.3 1941.7 1949.7 901.0 996.7 1030.9 1069.9 1122.5 19025.7 19482.0 19645.5 19720.3 19984.5 953.5 1004.7 1027.9 1028.2 1043.0 10961.7 10999.2 11121.6 11175.9 11195.8 417300.0 418293.0 450741.0 451279.0 451599.0 87367.6 87876.6 87880.0 88846.0 89602.0 960.5 973.5 979.7 981.4 1000.9 16503.9 17206.2 17654.8 17706.6 17930.3 40065.0 41302.2 41577.0 42027.0 42371.6 54420.7 55927.2 58043.7 58103.7 58628.4 8348.2 8367.5 8637.2 8777.0 8781.9 12548.5 12871.7 13304.4 13454.5 13523.8 6206.7 7221.7 11292.9 11784.9 11817.6 9463.7 11210.2 11291.0 11297.3 11591.9 11186.7 11193.2 11322.3 11409.1 12040.2 8088.6 8448.6 8568.7 8582.3 8655.2 10653.3 10725.1 11226.0 11526.3 11741.0 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#3] mootools.html Cycles:180 Average:5981.46 Median:4529.62 stddev:3491.40 (77.1%) stddev-sans-first:3484.23 13:18:57 INFO - PROCESS | 11049 | Values: 1402.3 1457.3 1626.2 1835.1 1836.1 7982.3 8760.9 8773.3 9201.2 9331.3 8819.8 8988.5 9088.4 9103.2 9106.5 2362.8 2406.6 2418.2 2423.7 2428.6 2307.4 2314.2 2382.9 2386.5 2392.6 2322.2 2343.7 2357.0 2393.6 2395.1 2249.9 2259.0 2272.1 2273.8 2331.8 2320.8 2337.7 2342.8 2344.5 2347.8 9036.7 9105.9 9146.8 9150.3 9152.6 5283.5 5322.7 5382.8 5399.1 5402.8 3268.6 3269.3 3340.7 3436.2 3443.1 1004.1 1024.6 1038.3 1044.3 1052.9 12533.6 12636.3 12691.7 12694.8 12723.6 4640.5 4648.0 4726.5 4751.3 4777.9 10631.1 10632.1 10664.0 10664.7 10675.3 5322.1 5396.5 5429.6 5433.8 5458.9 4418.8 4884.5 4940.3 5069.1 5085.6 4092.9 4134.6 4181.1 4204.9 4215.1 1279.2 1288.5 1296.2 1315.8 1319.6 927.3 935.4 950.2 958.2 982.6 5876.7 5890.5 5971.5 5991.7 6036.2 427.5 428.9 429.7 430.1 1040.4 4136.6 4235.4 4245.1 4250.2 4255.2 11501.4 11679.5 11683.2 11697.6 11811.6 10956.1 11349.4 11402.4 11663.1 11753.9 8375.0 8542.2 8587.3 8589.6 8611.0 6049.8 6267.6 6278.7 6307.6 6352.1 10276.7 10623.5 10640.3 10745.1 10772.4 10828.6 10963.9 10964.9 10975.8 10986.8 7250.8 7905.1 8112.0 8149.6 8249.2 8979.2 9007.1 9017.9 9135.5 9136.0 7912.9 7984.4 8050.7 8118.6 8144.7 7880.1 7934.0 8034.8 8101.4 8170.8 6871.7 7071.5 7149.7 7201.1 7223.4 4941.4 4965.4 5069.5 5073.9 5108.8 5023.8 5064.3 5215.3 5233.8 5346.9 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#4] prototype.html Cycles:180 Average:4935.95 Median:5624.32 stddev:1463.22 (26.0%) stddev-sans-first:1426.03 13:18:57 INFO - PROCESS | 11049 | Values: 337.1 339.9 346.6 346.7 347.5 5631.5 5660.8 5665.0 5665.7 5697.1 5532.2 5568.6 5586.5 5617.1 5671.9 4274.9 4313.2 4328.4 4334.3 4392.2 4331.5 4345.8 4348.0 4360.6 4389.2 4119.4 4303.5 4332.7 4346.3 4348.2 4235.5 4306.2 4307.5 4320.6 4336.8 3795.3 3797.1 3801.1 3809.6 3833.1 5317.2 5532.7 5536.6 5543.1 5549.5 5025.3 5033.1 5042.8 5051.7 5057.3 5900.6 5917.0 5939.2 5957.2 5970.5 4128.6 4193.5 4203.9 4238.2 4239.5 6058.2 6089.8 6112.3 6123.5 6131.4 4287.2 4302.6 4314.8 4316.0 4318.8 4223.6 4353.7 4403.6 4413.3 4425.3 4950.6 4965.6 4990.6 4993.7 5005.0 5888.6 5900.5 5912.7 5936.2 5965.2 1480.1 1499.7 1516.2 1517.9 1523.5 938.7 952.0 958.9 964.9 976.9 5139.3 5145.9 5157.7 5189.0 5212.0 5241.4 5299.0 5325.8 5364.7 5427.9 5443.5 5537.7 5656.9 5669.8 5696.9 3153.2 3170.3 3208.5 3210.2 3214.0 6192.4 6249.3 6249.3 6254.4 6319.7 6155.5 6169.2 6190.3 6222.2 6238.3 6169.8 6272.6 6295.8 6339.3 6391.7 6096.5 6108.9 6110.1 6113.2 6138.6 5973.1 6020.2 6029.6 6039.5 6067.2 5926.4 6291.7 6304.7 6308.4 6326.4 4325.5 4331.8 4345.0 4352.7 4354.8 5846.9 6039.2 6063.8 6096.8 6189.8 5823.6 5909.8 5925.9 5949.7 5954.8 5870.5 5874.3 5887.4 5895.7 5928.3 5631.8 5679.2 5772.6 5812.8 5813.7 5954.0 5992.3 6008.5 6012.0 6032.6 5699.4 5836.5 5872.6 5908.6 5936.0 13:18:57 INFO - PROCESS | 11049 | 13:18:57 INFO - PROCESS | 11049 | [#5] yui.html Cycles:180 Average:16116.74 Median:51687.61 stddev:20012.64 (38.7%) stddev-sans-first:20035.82 13:18:57 INFO - PROCESS | 11049 | Values: 820.7 831.9 834.0 859.5 878.2 14865.9 15372.2 15372.2 15418.5 15446.2 14461.5 14534.2 14574.3 14589.9 14614.3 668.9 785.5 811.1 814.2 819.9 807.2 813.5 815.3 815.8 818.5 876.0 878.0 878.1 879.4 881.3 862.8 870.1 871.1 874.9 875.0 629.7 631.3 633.8 634.0 634.9 14509.6 14521.1 14538.5 14559.2 14586.0 13955.3 14300.0 14314.6 14333.2 14334.6 11455.0 11478.7 11525.1 11714.9 12184.1 3848.4 3987.0 4071.0 4104.9 4106.2 58264.4 58313.4 59872.7 60126.7 60148.0 10913.7 10962.3 11233.1 11338.4 11810.3 20741.3 20798.1 20808.2 20843.9 20857.2 8394.8 8794.1 8844.3 8966.8 9083.8 4733.3 4816.9 4838.2 4899.5 4961.8 3324.9 3540.6 3606.5 3641.2 3643.0 684.4 696.9 698.6 698.8 703.3 576.8 588.7 661.4 689.5 723.9 8559.4 8726.3 8807.6 8846.6 9041.1 522.5 610.4 641.6 725.1 725.5 4157.6 4247.2 4347.2 4364.3 4394.0 72997.6 73830.0 74679.6 75358.6 77877.6 65289.3 65492.7 65726.0 65822.3 66024.0 55403.7 56202.7 56761.4 58531.1 58598.7 8620.8 8624.3 8810.3 8833.4 8930.2 37915.0 38921.6 39136.6 39223.4 39394.6 49744.0 51560.2 51815.0 52327.5 52331.0 11574.8 11668.1 11712.3 11916.8 11995.7 12924.5 13468.3 13677.8 13833.4 14063.2 11483.0 11516.7 11642.1 11870.0 12081.7 12068.4 12235.5 12247.2 12479.1 12699.0 10609.1 10887.3 10946.6 11186.0 11206.8 9876.5 10176.7 10177.2 10249.6 10284.3 9599.7 9866.3 9884.4 9884.9 9895.2 13:18:57 INFO - PROCESS | 11049 | -------- Summary: end -------- 13:18:57 INFO - PROCESS | 11049 | 13:18:58 INFO - TEST-INFO | 11049: exit 0 13:18:58 INFO - TEST-OK | dromaeo_css | took 1110712ms 13:18:58 INFO - TEST-START | kraken 13:18:58 INFO - operating with platform_type : linux_ 13:18:58 INFO - Initialising browser for kraken test... 13:18:58 INFO - TEST-INFO | started process 11290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_klvo/profile http://localhost:58290/getInfo.html) 13:19:02 INFO - PROCESS | 11290 | 13:19:02 INFO - PROCESS | 11290 | (process:11360): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:19:03 INFO - PROCESS | 11290 | __metrics Screen width/height:1600/1200 13:19:03 INFO - PROCESS | 11290 | colorDepth:24 13:19:03 INFO - PROCESS | 11290 | Browser inner width/height: 1024/697 13:19:03 INFO - PROCESS | 11290 | __metrics 13:19:03 ERROR - PROCESS | 11290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:19:04 INFO - TEST-INFO | 11290: exit 0 13:19:04 INFO - Browser initialized. 13:19:04 INFO - Running cycle 1/1 for kraken test... 13:19:04 INFO - TEST-INFO | started process 11411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa_klvo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:06 INFO - PROCESS | 11411 | 13:19:06 INFO - PROCESS | 11411 | (process:11474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:19:16 INFO - PROCESS | 11411 | RSS: Main: 166187008 13:19:16 INFO - PROCESS | 11411 | 13:19:18 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58290/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:19 INFO - PROCESS | 11411 | RSS: Main: 171008000 13:19:19 INFO - PROCESS | 11411 | 13:19:22 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58290/tests/kraken/driver.html?testName=audio-dft) 13:19:23 INFO - PROCESS | 11411 | RSS: Main: 171261952 13:19:23 INFO - PROCESS | 11411 | 13:19:26 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58290/tests/kraken/driver.html?testName=audio-fft) 13:19:26 INFO - PROCESS | 11411 | RSS: Main: 166047744 13:19:26 INFO - PROCESS | 11411 | 13:19:28 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58290/tests/kraken/driver.html?testName=audio-oscillator) 13:19:29 INFO - PROCESS | 11411 | RSS: Main: 166645760 13:19:29 INFO - PROCESS | 11411 | 13:19:31 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:19:32 INFO - PROCESS | 11411 | RSS: Main: 166768640 13:19:32 INFO - PROCESS | 11411 | 13:19:35 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58290/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:35 INFO - PROCESS | 11411 | RSS: Main: 167313408 13:19:35 INFO - PROCESS | 11411 | 13:19:39 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58290/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:39 INFO - PROCESS | 11411 | RSS: Main: 165212160 13:19:39 INFO - PROCESS | 11411 | 13:19:42 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58290/tests/kraken/driver.html?testName=json-parse-financial) 13:19:43 INFO - PROCESS | 11411 | RSS: Main: 166150144 13:19:43 INFO - PROCESS | 11411 | 13:19:44 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:45 INFO - PROCESS | 11411 | RSS: Main: 166166528 13:19:45 INFO - PROCESS | 11411 | 13:19:47 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:47 INFO - PROCESS | 11411 | RSS: Main: 166305792 13:19:47 INFO - PROCESS | 11411 | 13:19:49 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:50 INFO - PROCESS | 11411 | RSS: Main: 167112704 13:19:50 INFO - PROCESS | 11411 | 13:19:53 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:53 INFO - PROCESS | 11411 | RSS: Main: 167092224 13:19:53 INFO - PROCESS | 11411 | 13:19:56 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:57 INFO - PROCESS | 11411 | RSS: Main: 166838272 13:19:57 INFO - PROCESS | 11411 | 13:19:58 INFO - PROCESS | 11411 | Cycle 1(1): loaded http://localhost:58290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58290/tests/kraken/driver.html?testName=ai-astar) 13:19:59 INFO - PROCESS | 11411 | RSS: Main: 168357888 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | __start_tp_report 13:19:59 INFO - PROCESS | 11411 | _x_x_mozilla_page_load 13:19:59 INFO - PROCESS | 11411 | _x_x_mozilla_page_load_details 13:19:59 INFO - PROCESS | 11411 | |i|pagename|runs| 13:19:59 INFO - PROCESS | 11411 | |0;ai-astar;111;106;110;112;112;110;111;108;112;111 13:19:59 INFO - PROCESS | 11411 | |1;audio-beat-detection;152;126;155;184;126;159;160;139;186;133 13:19:59 INFO - PROCESS | 11411 | |2;audio-dft;162;163;162;161;159;165;175;165;162;160 13:19:59 INFO - PROCESS | 11411 | |3;audio-fft;76;74;74;163;75;75;75;76;172;76 13:19:59 INFO - PROCESS | 11411 | |4;audio-oscillator;83;83;151;82;83;84;142;82;83;137 13:19:59 INFO - PROCESS | 11411 | |5;imaging-gaussian-blur;118;119;117;118;117;117;117;118;118;117 13:19:59 INFO - PROCESS | 11411 | |6;imaging-darkroom;147;148;146;147;148;147;147;147;148;146 13:19:59 INFO - PROCESS | 11411 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;100;98 13:19:59 INFO - PROCESS | 11411 | |8;json-parse-financial;55;53;53;56;53;54;57;67;52;54 13:19:59 INFO - PROCESS | 11411 | |9;json-stringify-tinderbox;64;65;65;64;63;64;64;63;63;63 13:19:59 INFO - PROCESS | 11411 | |10;stanford-crypto-aes;78;79;78;79;84;80;80;79;80;81 13:19:59 INFO - PROCESS | 11411 | |11;stanford-crypto-ccm;121;117;121;145;123;137;134;135;157;131 13:19:59 INFO - PROCESS | 11411 | |12;stanford-crypto-pbkdf2;159;155;165;160;154;154;168;164;166;157 13:19:59 INFO - PROCESS | 11411 | |13;stanford-crypto-sha256-iterative;68;64;63;63;61;66;61;64;62;61 13:19:59 INFO - PROCESS | 11411 | __end_tp_report 13:19:59 INFO - PROCESS | 11411 | __start_cc_report 13:19:59 INFO - PROCESS | 11411 | _x_x_mozilla_cycle_collect,883 13:19:59 INFO - PROCESS | 11411 | __end_cc_report 13:19:59 INFO - PROCESS | 11411 | __startTimestamp1464293999129__endTimestamp 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | ------- Summary: start ------- 13:19:59 INFO - PROCESS | 11411 | Number of tests: 14 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:2.05 13:19:59 INFO - PROCESS | 11411 | Values: 111.0 106.0 110.0 112.0 112.0 110.0 111.0 108.0 112.0 111.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:157.00 stddev:21.56 (13.7%) stddev-sans-first:22.87 13:19:59 INFO - PROCESS | 11411 | Values: 152.0 126.0 155.0 184.0 126.0 159.0 160.0 139.0 186.0 133.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:4.50 (2.8%) stddev-sans-first:4.75 13:19:59 INFO - PROCESS | 11411 | Values: 162.0 163.0 162.0 161.0 159.0 165.0 175.0 165.0 162.0 160.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:39.01 (52.0%) stddev-sans-first:40.86 13:19:59 INFO - PROCESS | 11411 | Values: 76.0 74.0 74.0 163.0 75.0 75.0 75.0 76.0 172.0 76.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:83.00 stddev:29.41 (35.4%) stddev-sans-first:30.46 13:19:59 INFO - PROCESS | 11411 | Values: 83.0 83.0 151.0 82.0 83.0 84.0 142.0 82.0 83.0 137.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:19:59 INFO - PROCESS | 11411 | Values: 118.0 119.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:19:59 INFO - PROCESS | 11411 | Values: 147.0 148.0 146.0 147.0 148.0 147.0 147.0 147.0 148.0 146.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 13:19:59 INFO - PROCESS | 11411 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 100.0 98.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:4.35 (8.0%) stddev-sans-first:4.61 13:19:59 INFO - PROCESS | 11411 | Values: 55.0 53.0 53.0 56.0 53.0 54.0 57.0 67.0 52.0 54.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 13:19:59 INFO - PROCESS | 11411 | Values: 64.0 65.0 65.0 64.0 63.0 64.0 64.0 63.0 63.0 63.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.75 (2.2%) stddev-sans-first:1.73 13:19:59 INFO - PROCESS | 11411 | Values: 78.0 79.0 78.0 79.0 84.0 80.0 80.0 79.0 80.0 81.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:134.50 stddev:12.39 (9.2%) stddev-sans-first:12.47 13:19:59 INFO - PROCESS | 11411 | Values: 121.0 117.0 121.0 145.0 123.0 137.0 134.0 135.0 157.0 131.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:162.00 stddev:5.25 (3.2%) stddev-sans-first:5.55 13:19:59 INFO - PROCESS | 11411 | Values: 159.0 155.0 165.0 160.0 154.0 154.0 168.0 164.0 166.0 157.0 13:19:59 INFO - PROCESS | 11411 | 13:19:59 INFO - PROCESS | 11411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:2.31 (3.6%) stddev-sans-first:1.72 13:19:59 INFO - PROCESS | 11411 | Values: 68.0 64.0 63.0 63.0 61.0 66.0 61.0 64.0 62.0 61.0 13:19:59 INFO - PROCESS | 11411 | -------- Summary: end -------- 13:19:59 INFO - PROCESS | 11411 | 13:20:00 INFO - TEST-INFO | 11411: exit 0 13:20:00 INFO - TEST-OK | kraken | took 61469ms 13:20:00 INFO - SUITE-END | took 1172s 13:20:00 INFO - Completed test suite (00:19:32) 13:20:00 INFO - javascript benchmark 13:20:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7200.923567076658, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.968750312496, 3127.890523831666, 3156.921076973076, 3162.620485541734, 3170.651228364881, 5345.91981120283, 5377.2203030560595, 5394.1908713692965, 5443.428440013801, 5473.917891231635, 5332.546733527654, 5394.083005888999, 5454.427285135063, 5458.972705136469, 5505.587080968923, 4898.804047838091, 4935.80256789728, 5054.090263752523, 5080.0, 5168.767405466763, 782.7813065735412, 4979.153543897546, 4988.152014157602, 5019.196928491442, 5019.573336266403, 4943.678660887049, 4947.208446648519, 4969.925451118236, 4970.055689419017, 5005.424376196729, 4817.253325734517, 4950.529699678525, 4953.356063711731, 4986.5013498650205, 5034.773435195425, 4876.439209490918, 4885.658003939726, 4896.706197628154, 4905.558499735041, 4916.360873086476, 5324.068288049576, 5422.891542169174, 5433.049216387117, 5438.972805135989, 5450.0, 5712.485876271114, 5736.56975726818, 5910.143029260733, 5918.40815918409, 5927.3776253493625, 5777.335606405233, 5833.82498525045, 5846.941530584682, 5869.148973398876, 5888.499477544414, 5405.567554595662, 5431.8098866539485, 5443.156310771837, 5446.1558458439, 5451.863703407446, 5786.0, 5976.282846058414, 5982.850428739316, 6061.0, 6090.908636370458, 5860.3260625027815, 5872.29532456108, 5873.148393482921, 5873.618214816023, 5898.115282707542, 5936.495397891142, 5964.701764911737, 5965.612235204784, 5969.641821490724, 5974.671393073336, 5682.261306030189, 5760.913586296209, 5766.423357664284, 5795.768169273182, 5849.94150058494, 5683.062294721407, 5722.2561067061015, 5766.135079738073, 5778.422157784188, 5873.295204575393, 4396.780160991938, 4398.2962725964335, 4408.052268762167, 4415.602595766332, 4440.267355886307, 3869.6710779583486, 3911.1395492991496, 3924.7841368724994, 3926.6662333701383, 3958.4656071430563, 5586.944130558642, 5647.774089036475, 5656.886862262814, 5661.971690141523, 5693.800716974886, 5870.207521984563, 5942.168096466498, 5949.672767997802, 5953.136795164677, 5954.225950626477, 5416.91874621881, 5506.394296627368, 5528.143137813645, 5556.611037227436, 5606.103023516218, 4982.7010379376625, 5046.44489106198, 5050.545450909436, 5053.797848086109, 5055.165897626924, 6072.483838873745, 6076.361981991916, 6078.483328917003, 6079.0, 6098.32918378978, 5694.743736531866, 5867.178594996619, 5879.0, 5926.703664816656, 5967.76128954837, 6114.602550834182, 6124.601900876429, 6138.294096178996, 6156.876862462636, 6159.137720719193, 5642.633228840113, 5815.41845815415, 5837.970810145922, 5845.620034697731, 5846.766129354948, 5833.241678581757, 5878.647281163144, 5898.439648233411, 5920.79277225295, 5937.2578427696535, 5746.109353050284, 5778.711064446845, 5793.304803423616, 5803.0, 5804.245448091721, 5593.440655934537, 5614.326280846324, 5631.929933312657, 5703.572232082527, 5710.714464276686, 5496.890062198813, 5550.58370622213, 5578.888422231452, 5618.578606604439, 5622.381538030895, 5739.081746920473, 5740.540756739534, 5741.91387129185, 5789.942100579109, 5798.855028624318, 5497.642653227527, 5648.717564121695, 5654.85862853432, 5667.2349232854685, 5673.602847800615], "value": 5360.798606394146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3996563470893, 636.5416899832121, 651.2282944710519, 653.5392548253482, 656.1044174701534, 43756.343654845165, 44475.110497790025, 44581.33128003083, 44693.10613787722, 49378.0, 47078.76460617692, 47403.28895066577, 47706.28440573394, 47734.283985740156, 48003.759981200135, 8711.346649001334, 8938.28493720504, 8958.059403762609, 8975.237104846095, 8985.056569060253, 8751.3436492263, 8814.030456649763, 8834.249088827426, 8899.68851090212, 8902.0, 8936.597853096593, 8954.86567701485, 8988.550572471382, 8991.910080899206, 9003.729888103368, 8843.380963332569, 8883.689070882521, 8921.01868794432, 8929.553522323858, 8963.731088067369, 8445.113263107347, 8445.324374050062, 8529.061803201643, 8561.357898157663, 8563.657453701844, 42844.57155428468, 43368.3494747579, 43376.0, 43479.0, 43569.56430435687, 3492.004778638076, 3597.5323207983056, 3617.0595645132194, 4028.194361127786, 4306.0311429928015, 31605.0, 33535.0, 33589.0, 33609.83195084034, 33619.663803361895, 4234.661227101825, 4264.360345948133, 4364.127174565099, 4391.989842336248, 4425.033786469514, 343246.0, 343459.0, 343583.0, 343825.0, 343916.9999999975, 60903.0, 61315.0, 61604.69197653983, 61644.38355616386, 61902.0, 64342.0, 64701.0, 64796.67601661962, 65358.67320663366, 65524.0, 15800.60498487547, 15930.681386372207, 15984.120873352078, 15984.200789960456, 15988.76016859748, 11874.762504749857, 11912.821307680391, 11967.521299147937, 11994.760104797855, 12037.277763334228, 18430.5811413687, 19882.005899704956, 19985.0, 20017.899910500644, 20118.69821952672, 7241.456890733216, 7287.781366559012, 7464.216257293015, 7583.696652133964, 7587.203343648837, 1018.5060245780791, 1020.642775028734, 1084.5715942202944, 1105.9447027648584, 1115.3809635652128, 33747.83126084403, 33776.66223337784, 33781.83109084488, 33836.49245261323, 33892.32215355679, 1079.2229594691967, 1095.7151140703315, 1116.4306203836102, 1117.1565468071553, 1172.454808514045, 17381.130943452776, 17540.561485962953, 17667.823321766617, 17677.292908283784, 17859.821401786077, 550195.0, 557893.0, 558730.0, 559426.0, 560176.0, 57526.424735752946, 59344.70327648421, 59375.40624593699, 59386.40613593809, 59590.70204648949, 1348.440397235156, 1368.3705495472195, 1380.7721725915312, 1383.3567391163158, 1395.0722769358263, 31311.843440783563, 33165.50251746274, 33409.331813364086, 33436.0, 33625.0, 46325.53674463347, 52778.472215277354, 52875.0, 53121.734391327795, 53259.0, 342035.0, 345888.0, 347632.0, 347749.0, 348392.0, 28542.85728571344, 28799.56800648034, 28946.27634309159, 28985.0, 29016.274593134494, 48772.5122748768, 49339.0, 49659.255111172635, 49763.0, 50478.747606261735, 42195.0, 42220.0, 42367.36448953207, 42607.1478570433, 43761.56238437575, 41094.58905410908, 41912.580874192085, 42396.364054538586, 42516.149677006906, 42952.35571466493, 41791.37312940248, 42080.36879446872, 42541.0, 42994.57005429906, 44401.33397998968, 33071.50392744159, 39164.0, 40312.19375612413, 41060.79469602633, 41412.792936036334, 28804.855975719987, 28897.56653650239, 29083.966031719025, 29144.417111658073, 29532.557011645273], "value": 20474.706704456043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8925100971728, 396.91466334738027, 400.5673872218007, 407.9796010199489, 414.6330497509703, 18274.360397386077, 19544.31594894179, 19813.504662383428, 19992.70010949835, 20284.391468255977, 11118.277311974716, 11561.479733411996, 11905.702357441069, 19210.327638532654, 19553.51116222095, 5092.592592592593, 5238.397584277819, 5248.265242866002, 5270.7628156733035, 5346.304980352549, 5599.608027438081, 5627.6060675752715, 5694.800681976131, 5701.287339082614, 5721.713914304268, 5182.689038657673, 5655.123455864347, 5680.403557626451, 5692.943070569283, 5696.77212911483, 5220.712860792655, 5246.7901283948595, 5269.920951185735, 5289.735513224324, 5297.258383826248, 4912.656114072016, 5002.0246052019875, 5122.615803814729, 5127.359080114986, 5133.948660513384, 12849.614511564669, 12917.741645167043, 12956.287404192766, 13105.344732763324, 13197.736045279136, 2068.0, 2144.57108578285, 2152.6986221928787, 2200.9009594568283, 2216.3018649125474, 9822.950885245527, 10274.691759247235, 10306.330088544295, 10453.68638940833, 10598.0991615712, 1937.6609093408738, 1986.4338663480983, 2013.476496111007, 2098.9685154722692, 2150.7741687122784, 77684.61157694232, 79150.20849791543, 79542.0, 79783.0, 80006.0, 10369.63706270277, 11003.21360208296, 11232.831507527393, 11258.21192516516, 11337.72027549598, 15515.301811418512, 15629.218539073001, 15645.843541564438, 15708.21458927049, 15770.290336934866, 7633.274838890296, 7951.681932722627, 7990.880136797953, 8072.757817265491, 8173.223543763333, 7607.847843043219, 7669.0, 7694.461387702919, 7812.414068944852, 7854.960725196337, 4484.775761211927, 4542.432195975503, 4550.681452298373, 4588.220002599566, 4631.95368046322, 1881.1534809335853, 1882.8399586035341, 1899.259288877339, 1941.6505029094617, 1949.697796841492, 900.9819803603891, 996.6710985374809, 1030.922680798943, 1069.8662667166604, 1122.5397586989295, 19025.714614280798, 19482.0, 19645.50886227827, 19720.30978915731, 19984.500387490138, 953.5041778275258, 1004.6885465505717, 1027.9280450368403, 1028.2236911132047, 1042.9791404171874, 10961.671149865517, 10999.23005389631, 11121.610743623934, 11175.888241117647, 11195.832062518906, 417300.0, 418293.0, 450741.0, 451279.0, 451599.0, 87367.56316218378, 87876.5606171965, 87880.0, 88846.0, 89602.0, 960.4621412009298, 973.4597298499401, 979.7207795778169, 981.3964411886781, 1000.869886914711, 16503.91748041252, 17206.225719842387, 17654.823451765318, 17706.5573360667, 17930.282788688306, 40064.99350065087, 41302.1739565213, 41577.0, 42027.0, 42371.576284238, 54420.727896360266, 55927.16109258283, 58043.70978145082, 58103.70948145232, 58628.4137158623, 8348.165183481846, 8367.539785311867, 8637.179467950535, 8777.0, 8781.91218087811, 12548.494180698375, 12871.678208044874, 13304.401301941629, 13454.46182152742, 13523.797143043059, 6206.72069756871, 7221.747238846615, 11292.86969994949, 11784.941075294568, 11817.586384476503, 9463.716088517356, 11210.215284929976, 11290.983811457008, 11297.26567773092, 11591.884081159418, 11186.664400068012, 11193.160512961398, 11322.264052836868, 11409.087273017973, 12040.21738586989, 8088.63601137962, 8448.577571121297, 8568.700095496628, 8582.270507006975, 8655.221030107321, 10653.295472724327, 10725.141988641046, 11226.0, 11526.308421494738, 11741.0], "value": 8799.364109120062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.3198748606926, 1457.2786470697004, 1626.235669235459, 1835.1466568045855, 1836.0911348882305, 7982.32150267228, 8760.912390876088, 8773.25427338677, 9201.217896478798, 9331.346805723602, 8819.779505512366, 8988.460692358447, 9088.409253398524, 9103.180713735763, 9106.453612783238, 2362.799162071226, 2406.639004149374, 2418.2382549496942, 2423.672804171441, 2428.64784606232, 2307.3654744945106, 2314.190033488274, 2382.892769825362, 2386.4630458146867, 2392.629142482909, 2322.2104484475276, 2343.7187537495524, 2356.9764302357016, 2393.6050551658955, 2395.089865850974, 2249.898754556049, 2259.039908039085, 2272.136588096529, 2273.783990520898, 2331.825113116506, 2320.825938054653, 2337.7077865266842, 2342.7540108288554, 2344.5193735284224, 2347.7769611886843, 9036.683716069905, 9105.908940910573, 9146.771330716785, 9150.267978561698, 9152.633894644207, 5283.471652834724, 5322.654027488201, 5382.838514844561, 5399.055165346088, 5402.837914862561, 3268.6404495505476, 3269.29710112327, 3340.682635149657, 3436.1581412553833, 3443.070370999816, 1004.1264100232771, 1024.620890270597, 1038.2835843268197, 1044.253358848427, 1052.8894466081028, 12533.623991280276, 12636.305003224727, 12691.74616507674, 12694.80957785634, 12723.618291451272, 4640.468645347028, 4648.0, 4726.456457507431, 4751.287306903992, 4777.856664300007, 10631.096356809603, 10632.096271816827, 10664.040236378763, 10664.680059598224, 10675.306105103144, 5322.121849894724, 5396.541293989976, 5429.56563474921, 5433.809816656398, 5458.945410545924, 4418.779061046935, 4884.4871288514905, 4940.308356830046, 5069.138246498104, 5085.64400491962, 4092.877213683594, 4134.583695359029, 4181.059261666162, 4204.8528301509305, 4215.051613386963, 1279.1685404487157, 1288.491046036829, 1296.2222666400085, 1315.81578578999, 1319.630503459033, 927.2628260532892, 935.4013431403907, 950.2113246005937, 958.2046901072093, 982.6069572171189, 5876.676782776988, 5890.49930755882, 5971.5222782177325, 5991.700414979234, 6036.245469316335, 427.45926403100106, 428.8891770314837, 429.6713014543876, 430.1483063534157, 1040.3913710479303, 4136.5863413659, 4235.428217190702, 4245.129748401632, 4250.234957707642, 4255.1915136124035, 11501.42492875353, 11679.532818687327, 11683.182177247681, 11697.649070527897, 11811.645650630495, 10956.12351011917, 11349.432528373549, 11402.372869492257, 11663.066954643607, 11753.941230293794, 8374.958125209458, 8542.231199192103, 8587.313014958789, 8589.613467394107, 8610.95694521536, 6049.848753781191, 6267.561270711189, 6278.717457714505, 6307.621542707452, 6352.0789485525265, 10276.743081422725, 10623.521941512496, 10640.255182137176, 10745.140388769036, 10772.407517586607, 10828.566857325619, 10963.890361096606, 10964.890351096386, 10975.835362469728, 10986.780264394827, 7250.782476525713, 7905.090914544901, 8111.959440202997, 8149.633266502903, 8249.216324449168, 8979.236764875059, 9007.099290071203, 9017.864732028893, 9135.497547634945, 9136.040715724754, 7912.9208707912185, 7984.401169912164, 8050.718224862102, 8118.634661440131, 8144.674213031412, 7880.133185349492, 7933.9603301983125, 8034.758957231293, 8101.392395570238, 8170.83658326842, 6871.656417179021, 7071.504994650325, 7149.7497587584185, 7201.099862517185, 7223.422126229784, 4941.43173535048, 4965.379327584052, 5069.467705890976, 5073.898522029613, 5108.79564817418, 5023.8492845214705, 5064.265681476091, 5215.322008138917, 5233.842984710464, 5346.919796202982], "value": 4678.817661999878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.10834841843325, 339.90142858571016, 346.63083815736223, 346.70530049457966, 347.4597001662415, 5631.5076504726285, 5660.773569057238, 5665.0, 5665.71671416429, 5697.088465845465, 5532.225488431623, 5568.638038527492, 5586.469285417878, 5617.129344951529, 5671.886562268752, 4274.893127671818, 4313.15893400787, 4328.350747387885, 4334.306510958248, 4392.209402307575, 4331.545187755288, 4345.78271086446, 4348.0, 4360.56394360563, 4389.231884420214, 4119.361498967664, 4303.483581970152, 4332.653387728974, 4346.326319420479, 4348.195583816988, 4235.470566179212, 4306.224879521685, 4307.53543795108, 4320.589543993316, 4336.804843782006, 3795.2788970095594, 3797.145642230476, 3801.1067399161175, 3809.5999920008276, 3833.099221682902, 5317.229001794718, 5532.6680399176175, 5536.612437129403, 5543.059929024809, 5549.472800083986, 5025.271335656346, 5033.119204139261, 5042.773075211624, 5051.722155281458, 5057.291979122926, 5900.645961242296, 5917.0, 5939.168516407663, 5957.1957785698805, 5970.462658360769, 4128.60778226068, 4193.454850869368, 4203.936940945889, 4238.152369526077, 4239.491261048663, 6058.242719660043, 6089.817305480843, 6112.297085835097, 6123.510119190454, 6131.448169664752, 4287.228298906164, 4302.633551546637, 4314.827406903689, 4316.0, 4318.805653745589, 4223.619874211336, 4353.673474489426, 4403.581659742319, 4413.322937283876, 4425.269830478, 4950.628702847301, 4965.577925876341, 4990.600751939836, 4993.700377977333, 5004.974975125101, 5888.558358123158, 5900.527957763368, 5912.70436478183, 5936.168936348915, 5965.194698715704, 1480.1267252321181, 1499.6925630245773, 1516.1888389711671, 1517.9298594490858, 1523.474401331539, 938.6526985015588, 952.0431965874252, 958.8705524754208, 964.9469279189572, 976.8730065091635, 5139.280500729901, 5145.871353216199, 5157.6647517911215, 5188.9740551297755, 5212.0, 5241.449647787003, 5299.0, 5325.813596524103, 5364.704941228192, 5427.891442171134, 5443.510084092451, 5537.723113844291, 5656.943430565724, 5669.801556945487, 5696.886062278814, 3153.1644114309725, 3170.3183815479783, 3208.502682084281, 3210.229544909205, 3214.0197239841605, 6192.380761923771, 6249.25008998923, 6249.312575616678, 6254.437100660963, 6319.715612797435, 6155.507559395238, 6169.167162433014, 6190.2571691397325, 6222.191115155091, 6238.313785483593, 6169.753209871645, 6272.560920735596, 6295.842603934847, 6339.270983836917, 6391.6804159792755, 6096.481799047131, 6108.877822443437, 6110.1445797587485, 6113.23584551931, 6138.618810767542, 5973.074173503114, 6020.247469066367, 6029.577929545065, 6039.547033972557, 6067.211262535842, 5926.407359264039, 6291.748330066929, 6304.6847657617855, 6308.432241098323, 6326.43062124411, 4325.4593175853015, 4331.848385306499, 4344.956550434582, 4352.651787857028, 4354.825806967686, 5846.94153058464, 6039.15451836752, 6063.8180854572665, 6096.817095487142, 6189.81430557066, 5823.621464604787, 5909.793157239476, 5925.881482370414, 5949.672767997802, 5954.821355359346, 5870.530357571299, 5874.324452687995, 5887.4406931341455, 5895.702945352015, 5928.288605367384, 5631.802886898939, 5679.233303503974, 5772.5959182856795, 5812.76748930055, 5813.709314534341, 5953.958057340034, 5992.250968628921, 6008.519318454601, 6011.977963746261, 6032.607880487754, 5699.401562836008, 5836.533077353886, 5872.647641141374, 5908.556858235564, 5936.011436168932], "value": 4465.403371398586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.7045463633093, 831.908490066093, 833.9708110216144, 859.5487369131209, 878.2315473960281, 14865.925670371647, 15372.231388430575, 15372.23138843059, 15418.460353887602, 15446.150461724601, 14461.493847715332, 14534.200618965953, 14574.271286435689, 14589.927050364733, 14614.342354594042, 668.9264180940093, 785.5365334452672, 811.1442428238206, 814.1817473439215, 819.9385046121535, 807.2411932783165, 813.4712436916022, 815.2784785464847, 815.8205194857152, 818.4843548564396, 876.0144837058309, 877.9824403511926, 878.086789738671, 879.3624622148955, 881.3345923827534, 862.8446879561676, 870.1124852650292, 871.1071152069117, 874.8600223964136, 875.0243478521435, 629.6505439481086, 631.3181763695244, 633.8225296916825, 634.0299342006737, 634.8857205702972, 14509.637259068502, 14521.128732276096, 14538.491152809602, 14559.199244041574, 14586.0, 13955.302234888317, 14300.0, 14314.570562883131, 14333.21167335796, 14334.64163395913, 11455.0, 11478.713032174262, 11525.135614828838, 11714.941425292904, 12184.08619353552, 3848.422736589534, 3986.960130398688, 4070.9569076975617, 4104.938425923614, 4106.240345536085, 58264.41735582632, 58313.41686583123, 59872.70063649697, 60126.69936650332, 60148.0, 10913.672589822318, 10962.342259464298, 11233.10135189183, 11338.43307834605, 11810.291382517076, 20741.27405540799, 20798.064087116116, 20808.167673292897, 20843.895780521, 20857.165713371294, 8394.79013024667, 8794.120587941155, 8844.292456603585, 8966.820663586692, 9083.818323633623, 4733.266343716729, 4816.927746083811, 4838.153323168432, 4899.510048995072, 4961.82633607822, 3324.9335013299597, 3540.6282340354405, 3606.477060826218, 3641.16253261746, 3642.9635703643153, 684.4148253243504, 696.860627874417, 698.6332175607846, 698.7519430602165, 703.3212949503753, 576.7577617400618, 588.7438964050651, 661.424560632253, 689.5035574386434, 723.884178531443, 8559.443636163629, 8726.258268047288, 8807.551608305082, 8846.557672116369, 9041.141091596288, 522.5088416888113, 610.4353473037511, 641.5669423139362, 725.0682872508801, 725.5354788831486, 4157.625813676784, 4247.235497610398, 4347.217500849877, 4364.345348197796, 4393.956060439355, 72997.6350118246, 73830.0, 74679.62660186773, 75358.62320688361, 77877.61061194658, 65289.34710652833, 65492.67253663701, 65726.0, 65822.34177658257, 66024.0, 55403.72298138564, 56202.71898640563, 56761.43238567562, 58531.12203316954, 58598.7070064647, 8620.78448038804, 8624.310055195443, 8810.25112865388, 8833.425827321204, 8930.19628233462, 37915.0, 38921.610783891796, 39136.60863391444, 39223.41164882586, 39394.6060539391, 49744.0, 51560.22659660033, 51815.0, 52327.47672523226, 52331.03942082036, 11574.841443927242, 11668.124890633406, 11712.297262164297, 11916.812230334017, 11995.700107497383, 12924.483020679067, 13468.326583670581, 13677.794833077312, 13833.446662133805, 14063.156210627396, 11483.0, 11516.654500365003, 11642.126840487166, 11870.0, 12081.697957551132, 12068.396580171131, 12235.510579576718, 12247.203931744409, 12479.126461147633, 12699.047571431995, 10609.098226650822, 10887.302776138282, 10946.56213751473, 11186.049185819296, 11206.775864482828, 9876.45679487635, 10176.694699159038, 10177.236707246839, 10249.59001639956, 10284.331518451278, 9599.664011759554, 9866.260030497599, 9884.406935583887, 9884.901150988399, 9895.158911492315], "value": 6908.619531650076, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 112.0, 112.0, 110.0, 111.0, 108.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 155.0, 184.0, 126.0, 159.0, 160.0, 139.0, 186.0, 133.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 159.0, 165.0, 175.0, 165.0, 162.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 163.0, 75.0, 75.0, 75.0, 76.0, 172.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 151.0, 82.0, 83.0, 84.0, 142.0, 82.0, 83.0, 137.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 100.0, 98.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 56.0, 53.0, 54.0, 57.0, 67.0, 52.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 79.0, 84.0, 80.0, 80.0, 79.0, 80.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 121.0, 145.0, 123.0, 137.0, 134.0, 135.0, 157.0, 131.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 165.0, 160.0, 154.0, 154.0, 168.0, 164.0, 166.0, 157.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 63.0, 63.0, 61.0, 66.0, 61.0, 64.0, 62.0, 61.0], "value": 63.3, "unit": "score"}]}]} 13:20:00 INFO - Return code: 0 13:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:20:00 ERROR - # TBPL SUCCESS # 13:20:00 INFO - Running post-action listener: _resource_record_post_action 13:20:00 INFO - ##### 13:20:00 INFO - ##### Finished run-tests step (success) 13:20:00 INFO - ##### 13:20:00 INFO - Running post-run listener: _resource_record_post_run 13:20:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 36864; Write bytes: 291074048; Read time: 32; Write time: 155488 13:20:00 INFO - TinderboxPrint: CPU usage
13.4% 13:20:00 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 32 13:20:00 INFO - TinderboxPrint: I/O write bytes / time
291,074,048 / 155,488 13:20:00 INFO - TinderboxPrint: CPU idle
8,219.3 (86.6%) 13:20:00 INFO - TinderboxPrint: CPU user
1,222.4 (12.9%) 13:20:00 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1253376; Read time: 0; Write time: 40 13:20:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 36864; Write bytes: 289820672; Read time: 32; Write time: 155448 13:20:01 INFO - Running post-run listener: _upload_blobber_files 13:20:01 INFO - Blob upload gear active. 13:20:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:01 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 13:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:02 INFO - (blobuploader) - INFO - Done attempting. 13:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:03 INFO - (blobuploader) - INFO - Done attempting. 13:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:07 INFO - (blobuploader) - INFO - Done attempting. 13:20:07 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:07 INFO - Return code: 0 13:20:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ad0d390bc683d5597d9fcf02b75216f56948189efc3b9a575613c4d263eed4dbdaa382533bff619090b5dc0d01f29e4a26950f591a7933031f61e7088c718e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d425cde2e12e9ccc14e0a74c394711d901420a6f6db6b3ee7d7aefa2fb37a0649180f14c203481a0523e8b8bebc4a4e54cb13b59c471157a749d156c2e5af31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f321908ad95850ea00421702db906fa30c45353ba2dc8f3f2c05bb5ba0d20f262da8fbea2248097a2465f851cdbd48cc605a391e4fdf9ff8967ac92bfb559"} 13:20:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:07 INFO - Contents: 13:20:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ad0d390bc683d5597d9fcf02b75216f56948189efc3b9a575613c4d263eed4dbdaa382533bff619090b5dc0d01f29e4a26950f591a7933031f61e7088c718e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d425cde2e12e9ccc14e0a74c394711d901420a6f6db6b3ee7d7aefa2fb37a0649180f14c203481a0523e8b8bebc4a4e54cb13b59c471157a749d156c2e5af31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f321908ad95850ea00421702db906fa30c45353ba2dc8f3f2c05bb5ba0d20f262da8fbea2248097a2465f851cdbd48cc605a391e4fdf9ff8967ac92bfb559"} 13:20:07 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:07 INFO - Copying logs to upload dir... 13:20:07 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.335480 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-26 13:20:07.501570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:20:07.504907) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ad0d390bc683d5597d9fcf02b75216f56948189efc3b9a575613c4d263eed4dbdaa382533bff619090b5dc0d01f29e4a26950f591a7933031f61e7088c718e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d425cde2e12e9ccc14e0a74c394711d901420a6f6db6b3ee7d7aefa2fb37a0649180f14c203481a0523e8b8bebc4a4e54cb13b59c471157a749d156c2e5af31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f321908ad95850ea00421702db906fa30c45353ba2dc8f3f2c05bb5ba0d20f262da8fbea2248097a2465f851cdbd48cc605a391e4fdf9ff8967ac92bfb559"} build_url:https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/BALCI71lSuCykOu6xFsdeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ad0d390bc683d5597d9fcf02b75216f56948189efc3b9a575613c4d263eed4dbdaa382533bff619090b5dc0d01f29e4a26950f591a7933031f61e7088c718e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d425cde2e12e9ccc14e0a74c394711d901420a6f6db6b3ee7d7aefa2fb37a0649180f14c203481a0523e8b8bebc4a4e54cb13b59c471157a749d156c2e5af31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f321908ad95850ea00421702db906fa30c45353ba2dc8f3f2c05bb5ba0d20f262da8fbea2248097a2465f851cdbd48cc605a391e4fdf9ff8967ac92bfb559"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:20:07.529847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:20:07.530152) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464292591.18913-1834305842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:20:07.613580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:20:07.613907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:20:07.614214) ========= ========= Total master_lag: 0.17 =========