builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1464193819.35 results: success (0) buildid: 20160525063710 builduid: 67e7610a129d4ea4b040c5ef98e6020f revision: d6d4e8417d2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.354952) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.355467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.355839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.370968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.371286) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 09:30:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3M=0s 2016-05-25 09:30:19 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.485810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.486213) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.537683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:19.538059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6d4e8417d2f --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 d6d4e8417d2f --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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 09:30:19,741 Setting DEBUG logging. 2016-05-25 09:30:19,741 attempt 1/10 2016-05-25 09:30:19,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6d4e8417d2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 09:30:20,062 unpacking tar archive at: mozilla-central-d6d4e8417d2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:20.248424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:20.248777) ========= script_repo_revision: d6d4e8417d2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:20.249208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:20.249533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 09:30:20.260722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 09:30:20.261070) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:20 INFO - MultiFileLogger online at 20160525 09:30:20 in /builds/slave/test 09:30:20 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 09:30:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:20 INFO - {'append_to_log': False, 09:30:20 INFO - 'base_work_dir': '/builds/slave/test', 09:30:20 INFO - 'blob_upload_branch': 'Firefox', 09:30:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:20 INFO - 'branch': 'Firefox', 09:30:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:20 INFO - 'config_files': ('talos/linux_config.py',), 09:30:20 INFO - 'default_actions': ('clobber', 09:30:20 INFO - 'read-buildbot-config', 09:30:20 INFO - 'download-and-extract', 09:30:20 INFO - 'populate-webroot', 09:30:20 INFO - 'create-virtualenv', 09:30:20 INFO - 'install', 09:30:20 INFO - 'run-tests'), 09:30:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:20 INFO - 'download_minidump_stackwalk': True, 09:30:20 INFO - 'download_symbols': 'ondemand', 09:30:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:20 INFO - 'installer_path': 'installer.exe', 09:30:20 INFO - 'log_level': 'info', 09:30:20 INFO - 'log_name': 'talos', 09:30:20 INFO - 'log_to_console': True, 09:30:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:20 INFO - 'opt_config_files': (), 09:30:20 INFO - 'pip_index': False, 09:30:20 INFO - 'sps_profile': False, 09:30:20 INFO - 'sps_profile_interval': 0, 09:30:20 INFO - 'suite': 'dromaeojs-e10s', 09:30:20 INFO - 'system_bits': '32', 09:30:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:20 INFO - 'title': 'talos-linux64-ix-051', 09:30:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:20 INFO - 'use_talos_json': True, 09:30:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:20 INFO - 'work_dir': 'build'} 09:30:20 INFO - ##### 09:30:20 INFO - ##### Running clobber step. 09:30:20 INFO - ##### 09:30:20 INFO - Running pre-action listener: _resource_record_pre_action 09:30:20 INFO - Running main action method: clobber 09:30:20 INFO - rmtree: /builds/slave/test/build 09:30:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - ##### 09:30:21 INFO - ##### Finished clobber step (success) 09:30:21 INFO - ##### 09:30:21 INFO - ##### 09:30:21 INFO - ##### Running read-buildbot-config step. 09:30:21 INFO - ##### 09:30:21 INFO - Running pre-action listener: _resource_record_pre_action 09:30:21 INFO - Running main action method: read_buildbot_config 09:30:21 INFO - Using buildbot properties: 09:30:21 INFO - { 09:30:21 INFO - "project": "", 09:30:21 INFO - "product": "firefox", 09:30:21 INFO - "script_repo_revision": "production", 09:30:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:30:21 INFO - "repository": "", 09:30:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:30:21 INFO - "buildid": "20160525063710", 09:30:21 INFO - "stage_platform": "linux64-pgo", 09:30:21 INFO - "basedir": "/builds/slave/test", 09:30:21 INFO - "nightly_build": "True", 09:30:21 INFO - "buildnumber": 224, 09:30:21 INFO - "slavename": "talos-linux64-ix-051", 09:30:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:30:21 INFO - "platform": "ubuntu64_hw", 09:30:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:30:21 INFO - "branch": "mozilla-central", 09:30:21 INFO - "repo_path": "mozilla-central", 09:30:21 INFO - "revision": "d6d4e8417d2f", 09:30:21 INFO - "pgo_build": "True", 09:30:21 INFO - "builduid": "67e7610a129d4ea4b040c5ef98e6020f", 09:30:21 INFO - "slavebuilddir": "test" 09:30:21 INFO - } 09:30:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - ##### 09:30:21 INFO - ##### Finished read-buildbot-config step (success) 09:30:21 INFO - ##### 09:30:21 INFO - ##### 09:30:21 INFO - ##### Running download-and-extract step. 09:30:21 INFO - ##### 09:30:21 INFO - Running pre-action listener: _resource_record_pre_action 09:30:21 INFO - Running main action method: download_and_extract 09:30:21 INFO - mkdir: /builds/slave/test/build/tests 09:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:21 INFO - https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:22 INFO - Downloaded 1361 bytes. 09:30:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:30:22 INFO - Using the following test package requirements: 09:30:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:30:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'jsshell-linux-x86_64.zip'], 09:30:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:30:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:30:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30:22 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')]} 09:30:22 INFO - https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:23 INFO - Downloaded 24420760 bytes. 09:30:23 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'] 09:30:23 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 09:30:24 INFO - Return code: 0 09:30:24 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 09:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:24 INFO - https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:30:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:30:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:25 INFO - Downloaded 24420760 bytes. 09:30:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:30:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:30:27 INFO - Return code: 0 09:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:27 INFO - https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:28 INFO - Downloaded 10834034 bytes. 09:30:28 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'] 09:30:28 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 09:30:28 INFO - Return code: 0 09:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:28 INFO - https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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 09:30:30 INFO - Downloaded 58629588 bytes. 09:30:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:30:30 INFO - mkdir: /builds/slave/test/properties 09:30:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:30 INFO - Contents: 09:30:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:30:31 INFO - Running post-action listener: _resource_record_post_action 09:30:31 INFO - Running post-action listener: set_extra_try_arguments 09:30:31 INFO - ##### 09:30:31 INFO - ##### Finished download-and-extract step (success) 09:30:31 INFO - ##### 09:30:31 INFO - ##### 09:30:31 INFO - ##### Running populate-webroot step. 09:30:31 INFO - ##### 09:30:31 INFO - Running pre-action listener: _resource_record_pre_action 09:30:31 INFO - Running main action method: populate_webroot 09:30:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:31 INFO - '--tppagecycles', 09:30:31 INFO - '7'], 09:30:31 INFO - 'tests': ['tsvgm']}}, 09:30:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['damp', 'tps']}, 09:30:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'tests': ['damp', 'tps']}, 09:30:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['dromaeo_dom']}, 09:30:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['a11yr', 09:30:31 INFO - 'ts_paint', 09:30:31 INFO - 'tpaint', 09:30:31 INFO - 'sessionrestore', 09:30:31 INFO - 'sessionrestore_no_auto_restore', 09:30:31 INFO - 'tabpaint']}, 09:30:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['tsvgx', 09:30:31 INFO - 'tsvgr_opacity', 09:30:31 INFO - 'tart', 09:30:31 INFO - 'tscrollx', 09:30:31 INFO - 'cart']}, 09:30:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:31 INFO - 'tsvgr_opacity', 09:30:31 INFO - 'tart', 09:30:31 INFO - 'tscrollx', 09:30:31 INFO - 'cart']}, 09:30:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'talos_options': ['--disable-e10s'], 09:30:31 INFO - 'tests': ['tp5o']}, 09:30:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'tests': ['tp5o']}, 09:30:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'talos_options': ['--disable-e10s', 09:30:31 INFO - '--xperf_path', 09:30:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:31 INFO - 'tests': ['tp5n']}, 09:30:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:31 INFO - 'talos_options': ['--xperf_path', 09:30:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:31 INFO - 'tests': ['tp5n']}}, 09:30:31 INFO - 'talos.zip': {'path': '', 09:30:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:31 INFO - Running post-action listener: _resource_record_post_action 09:30:31 INFO - ##### 09:30:31 INFO - ##### Finished populate-webroot step (success) 09:30:31 INFO - ##### 09:30:31 INFO - ##### 09:30:31 INFO - ##### Running create-virtualenv step. 09:30:31 INFO - ##### 09:30:31 INFO - Running pre-action listener: _resource_record_pre_action 09:30:31 INFO - Running main action method: create_virtualenv 09:30:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:31 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 09:30:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:31 INFO - Using real prefix '/usr' 09:30:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:34 INFO - Installing pip.................done. 09:30:34 INFO - Return code: 0 09:30:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:34 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:34 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 09:30:34 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 09:30:34 INFO - Using env: {'DISPLAY': ':0', 09:30:34 INFO - 'HOME': '/home/cltbld', 09:30:34 INFO - 'LANG': 'en_US.UTF-8', 09:30:34 INFO - 'LANGUAGE': 'en_US:en', 09:30:34 INFO - 'LOGNAME': 'cltbld', 09:30:34 INFO - 'MAIL': '/var/mail/cltbld', 09:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:34 INFO - 'MOZ_NO_REMOTE': '1', 09:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:34 INFO - 'NO_EM_RESTART': '1', 09:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:34 INFO - 'PWD': '/builds/slave/test', 09:30:34 INFO - 'SHELL': '/bin/bash', 09:30:34 INFO - 'SHLVL': '1', 09:30:34 INFO - 'TERM': 'linux', 09:30:34 INFO - 'TMOUT': '86400', 09:30:34 INFO - 'USER': 'cltbld', 09:30:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:34 INFO - '_': '/tools/buildbot/bin/python'} 09:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:34 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 09:30:34 INFO - Cleaning up... 09:30:34 INFO - Return code: 0 09:30:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:34 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:34 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 09:30:34 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 09:30:34 INFO - Using env: {'DISPLAY': ':0', 09:30:34 INFO - 'HOME': '/home/cltbld', 09:30:34 INFO - 'LANG': 'en_US.UTF-8', 09:30:34 INFO - 'LANGUAGE': 'en_US:en', 09:30:34 INFO - 'LOGNAME': 'cltbld', 09:30:34 INFO - 'MAIL': '/var/mail/cltbld', 09:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:34 INFO - 'MOZ_NO_REMOTE': '1', 09:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:34 INFO - 'NO_EM_RESTART': '1', 09:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:34 INFO - 'PWD': '/builds/slave/test', 09:30:34 INFO - 'SHELL': '/bin/bash', 09:30:34 INFO - 'SHLVL': '1', 09:30:34 INFO - 'TERM': 'linux', 09:30:34 INFO - 'TMOUT': '86400', 09:30:34 INFO - 'USER': 'cltbld', 09:30:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:34 INFO - '_': '/tools/buildbot/bin/python'} 09:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:34 INFO - Downloading/unpacking psutil>=3.1.1 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:36 INFO - Installing collected packages: psutil 09:30:36 INFO - Running setup.py install for psutil 09:30:36 INFO - building 'psutil._psutil_linux' extension 09:30:36 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 09:30:36 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 09:30:36 INFO - building 'psutil._psutil_posix' extension 09:30:36 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 09:30:36 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 09:30:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:37 INFO - Successfully installed psutil 09:30:37 INFO - Cleaning up... 09:30:37 INFO - Return code: 0 09:30:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:30:37 INFO - Using env: {'DISPLAY': ':0', 09:30:37 INFO - 'HOME': '/home/cltbld', 09:30:37 INFO - 'LANG': 'en_US.UTF-8', 09:30:37 INFO - 'LANGUAGE': 'en_US:en', 09:30:37 INFO - 'LOGNAME': 'cltbld', 09:30:37 INFO - 'MAIL': '/var/mail/cltbld', 09:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:37 INFO - 'MOZ_NO_REMOTE': '1', 09:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:37 INFO - 'NO_EM_RESTART': '1', 09:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:37 INFO - 'PWD': '/builds/slave/test', 09:30:37 INFO - 'SHELL': '/bin/bash', 09:30:37 INFO - 'SHLVL': '1', 09:30:37 INFO - 'TERM': 'linux', 09:30:37 INFO - 'TMOUT': '86400', 09:30:37 INFO - 'USER': 'cltbld', 09:30:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:37 INFO - '_': '/tools/buildbot/bin/python'} 09:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:39 INFO - Installing collected packages: mozsystemmonitor 09:30:39 INFO - Running setup.py install for mozsystemmonitor 09:30:39 INFO - Successfully installed mozsystemmonitor 09:30:39 INFO - Cleaning up... 09:30:39 INFO - Return code: 0 09:30:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:39 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:39 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 09:30:39 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 09:30:39 INFO - Using env: {'DISPLAY': ':0', 09:30:39 INFO - 'HOME': '/home/cltbld', 09:30:39 INFO - 'LANG': 'en_US.UTF-8', 09:30:39 INFO - 'LANGUAGE': 'en_US:en', 09:30:39 INFO - 'LOGNAME': 'cltbld', 09:30:39 INFO - 'MAIL': '/var/mail/cltbld', 09:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:39 INFO - 'MOZ_NO_REMOTE': '1', 09:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:39 INFO - 'NO_EM_RESTART': '1', 09:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:39 INFO - 'PWD': '/builds/slave/test', 09:30:39 INFO - 'SHELL': '/bin/bash', 09:30:39 INFO - 'SHLVL': '1', 09:30:39 INFO - 'TERM': 'linux', 09:30:39 INFO - 'TMOUT': '86400', 09:30:39 INFO - 'USER': 'cltbld', 09:30:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:39 INFO - '_': '/tools/buildbot/bin/python'} 09:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:42 INFO - Downloading docopt-0.6.1.tar.gz 09:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:42 INFO - Running setup.py install for blobuploader 09:30:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:42 INFO - Running setup.py install for requests 09:30:42 INFO - Running setup.py install for docopt 09:30:42 INFO - Successfully installed blobuploader requests docopt 09:30:42 INFO - Cleaning up... 09:30:42 INFO - Return code: 0 09:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:42 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:42 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 09:30:42 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 09:30:42 INFO - Using env: {'DISPLAY': ':0', 09:30:42 INFO - 'HOME': '/home/cltbld', 09:30:42 INFO - 'LANG': 'en_US.UTF-8', 09:30:42 INFO - 'LANGUAGE': 'en_US:en', 09:30:42 INFO - 'LOGNAME': 'cltbld', 09:30:42 INFO - 'MAIL': '/var/mail/cltbld', 09:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:42 INFO - 'MOZ_NO_REMOTE': '1', 09:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:42 INFO - 'NO_EM_RESTART': '1', 09:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:42 INFO - 'PWD': '/builds/slave/test', 09:30:42 INFO - 'SHELL': '/bin/bash', 09:30:42 INFO - 'SHLVL': '1', 09:30:42 INFO - 'TERM': 'linux', 09:30:42 INFO - 'TMOUT': '86400', 09:30:42 INFO - 'USER': 'cltbld', 09:30:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:42 INFO - '_': '/tools/buildbot/bin/python'} 09:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:43 INFO - Running setup.py (path:/tmp/pip-DREpOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:43 INFO - Running setup.py (path:/tmp/pip-LfmZih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:43 INFO - Running setup.py (path:/tmp/pip-KfUpvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:43 INFO - Running setup.py (path:/tmp/pip-vtd_Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:43 INFO - Running setup.py (path:/tmp/pip-9jSLs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:43 INFO - Running setup.py (path:/tmp/pip-qAMKVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:43 INFO - Running setup.py (path:/tmp/pip-ZffGDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:43 INFO - Running setup.py (path:/tmp/pip-QeLOO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:43 INFO - Running setup.py (path:/tmp/pip-s1xCLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:43 INFO - Running setup.py (path:/tmp/pip-vxosJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:43 INFO - Running setup.py (path:/tmp/pip-DtID21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:43 INFO - Running setup.py (path:/tmp/pip-q_Zzur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:43 INFO - Running setup.py (path:/tmp/pip-A9PA7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:44 INFO - Running setup.py (path:/tmp/pip-P97gKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:44 INFO - Running setup.py (path:/tmp/pip-PFPgnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:44 INFO - Running setup.py (path:/tmp/pip-GEAL2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:44 INFO - Running setup.py (path:/tmp/pip-kpneJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:44 INFO - Running setup.py install for manifestparser 09:30:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:44 INFO - Running setup.py install for mozcrash 09:30:44 INFO - Running setup.py install for mozdebug 09:30:44 INFO - Running setup.py install for mozdevice 09:30:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:44 INFO - Running setup.py install for mozfile 09:30:44 INFO - Running setup.py install for mozhttpd 09:30:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:44 INFO - Running setup.py install for mozinfo 09:30:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for mozInstall 09:30:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for mozleak 09:30:45 INFO - Running setup.py install for mozlog 09:30:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for moznetwork 09:30:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for mozprocess 09:30:45 INFO - Running setup.py install for mozprofile 09:30:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for mozrunner 09:30:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:45 INFO - Running setup.py install for mozscreenshot 09:30:45 INFO - Running setup.py install for moztest 09:30:45 INFO - Running setup.py install for mozversion 09:30:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:46 INFO - Cleaning up... 09:30:46 INFO - Return code: 0 09:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:46 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:46 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 09:30:46 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 09:30:46 INFO - Using env: {'DISPLAY': ':0', 09:30:46 INFO - 'HOME': '/home/cltbld', 09:30:46 INFO - 'LANG': 'en_US.UTF-8', 09:30:46 INFO - 'LANGUAGE': 'en_US:en', 09:30:46 INFO - 'LOGNAME': 'cltbld', 09:30:46 INFO - 'MAIL': '/var/mail/cltbld', 09:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:46 INFO - 'MOZ_NO_REMOTE': '1', 09:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:46 INFO - 'NO_EM_RESTART': '1', 09:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:46 INFO - 'PWD': '/builds/slave/test', 09:30:46 INFO - 'SHELL': '/bin/bash', 09:30:46 INFO - 'SHLVL': '1', 09:30:46 INFO - 'TERM': 'linux', 09:30:46 INFO - 'TMOUT': '86400', 09:30:46 INFO - 'USER': 'cltbld', 09:30:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:46 INFO - '_': '/tools/buildbot/bin/python'} 09:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:46 INFO - Running setup.py (path:/tmp/pip-MRs0KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:46 INFO - Running setup.py (path:/tmp/pip-iuyFRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:46 INFO - Running setup.py (path:/tmp/pip-M0iiV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:46 INFO - Running setup.py (path:/tmp/pip-8Dfj_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:46 INFO - Running setup.py (path:/tmp/pip-10P62d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:46 INFO - Running setup.py (path:/tmp/pip-fTVrmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:46 INFO - Running setup.py (path:/tmp/pip-OHgrlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:46 INFO - Running setup.py (path:/tmp/pip-tji3Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:46 INFO - Running setup.py (path:/tmp/pip-cJorVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:46 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)) 09:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:46 INFO - Running setup.py (path:/tmp/pip-Iff753-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:47 INFO - Running setup.py (path:/tmp/pip-PKFZFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:47 INFO - Running setup.py (path:/tmp/pip-eoj5XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:47 INFO - Running setup.py (path:/tmp/pip-95MPIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:47 INFO - Running setup.py (path:/tmp/pip-Br5jhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:47 INFO - Running setup.py (path:/tmp/pip-r3WrFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:47 INFO - Running setup.py (path:/tmp/pip-oBqBWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:47 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)) 09:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:47 INFO - Running setup.py (path:/tmp/pip-nE_XRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:47 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)) 09:30:47 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)) 09:30:47 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)) 09:30:47 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)) 09:30:47 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)) 09:30:47 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)) 09:30:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:49 INFO - Downloading blessings-1.6.tar.gz 09:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:49 INFO - Installing collected packages: blessings 09:30:49 INFO - Running setup.py install for blessings 09:30:49 INFO - Successfully installed blessings 09:30:49 INFO - Cleaning up... 09:30:49 INFO - Return code: 0 09:30:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:49 INFO - Reading from file tmpfile_stdout 09:30:49 INFO - Current package versions: 09:30:49 INFO - argparse == 1.2.1 09:30:49 INFO - blessings == 1.6 09:30:49 INFO - blobuploader == 1.2.4 09:30:49 INFO - docopt == 0.6.1 09:30:49 INFO - manifestparser == 1.1 09:30:49 INFO - mozInstall == 1.12 09:30:49 INFO - mozcrash == 0.17 09:30:49 INFO - mozdebug == 0.1 09:30:49 INFO - mozdevice == 0.48 09:30:49 INFO - mozfile == 1.2 09:30:49 INFO - mozhttpd == 0.7 09:30:49 INFO - mozinfo == 0.9 09:30:49 INFO - mozleak == 0.1 09:30:49 INFO - mozlog == 3.2 09:30:49 INFO - moznetwork == 0.27 09:30:49 INFO - mozprocess == 0.22 09:30:49 INFO - mozprofile == 0.28 09:30:49 INFO - mozrunner == 6.11 09:30:49 INFO - mozscreenshot == 0.1 09:30:49 INFO - mozsystemmonitor == 0.3 09:30:49 INFO - moztest == 0.7 09:30:49 INFO - mozversion == 1.4 09:30:49 INFO - psutil == 3.1.1 09:30:49 INFO - requests == 1.2.3 09:30:49 INFO - wsgiref == 0.1.2 09:30:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:49 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 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:49 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 09:30:49 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 09:30:49 INFO - Using env: {'DISPLAY': ':0', 09:30:49 INFO - 'HOME': '/home/cltbld', 09:30:49 INFO - 'LANG': 'en_US.UTF-8', 09:30:49 INFO - 'LANGUAGE': 'en_US:en', 09:30:49 INFO - 'LOGNAME': 'cltbld', 09:30:49 INFO - 'MAIL': '/var/mail/cltbld', 09:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:49 INFO - 'MOZ_NO_REMOTE': '1', 09:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:49 INFO - 'NO_EM_RESTART': '1', 09:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:49 INFO - 'PWD': '/builds/slave/test', 09:30:49 INFO - 'SHELL': '/bin/bash', 09:30:49 INFO - 'SHLVL': '1', 09:30:49 INFO - 'TERM': 'linux', 09:30:49 INFO - 'TMOUT': '86400', 09:30:49 INFO - 'USER': 'cltbld', 09:30:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:49 INFO - '_': '/tools/buildbot/bin/python'} 09:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 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)) 09:30:50 INFO - Cleaning up... 09:30:50 INFO - Return code: 0 09:30:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30: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', 'jsonschema'] in /builds/slave/test/build 09:30: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 jsonschema 09:30:50 INFO - Using env: {'DISPLAY': ':0', 09:30:50 INFO - 'HOME': '/home/cltbld', 09:30:50 INFO - 'LANG': 'en_US.UTF-8', 09:30:50 INFO - 'LANGUAGE': 'en_US:en', 09:30:50 INFO - 'LOGNAME': 'cltbld', 09:30:50 INFO - 'MAIL': '/var/mail/cltbld', 09:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:50 INFO - 'MOZ_NO_REMOTE': '1', 09:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:50 INFO - 'NO_EM_RESTART': '1', 09:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:50 INFO - 'PWD': '/builds/slave/test', 09:30:50 INFO - 'SHELL': '/bin/bash', 09:30:50 INFO - 'SHLVL': '1', 09:30:50 INFO - 'TERM': 'linux', 09:30:50 INFO - 'TMOUT': '86400', 09:30:50 INFO - 'USER': 'cltbld', 09:30:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:50 INFO - '_': '/tools/buildbot/bin/python'} 09:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:50 INFO - Downloading/unpacking jsonschema 09:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:52 INFO - warning: no files found matching '*.txt' 09:30:52 INFO - no previously-included directories found matching 'build' 09:30:52 INFO - no previously-included directories found matching 'dist' 09:30:52 INFO - no previously-included directories found matching '.git*' 09:30:52 INFO - Installing collected packages: jsonschema, functools32 09:30:52 INFO - Running setup.py install for functools32 09:30:52 INFO - warning: no files found matching '*.txt' 09:30:52 INFO - no previously-included directories found matching 'build' 09:30:52 INFO - no previously-included directories found matching 'dist' 09:30:52 INFO - no previously-included directories found matching '.git*' 09:30:52 INFO - Successfully installed jsonschema functools32 09:30:52 INFO - Cleaning up... 09:30:52 INFO - Return code: 0 09:30:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae420cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', '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 09:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:30:52 INFO - Using env: {'DISPLAY': ':0', 09:30:52 INFO - 'HOME': '/home/cltbld', 09:30:52 INFO - 'LANG': 'en_US.UTF-8', 09:30:52 INFO - 'LANGUAGE': 'en_US:en', 09:30:52 INFO - 'LOGNAME': 'cltbld', 09:30:52 INFO - 'MAIL': '/var/mail/cltbld', 09:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:52 INFO - 'MOZ_NO_REMOTE': '1', 09:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:52 INFO - 'NO_EM_RESTART': '1', 09:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:52 INFO - 'PWD': '/builds/slave/test', 09:30:52 INFO - 'SHELL': '/bin/bash', 09:30:52 INFO - 'SHLVL': '1', 09:30:52 INFO - 'TERM': 'linux', 09:30:52 INFO - 'TMOUT': '86400', 09:30:52 INFO - 'USER': 'cltbld', 09:30:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:52 INFO - '_': '/tools/buildbot/bin/python'} 09:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:52 INFO - Downloading/unpacking flake8 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:52 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 09:30:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:30:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:30:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:30:55 INFO - no previously-included directories found matching 'docs/_build' 09:30:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:30:55 INFO - Running setup.py install for pep8 09:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:30:55 INFO - no previously-included directories found matching 'docs/_build' 09:30:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:30:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:30:55 INFO - Cleaning up... 09:30:55 INFO - Return code: 0 09:30:55 INFO - Running post-action listener: _resource_record_post_action 09:30:55 INFO - Running post-action listener: _start_resource_monitoring 09:30:55 INFO - Starting resource monitoring. 09:30:55 INFO - ##### 09:30:55 INFO - ##### Finished create-virtualenv step (success) 09:30:55 INFO - ##### 09:30:55 INFO - ##### 09:30:55 INFO - ##### Running install step. 09:30:55 INFO - ##### 09:30:55 INFO - Running pre-action listener: _resource_record_pre_action 09:30:55 INFO - Running main action method: install 09:30:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:56 INFO - Reading from file tmpfile_stdout 09:30:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:56 INFO - Reading from file tmpfile_stdout 09:30:56 INFO - Output received: 09:30:56 INFO - Usage: mozinstall [options] installer 09:30:56 INFO - Options: 09:30:56 INFO - -h, --help show this help message and exit 09:30:56 INFO - -d DEST, --destination=DEST 09:30:56 INFO - Directory to install application into. [default: 09:30:56 INFO - "/builds/slave/test"] 09:30:56 INFO - --app=APP Application being installed. [default: firefox] 09:30:56 INFO - mkdir: /builds/slave/test/build/application 09:30:56 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'] 09:30:56 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 09:31:12 INFO - Reading from file tmpfile_stdout 09:31:12 INFO - Output received: 09:31:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:31:12 INFO - Running post-action listener: _resource_record_post_action 09:31:12 INFO - ##### 09:31:12 INFO - ##### Finished install step (success) 09:31:12 INFO - ##### 09:31:12 INFO - ##### 09:31:12 INFO - ##### Running run-tests step. 09:31:12 INFO - ##### 09:31:12 INFO - Running pre-action listener: _resource_record_pre_action 09:31:12 INFO - Running main action method: run_tests 09:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:12 INFO - Python 2.7.3 09:31:12 INFO - Return code: 0 09:31:12 INFO - grabbing minidump binary from tooltool 09:31:12 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')]} 09:31:12 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 0x1e439c0>, '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 0x1e448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:12 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 09:31:12 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 09:31:12 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 09:31:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:12 INFO - Return code: 0 09:31:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:31:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:31:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:31:13 INFO - Return code: 0 09:31:13 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/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:31:13 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/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:31:13 INFO - Using env: {'DISPLAY': ':0', 09:31:13 INFO - 'HOME': '/home/cltbld', 09:31:13 INFO - 'LANG': 'en_US.UTF-8', 09:31:13 INFO - 'LANGUAGE': 'en_US:en', 09:31:13 INFO - 'LOGNAME': 'cltbld', 09:31:13 INFO - 'MAIL': '/var/mail/cltbld', 09:31:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:13 INFO - 'MOZ_NO_REMOTE': '1', 09:31:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:13 INFO - 'NO_EM_RESTART': '1', 09:31:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:13 INFO - 'PWD': '/builds/slave/test', 09:31:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:13 INFO - 'SHELL': '/bin/bash', 09:31:13 INFO - 'SHLVL': '1', 09:31:13 INFO - 'TERM': 'linux', 09:31:13 INFO - 'TMOUT': '86400', 09:31:13 INFO - 'USER': 'cltbld', 09:31:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703', 09:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:13 INFO - '_': '/tools/buildbot/bin/python'} 09:31:13 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/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:31:13 INFO - mozversion application_buildid: 20160525063710 09:31:13 INFO - mozversion application_changeset: d6d4e8417d2fd71fdf47c319b7a217f6ace9d5a5 09:31:13 INFO - mozversion application_display_name: Nightly 09:31:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:13 INFO - mozversion application_name: Firefox 09:31:13 INFO - mozversion application_remotingname: firefox 09:31:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:31:13 INFO - mozversion application_vendor: Mozilla 09:31:13 INFO - mozversion application_version: 49.0a1 09:31:13 INFO - mozversion platform_buildid: 20160525063710 09:31:13 INFO - mozversion platform_changeset: d6d4e8417d2fd71fdf47c319b7a217f6ace9d5a5 09:31:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:31:13 INFO - mozversion platform_version: 49.0a1 09:31:13 INFO - using testdate: 1464193873 09:31:13 INFO - actual date: 1464193873 09:31:13 INFO - starting webserver on 'localhost:40531' 09:31:13 INFO - SUITE-START | Running 2 tests 09:31:13 INFO - TEST-START | dromaeo_css 09:31:13 INFO - operating with platform_type : linux_ 09:31:13 INFO - Initialising browser for dromaeo_css test... 09:31:13 INFO - TEST-INFO | started process 31860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ShjcH/profile http://localhost:40531/getInfo.html) 09:31:17 INFO - PROCESS | 31860 | 09:31:17 INFO - PROCESS | 31860 | (process:31927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:31:18 INFO - PROCESS | 31860 | __metrics Screen width/height:1600/1200 09:31:18 INFO - PROCESS | 31860 | colorDepth:24 09:31:18 INFO - PROCESS | 31860 | Browser inner width/height: 1024/697 09:31:18 INFO - PROCESS | 31860 | __metrics 09:31:19 ERROR - PROCESS | 31860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:31:20 INFO - TEST-INFO | 31860: exit 0 09:31:20 INFO - Browser initialized. 09:31:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:31:20 INFO - TEST-INFO | started process 31978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ShjcH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:21 INFO - PROCESS | 31978 | 09:31:21 INFO - PROCESS | 31978 | (process:32039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:31:31 INFO - PROCESS | 31978 | RSS: Main: 166481920 09:31:31 INFO - PROCESS | 31978 | 09:32:21 INFO - PROCESS | 31978 | 1464193941476 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] 09:34:28 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40531/tests/dromaeo/cssquery-ext.html) 09:34:30 INFO - PROCESS | 31978 | RSS: Main: 170041344 09:34:30 INFO - PROCESS | 31978 | 09:37:32 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-ext.html (next: http://localhost:40531/tests/dromaeo/cssquery-jquery.html) 09:37:32 INFO - PROCESS | 31978 | RSS: Main: 168939520 09:37:32 INFO - PROCESS | 31978 | 09:40:34 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40531/tests/dromaeo/cssquery-mootools.html) 09:40:35 INFO - PROCESS | 31978 | RSS: Main: 170471424 09:40:35 INFO - PROCESS | 31978 | 09:43:36 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40531/tests/dromaeo/cssquery-prototype.html) 09:43:37 INFO - PROCESS | 31978 | RSS: Main: 167907328 09:43:37 INFO - PROCESS | 31978 | 09:46:40 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40531/tests/dromaeo/cssquery-yui.html) 09:46:40 INFO - PROCESS | 31978 | RSS: Main: 169005056 09:46:40 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | Cycle 1(1): loaded http://localhost:40531/tests/dromaeo/cssquery-yui.html (next: http://localhost:40531/tests/dromaeo/cssquery-dojo.html) 09:49:43 INFO - PROCESS | 31978 | RSS: Main: 171208704 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | __start_tp_report 09:49:43 INFO - PROCESS | 31978 | _x_x_mozilla_page_load 09:49:43 INFO - PROCESS | 31978 | _x_x_mozilla_page_load_details 09:49:43 INFO - PROCESS | 31978 | |i|pagename|runs| 09:49:43 INFO - PROCESS | 31978 | |0;dojo.html;3117.8752849886005;3121.5005599104143;3137.8274194919277;3151.716345528902;3155.8737650493968;5405.567554595633;5410.8917821643545;5430.864228394292;5481.835544933649;5489.752961116749;5379.515843574078;5438.075527160382;5441.319835020622;5469.124940009599;5503.669779813204;4888.340074089988;4941.3329200558;5023.673461225027;5045.318881950926;5090.669106508084;834.1617481447792;4880.7071575705395;4963.925541116886;5013.924791128118;5014.774335154927;4984.102861484931;4993.925091123636;5001.17480615698;5024.974875125601;5038.8488345349515;5001.624878134118;5035.949640503622;5047.293378926916;5054.292399064134;5071.822486212965;4879.39007624047;4921.26181072842;4930.309756634074;4936.777844996984;4956;5332.920006199872;5369.570434365241;5388.946110538884;5406.864828379283;5411.891762164774;5687.004774164505;5767.711614419262;5770.480656740871;5773.39379365169;5800.680962547058;5886.205362276123;5896.852578685524;5921.934051870661;5964.284285885678;5995.910061349084;5465.781368745245;5466.180072989044;5468.26178465906;5522.337319521643;5524.867402182543;5873.383294754075;5929.169916211734;5950.851228719317;6063.878722425527;6076.179715738407;5719.571032172604;5720.742566584514;5727.140928860705;5729.1119876419225;5732.541396688255;5823.5341172706085;5860.765569377178;5878.206442130343;5882.705864706748;5898.203742494794;5740.626859254218;5754.625949313281;5800.970995144998;5804.4775970162045;5811.82564523065;5778.335491418541;5823.970880145572;5828.562857785683;5829.446202610745;5834.445727655866;4332.761698106571;4419.049904270533;4431.047324825178;4435.246008178618;4475.060237350193;3873.4770805941403;3894.435306880543;3923.3330333843314;3943.073377756225;3948.5853985331128;5535.58483113768;5587.888242235133;5612.719364031782;5682.261306030189;5689.715514224272;5767.769289228384;5918.171455996164;5950.047992321208;5952.077427998581;5954.732037058343;5565.582581306418;5621.128725047624;5633.971830140905;5652.8869422611315;5656.066748986454;4888.193448081027;4946.258061290835;4955.306257124005;4962.454130045692;4979.676321039121;5935.228420305332;6013.729382177812;6106.694665266719;6109.14471973924;6109.14471973924;5871.588988770745;5909;5940.435658612425;5957.523398128226;5962.105684147413;6034.698265086816;6053.273607167168;6061.878762424815;6075.513958883367;6090.604110732788;5632.127020311858;5706.657600543981;5725.656460612377;5807.796727114531;5810.883782324415;5861;5876.588638795414;5880.353161152356;5908.940910591011;5940.762369505172;5722.570807189394;5727.02640551099;5738.971305143615;5740.425957404394;5743.712814359349;5581.972090139523;5605.467480589337;5655.236543066633;5686.630369026166;5701.372848986691;5596.356419011703;5638.097904335286;5688.8577785554035;5704.087346024616;5744.080947048452;5735.082386818089;5746.9712651436475;5750.5112065474905;5774.682392468455;5792.986227410271;5554.944450555605;5589.972050139723;5604.775808967595;5680.289963754531;5686.60193786431 09:49:43 INFO - PROCESS | 31978 | |1;ext.html;585.1982783586487;635.0759644716937;644.9161608990828;657.4871600151881;674.2852576269158;39532.20935581287;40303;43109.13781724364;43199.568004319946;43289.35065974013;44533.554664453346;44750.77624611872;44922;44998.775006125004;45165.322520162226;8709.695160669378;8867.866981995276;8868.645254189825;8889.377743557954;8904.777380565472;8506.489610623352;8644.481331120121;8644.524551149685;8651.783705407352;8670.696525621604;8636.136386361344;8643.2653224476;8692.217700406962;8698.826023479527;8713.520756358397;8564.057953625097;8582.055973842873;8636.352273579476;8643.827123457528;8659.134086591353;8691.782705432415;8747.343949203772;8802.735917922408;8818.691345802867;8830.646774129027;41312.793436032625;41855.162896741895;42053.78973105115;42107.368389474184;42195.578044219474;3714.4428335749585;3769.2649933263024;3796.316663000659;3981.840726370942;4303.677224208197;31731.682683173105;32349.51475727866;32403.83798081018;33004.6699533004;34247.14382140442;4271.9359209611885;4304.677149213821;4307.181635489247;4310.224159651261;4377.802998865059;339931;340314;340704;341468;341925;50468.49531504638;55575.16637250444;57953.522788632814;58218.70890645604;58478.415215848145;55840.720796395755;60947.08579371313;61239;61447.385526144164;61456.385436145065;13053.673658158432;13118.803217951738;13155.276459794803;13188.736225275441;13202.603921882359;12148.939255303843;12222.572209972608;12272.693182670504;12331.630051098482;12333.444994975247;16440.917795410947;16453.177341132894;16479.176041197894;16502.83497165037;16568.337266509203;6465.838354041187;6514.413702766774;6532.869342613121;6577.14497115372;6681.866362672817;966.3380584299637;1023.4473384372355;1206.85517737872;1212.0788200967152;1268.5940499040403;31533.36933261322;31593.21016974594;31647.367052658818;31992.840035799672;32125.678743212735;1127.301073334538;1137.1982752159709;1229.9139060265875;1251.0992085698283;1254.8431446069242;16647.66704665924;16784.41254556085;16921.7461738074;16989.150542472828;17036.14819259032;486477;487781;492032;492740;494411;56541.717291414105;56584;56721;56762.432375675715;56954.145687814715;1399.524161784998;1414.1373762005169;1417.5322143692556;1437.9496717615043;1448.304813689435;30042.69957300399;31407.52888706717;31516.212094697818;31590.684093158776;31923.521147182346;48996.5100348992;52798.472015280895;54661.453385467226;55087.44912550983;59811;381956;385200;387653;388171;389322;26698;26759.19722408331;26776.33059173536;26880;27098.05156819502;45507.54492455033;45669.314960274955;45710.54289457063;45830.770846145555;46802.53197467982;39206.41190382204;39208.607913920496;40116.79941600273;40204;40255.1948961025;39102.217955641296;39384;39431.408528872664;39699.40450893297;40107.59892401155;34404.057480980955;39590.40614390729;42929.66568259734;43302;43424.78287608542;35571.82214088913;36131.277374451834;36756.632433676394;36946;37039.25921481609;28128.57807132854;28151.155465336073;28320.575191371732;28370.574441383807;28636.713632863404 09:49:43 INFO - PROCESS | 31978 | |2;jquery.html;382.9349010668188;386.59214528672237;394.1565050791306;400.8116185392864;407.67386091127094;18373.356932507366;19165.80834191661;19186.42440726777;19477.99999999998;19538.90230548847;17657.20542575584;18201.81798182018;18286.725699114522;18472.907635461805;18721.689481736285;5534.640248383852;5573.888522229553;5667.886642267152;5715.799947001856;5729.3411257705275;5437.755301011464;5554.361248456439;5571.247881536002;5589.944100558983;5596.300462442195;5436.157395603668;5453.15476101203;5502.449755024506;5506.724663766796;5532.474414930575;5420.512153906147;5496.587755918302;5500.954818584476;5556.583256255797;5595.104783234663;4890.535399137077;4939.135651261015;4943.258511223309;4945.109880221558;4993.226049962262;21902.89048554763;22014.669779953314;22350.2177423791;22487.100515979506;22531.549369012693;2334.568104900582;2362.362162216209;2370.3481542575755;2588.831725937808;2729.2630989632885;13478.595642130751;13886.236257005861;14024.929875350557;14102.576922692335;14623.488177913829;1907.2847682119204;1924.7786504552016;1975.782663906969;2022.2719820864477;2054.897255137237;75407.62296188538;78903;79098;79565.20434795636;80580.19419805786;8406.873896891551;9039.276857851357;9123.220971910547;9791.51042447889;9911.553980070914;12906.80639790404;12977.805332920014;12998.545050923361;13003.08978371505;13148.60554183376;7338.156112047183;7377.372923301579;7394.815129621803;7442.516236444614;7451.2921272479025;7258.491905566665;7266.781996540112;7295.306945840137;7354.852902942018;7393.706101432228;4008.118213992917;4118.670506359484;4124.154548317588;4129.215449064668;4209.116085622054;1858.5725283184943;1911.4838993471963;1967.5868067705942;1972.1322618048014;1972.378700709272;922.5802259971697;1029.6910926722103;1056.4084112896803;1070.7483741320784;1084.6312253833735;18876.33932812345;19537;19863;19887.60224795496;19898;974.1524873360222;995.7908839143861;1019.6380284998867;1023.97440063999;1049.9632512862013;9249.630014799333;10846.132309415229;11042.116630669527;11045.447727613588;11107;480663;485373;502256;505399;505535;101973.49013254886;103141;105541.47229263958;105828;106348;967.0812727908515;977.9217662586834;984.9359791613522;985.7929834734786;988.7775250568565;17160.48518544396;17307.221175047405;17337.393191238247;17417.738733919254;17773.289068437636;42055.3691694631;42502;43255.351169731846;43470.78264608657;43579.782101089295;55346.44653553574;60358.698206508685;61078.38921610727;61345.38654613575;62065.68967155135;8484.490930544187;8556.657733690583;8617.65529378843;8696.652133914573;8792.560371981248;9365.85951210746;13380.732385352043;13510.662233444242;13571.52499662507;13683.45266189381;11177.441127943408;11382.14633902444;11386.544538218379;11522.481488332878;11751.529938802352;11157.832632510681;11164.330140191614;11304.434778261219;11413.08695304357;11784.941075294568;11423.885761142283;11534.94232528832;11587.246828956091;11604.535818567163;11816.82274765862;7383.926160738324;7770;8400.87398689008;8485.193906578865;8553.315734741082;11677.474513647076;11683.357415342238;11772.17594768358;11815.113866459878;12006.879931200576 09:49:43 INFO - PROCESS | 31978 | |3;mootools.html;1461.9122852628843;1483.14719036554;1651.4467653336133;1788.09701100944;1821.4899828048142;7824.256695613922;8753.824923501526;8770.47377157371;9316.673916412936;9326.440413575181;8849.159329863653;9099.090090990898;9158.908410915888;9183.357164998453;9185.402948808323;2288.0275882749806;2298.9655155172686;2305.262316058862;2313.687652166961;2315.780000899912;2325.5581439526522;2339.9415014624688;2370.8814559272055;2379.119725701493;2380.155044959032;2285.874276914769;2330.615448451012;2338.485533182697;2358.882055897207;2376.6078597031556;2287.0737351372554;2297.4026753044245;2308.1113771198125;2310.7689231076924;2314.2131675230503;2277.7380601230907;2288.405014696191;2292.2779324512726;2292.495650956787;2301.8043466305385;8902.243309318716;9034.86447703285;9043.186113249772;9049.321300902458;9058.682946096855;4998;5062.0888240116765;5066.594672426197;5067.847964561069;5071.087204303224;3190.5483005232795;3390.3049874775857;3401.268727223634;3412.419888618916;3431.4852772084137;1146.776378606172;1155.133649762678;1155.4453862146133;1172.349346112907;1200.0579545057087;12327;12395.380230988414;12425.875741242653;12443.440045197987;12455.314957677325;4364.585364390377;4645.187092258841;4656.650751193674;4662.32396302541;4672.859814205579;9939.65211217604;9942.304038717364;9968.700938971842;9977.850332245021;9983.15143212835;5324.094903866352;5330.280412144389;5354.678719276856;5358.973205134027;5367.087595108841;4324.545922678137;4620.237660786;4785.736784476818;4951.603871690256;4972.825951091694;3885.0675837798726;3928.9981054830837;3999.8800035998966;4045.7572545646767;4116.217918595457;1181.8463599731979;1183.4319526627266;1184.934828584419;1194.8230992472409;1204.644629834201;983.9901600984042;1008.7175590834578;1017.5370206555999;1025.7640742629087;1042.4058286776465;6227.750889964442;6354.777582784581;6376.776812811622;6400.807975760735;6535.052417399451;965.5558443116245;982.7985263021063;996.0985308296003;1013.1641395848308;1021.6577446555339;4232.280512312914;4282.293421585404;4285.807138678767;4300.827966881352;4423.314386270134;10894.67315980522;11110.166737494721;11142.49858756358;11148.721281968015;11201.103911687045;10661.78676426467;10943.890561094446;10990.780184396268;11047.337159770439;11108.888911110947;8328.292095171857;8427.705030323908;8467.153284671484;8482.363822713198;8516.829663406821;6204.689765511796;6255.374462553708;6478.708458119301;6481.837954051187;6534.967325163534;10225.897741022793;10471.476426178813;10700.090492308242;10726.249162558857;10727.570897164025;10572.629957951434;10701.839472408075;10729.678109656723;10772.70727512672;10778.838317425088;7173.856522869409;7818.452708310364;8040;8057.879131813144;8260.091389946982;8861.91138088611;8908.10918908104;8950.597223125105;8984.05667404913;9028.548572571213;7481.70073197066;7803.843923121619;7849.882251766342;7875.724349647735;7884.172161922916;7460.179380268275;7669.616519173907;7677.884831727641;7808.648610812641;7815.062192536932;7117.928820711727;7182.676779545038;7327.523710958771;7339.74310899116;7373.5575865448245;5059.367579052619;5128.153854613947;5176.327077479904;5181.093308671043;5218.66078704883;5122.846314610568;5123.820666276662;5161.638685291993;5168.560672342893;5232.37211534603 09:49:43 INFO - PROCESS | 31978 | |4;prototype.html;307.7783995523224;323.68440770249003;324.8192819102563;324.8895375572305;326.2479983637715;5025.195968645008;5529.91705124423;5538.307711536058;5564.276644036279;5638.182463542794;5477.835664930059;5515.621094726318;5524.502794748471;5533.501984821365;5536.474034966682;4242.89392765181;4281.12236991416;4303.440552728141;4320.438343015404;4321.697481176319;4175.31107367284;4279.336702811053;4288.76411797351;4324.286492728712;4342.934855977162;4205.810738516759;4219.831206751726;4223.472065991751;4247.171801498694;4257.659387249028;4225.894352641178;4249.128928569636;4266.018815672382;4274.081072569397;4292.7209731367675;3627.383344831385;3676.74262801604;3699.5560532736245;3724.21237805852;3776.9433458498142;5417.3770016447825;5445.891082178374;5446.739603064723;5449.591280653927;5453.536449401806;4880.194767863299;4880.389951256093;4892.290617860391;4930.704157750546;4940.308356830046;5481.397046324901;5716.914246286309;5762.654240745569;5774.249347584829;5781.653100813965;4025.6175663311938;4061.6547593454297;4066.3900414937702;4086.7547947123267;4097.508299004109;5809.651420914759;5931.051031834929;6040.939590604125;6055.969720151371;6067.696615169224;4133.318002529549;4149.792510374469;4171.6036976487185;4174.227767862955;4185.016521117535;4240.745555266694;4244.363345498138;4246.681498887534;4258.1483703258855;4261.4673165854265;4568.17772800899;4901.4805410322915;4907.312976183337;4923.261510773341;4969.676970996874;5784.1902133701315;5799.594028417971;5801.3908539602735;5837.795677151279;5845.181674565564;1425.0879437160227;1428.6999730056596;1434.5337765226343;1434.978475322871;1442.5239670908575;902.4224496322358;917.5916717060977;926.3561824531886;934.275936149476;942.3497786527412;5028.396592408934;5043;5068;5092.719900405439;5115.488451154929;5244.868878277997;5323.604378029825;5333.626646134733;5398.676079435247;5409.810656627078;5098.388193416814;5149.9742501287255;5164.561012313995;5324.893502129936;5791.797287095016;3187;3192.329610781762;3202.807831530069;3212.823294718766;3227.5320078588475;6129.938700613026;6198.2252218472695;6218.81343559694;6223.657698826518;6249.750009999549;6005.879882402328;6029;6029.78895738647;6179.227596550431;6190.845228869314;6216.595921265103;6230.003199488151;6233.812985610439;6238.500919926395;6262.3111457739615;5712.927615454303;5936.703164841654;5941.613795103304;5991.310999235144;6037.215162028908;5958.285005799332;5980.850478738066;5986.191864098291;6016.488598469179;6025.969870150621;6009.7295621698;6053.424924632153;6221.751129954751;6239.1577137085915;6239.188905442264;4152.813123409514;4166.604172603597;4174.165166966558;4187.413762073251;4191.958080419279;5817.854553636193;6039.909401358896;6053;6064.787732429344;6075.878482430238;5783.277090363705;5807.0998995155815;5809.36097029318;5827.155062515996;5837.562182836219;5804.448577385142;5826.688994976096;5848.619839710405;5861.120831875252;5912.172295878667;5431.266778984945;5712.171735098471;5762.30852297727;5777.942220577908;5805.622634528742;5838.678872662044;5840.532757379485;5863.530917526673;5902.173695682522;5954.315253745702;5574.9721251393485;5730.226419433323;5763.538916886723;5782.5373970081455;5795.942040579709 09:49:43 INFO - PROCESS | 31978 | |5;yui.html;709.3757493405802;729.62424351459;748.9887651685226;756.8751156059251;762.2073044034205;13852.168869867803;13945.511907083253;14002.369893354798;14057.29713514324;14059.156450612945;13260.204387736743;13757.10578812379;13815.102018368823;13825.516106936258;13870.514531991383;682.2290811383131;817.5666896544841;823.8764185372212;833.4249367936135;833.72487079264;798.4371018432021;818.382121498268;821.6877586517145;828.2545708862042;831.2601784411878;869.821686554258;870.2254993056185;872.3500991761115;873.9519326437044;874.3092956564307;866.3805379153872;871.1201686296822;871.3682580129419;871.4509858788954;873.0134947509338;632.3107812484368;633.2464367402775;634.0742515926753;634.1534052040486;636.430394796659;14113.364898579588;14128.788068178985;14138.293085345795;14159.22124283164;14162.71674566503;13691.383887725076;13738.931305343509;13939.303034848319;14029.298535073205;14297.78553321701;11525.36610486423;11545.076393888552;11553.653390398302;11607.419629018515;11700.23948443357;3787.1478917243676;3917;4002.779847108408;4004.659603933669;4014.0767623446477;54590.72704636451;56412;56555.717221414045;56631.150532742045;58609.12086318708;10942.945285273523;11190.440477976068;11516.596919107791;11553.711157221136;12012.738662440317;19206;19302.32441864528;19350.903245483965;19417.611647766964;19463.513412164524;8103;8245.587720613945;8508.361872859561;8525.786855328666;8730.956345218234;4488.1472520221705;4516.683832131785;4520.819167233274;4543.704659197141;4571.451425828922;3262.5269335946628;3329.284203896174;3338.115399419156;3344.5819272590925;3372.342393233345;698.9709043432455;706.2972342519226;708.3801673535656;716.7491378017652;717.2648035763384;728.0971595221887;739.1241378965942;758.4842307231136;765.2691679446116;795.0737390939606;9273.814523709489;9405.811883762422;9627.759306017406;9776.560054797408;9780.755481113029;702.2065066474953;708.5111273221461;743.0674503498076;767.6315368623092;787.9724209652635;4302.591253830881;4754.904901902012;4757.286407038971;4831.516848315211;4861.490751140614;73265;73826;73849.63075184589;74417;74868.25131748612;65594.34405655978;66729;66871;68557.3144268551;68590.31409685839;61012;62059.379406206266;62723.05915411272;62806;63239.36760632427;9029.41308814925;9075.727728168165;9101.863472047793;9140.223081038186;9167.541622918961;40508.1898362037;40656.39015414831;41296.1740765189;41356.1728765417;41714.79142604268;50200.042955542296;57047.71476142759;57166.7141664289;57253.713731431075;57327.42672573388;11392.25950313227;11448.198626096093;11472.541098355972;11663.650090497298;11859.94070029679;12762.872371276168;12820.294883781482;12868;12949.352532373532;13026;12208.755824883276;12376.876231237573;12377.566785162477;12507.17899289345;12642.115051946275;11936.10479214045;12063.698407539881;12104.394780261127;12260.203086799329;12575.811362829749;10958.671239862817;12418.937905310415;12860.2926839021;13082.149660272053;13170.275634840176;10623.628173013907;10845.349279043283;10879.945600272265;10921.453927303444;10934.945325273322;10224.642137525449;10368.781947388106;10378.42918639482;10410.843837342294;10519 09:49:43 INFO - PROCESS | 31978 | __end_tp_report 09:49:43 INFO - PROCESS | 31978 | __start_cc_report 09:49:43 INFO - PROCESS | 31978 | _x_x_mozilla_cycle_collect,340 09:49:43 INFO - PROCESS | 31978 | __end_cc_report 09:49:43 INFO - PROCESS | 31978 | __startTimestamp1464194983766__endTimestamp 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | ------- Summary: start ------- 09:49:43 INFO - PROCESS | 31978 | Number of tests: 6 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#0] dojo.html Cycles:165 Average:5407.07 Median:5682.26 stddev:724.86 (12.8%) stddev-sans-first:704.49 09:49:43 INFO - PROCESS | 31978 | Values: 3117.9 3121.5 3137.8 3151.7 3155.9 5405.6 5410.9 5430.9 5481.8 5489.8 5379.5 5438.1 5441.3 5469.1 5503.7 4888.3 4941.3 5023.7 5045.3 5090.7 834.2 4880.7 4963.9 5013.9 5014.8 4984.1 4993.9 5001.2 5025.0 5038.8 5001.6 5035.9 5047.3 5054.3 5071.8 4879.4 4921.3 4930.3 4936.8 4956.0 5332.9 5369.6 5388.9 5406.9 5411.9 5687.0 5767.7 5770.5 5773.4 5800.7 5886.2 5896.9 5921.9 5964.3 5995.9 5465.8 5466.2 5468.3 5522.3 5524.9 5873.4 5929.2 5950.9 6063.9 6076.2 5719.6 5720.7 5727.1 5729.1 5732.5 5823.5 5860.8 5878.2 5882.7 5898.2 5740.6 5754.6 5801.0 5804.5 5811.8 5778.3 5824.0 5828.6 5829.4 5834.4 4332.8 4419.0 4431.0 4435.2 4475.1 3873.5 3894.4 3923.3 3943.1 3948.6 5535.6 5587.9 5612.7 5682.3 5689.7 5767.8 5918.2 5950.0 5952.1 5954.7 5565.6 5621.1 5634.0 5652.9 5656.1 4888.2 4946.3 4955.3 4962.5 4979.7 5935.2 6013.7 6106.7 6109.1 6109.1 5871.6 5909.0 5940.4 5957.5 5962.1 6034.7 6053.3 6061.9 6075.5 6090.6 5632.1 5706.7 5725.7 5807.8 5810.9 5861.0 5876.6 5880.4 5908.9 5940.8 5722.6 5727.0 5739.0 5740.4 5743.7 5582.0 5605.5 5655.2 5686.6 5701.4 5596.4 5638.1 5688.9 5704.1 5744.1 5735.1 5747.0 5750.5 5774.7 5793.0 5554.9 5590.0 5604.8 5680.3 5686.6 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#1] ext.html Cycles:180 Average:56914.95 Median:40279.10 stddev:108621.76 (269.7%) stddev-sans-first:108844.14 09:49:43 INFO - PROCESS | 31978 | Values: 585.2 635.1 644.9 657.5 674.3 39532.2 40303.0 43109.1 43199.6 43289.4 44533.6 44750.8 44922.0 44998.8 45165.3 8709.7 8867.9 8868.6 8889.4 8904.8 8506.5 8644.5 8644.5 8651.8 8670.7 8636.1 8643.3 8692.2 8698.8 8713.5 8564.1 8582.1 8636.4 8643.8 8659.1 8691.8 8747.3 8802.7 8818.7 8830.6 41312.8 41855.2 42053.8 42107.4 42195.6 3714.4 3769.3 3796.3 3981.8 4303.7 31731.7 32349.5 32403.8 33004.7 34247.1 4271.9 4304.7 4307.2 4310.2 4377.8 339931.0 340314.0 340704.0 341468.0 341925.0 50468.5 55575.2 57953.5 58218.7 58478.4 55840.7 60947.1 61239.0 61447.4 61456.4 13053.7 13118.8 13155.3 13188.7 13202.6 12148.9 12222.6 12272.7 12331.6 12333.4 16440.9 16453.2 16479.2 16502.8 16568.3 6465.8 6514.4 6532.9 6577.1 6681.9 966.3 1023.4 1206.9 1212.1 1268.6 31533.4 31593.2 31647.4 31992.8 32125.7 1127.3 1137.2 1229.9 1251.1 1254.8 16647.7 16784.4 16921.7 16989.2 17036.1 486477.0 487781.0 492032.0 492740.0 494411.0 56541.7 56584.0 56721.0 56762.4 56954.1 1399.5 1414.1 1417.5 1437.9 1448.3 30042.7 31407.5 31516.2 31590.7 31923.5 48996.5 52798.5 54661.5 55087.4 59811.0 381956.0 385200.0 387653.0 388171.0 389322.0 26698.0 26759.2 26776.3 26880.0 27098.1 45507.5 45669.3 45710.5 45830.8 46802.5 39206.4 39208.6 40116.8 40204.0 40255.2 39102.2 39384.0 39431.4 39699.4 40107.6 34404.1 39590.4 42929.7 43302.0 43424.8 35571.8 36131.3 36756.6 36946.0 37039.3 28128.6 28151.2 28320.6 28370.6 28636.7 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#2] jquery.html Cycles:180 Average:29366.30 Median:384.76 stddev:82065.02 (21328.7%) stddev-sans-first:82266.37 09:49:43 INFO - PROCESS | 31978 | Values: 382.9 386.6 394.2 400.8 407.7 18373.4 19165.8 19186.4 19478.0 19538.9 17657.2 18201.8 18286.7 18472.9 18721.7 5534.6 5573.9 5667.9 5715.8 5729.3 5437.8 5554.4 5571.2 5589.9 5596.3 5436.2 5453.2 5502.4 5506.7 5532.5 5420.5 5496.6 5501.0 5556.6 5595.1 4890.5 4939.1 4943.3 4945.1 4993.2 21902.9 22014.7 22350.2 22487.1 22531.5 2334.6 2362.4 2370.3 2588.8 2729.3 13478.6 13886.2 14024.9 14102.6 14623.5 1907.3 1924.8 1975.8 2022.3 2054.9 75407.6 78903.0 79098.0 79565.2 80580.2 8406.9 9039.3 9123.2 9791.5 9911.6 12906.8 12977.8 12998.5 13003.1 13148.6 7338.2 7377.4 7394.8 7442.5 7451.3 7258.5 7266.8 7295.3 7354.9 7393.7 4008.1 4118.7 4124.2 4129.2 4209.1 1858.6 1911.5 1967.6 1972.1 1972.4 922.6 1029.7 1056.4 1070.7 1084.6 18876.3 19537.0 19863.0 19887.6 19898.0 974.2 995.8 1019.6 1024.0 1050.0 9249.6 10846.1 11042.1 11045.4 11107.0 480663.0 485373.0 502256.0 505399.0 505535.0 101973.5 103141.0 105541.5 105828.0 106348.0 967.1 977.9 984.9 985.8 988.8 17160.5 17307.2 17337.4 17417.7 17773.3 42055.4 42502.0 43255.4 43470.8 43579.8 55346.4 60358.7 61078.4 61345.4 62065.7 8484.5 8556.7 8617.7 8696.7 8792.6 9365.9 13380.7 13510.7 13571.5 13683.5 11177.4 11382.1 11386.5 11522.5 11751.5 11157.8 11164.3 11304.4 11413.1 11784.9 11423.9 11534.9 11587.2 11604.5 11816.8 7383.9 7770.0 8400.9 8485.2 8553.3 11677.5 11683.4 11772.2 11815.1 12006.9 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#3] mootools.html Cycles:180 Average:5908.19 Median:4659.49 stddev:3370.46 (72.3%) stddev-sans-first:3363.35 09:49:43 INFO - PROCESS | 31978 | Values: 1461.9 1483.1 1651.4 1788.1 1821.5 7824.3 8753.8 8770.5 9316.7 9326.4 8849.2 9099.1 9158.9 9183.4 9185.4 2288.0 2299.0 2305.3 2313.7 2315.8 2325.6 2339.9 2370.9 2379.1 2380.2 2285.9 2330.6 2338.5 2358.9 2376.6 2287.1 2297.4 2308.1 2310.8 2314.2 2277.7 2288.4 2292.3 2292.5 2301.8 8902.2 9034.9 9043.2 9049.3 9058.7 4998.0 5062.1 5066.6 5067.8 5071.1 3190.5 3390.3 3401.3 3412.4 3431.5 1146.8 1155.1 1155.4 1172.3 1200.1 12327.0 12395.4 12425.9 12443.4 12455.3 4364.6 4645.2 4656.7 4662.3 4672.9 9939.7 9942.3 9968.7 9977.9 9983.2 5324.1 5330.3 5354.7 5359.0 5367.1 4324.5 4620.2 4785.7 4951.6 4972.8 3885.1 3929.0 3999.9 4045.8 4116.2 1181.8 1183.4 1184.9 1194.8 1204.6 984.0 1008.7 1017.5 1025.8 1042.4 6227.8 6354.8 6376.8 6400.8 6535.1 965.6 982.8 996.1 1013.2 1021.7 4232.3 4282.3 4285.8 4300.8 4423.3 10894.7 11110.2 11142.5 11148.7 11201.1 10661.8 10943.9 10990.8 11047.3 11108.9 8328.3 8427.7 8467.2 8482.4 8516.8 6204.7 6255.4 6478.7 6481.8 6535.0 10225.9 10471.5 10700.1 10726.2 10727.6 10572.6 10701.8 10729.7 10772.7 10778.8 7173.9 7818.5 8040.0 8057.9 8260.1 8861.9 8908.1 8950.6 8984.1 9028.5 7481.7 7803.8 7849.9 7875.7 7884.2 7460.2 7669.6 7677.9 7808.6 7815.1 7117.9 7182.7 7327.5 7339.7 7373.6 5059.4 5128.2 5176.3 5181.1 5218.7 5122.8 5123.8 5161.6 5168.6 5232.4 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#4] prototype.html Cycles:180 Average:4841.13 Median:5465.69 stddev:1447.36 (26.5%) stddev-sans-first:1410.86 09:49:43 INFO - PROCESS | 31978 | Values: 307.8 323.7 324.8 324.9 326.2 5025.2 5529.9 5538.3 5564.3 5638.2 5477.8 5515.6 5524.5 5533.5 5536.5 4242.9 4281.1 4303.4 4320.4 4321.7 4175.3 4279.3 4288.8 4324.3 4342.9 4205.8 4219.8 4223.5 4247.2 4257.7 4225.9 4249.1 4266.0 4274.1 4292.7 3627.4 3676.7 3699.6 3724.2 3776.9 5417.4 5445.9 5446.7 5449.6 5453.5 4880.2 4880.4 4892.3 4930.7 4940.3 5481.4 5716.9 5762.7 5774.2 5781.7 4025.6 4061.7 4066.4 4086.8 4097.5 5809.7 5931.1 6040.9 6056.0 6067.7 4133.3 4149.8 4171.6 4174.2 4185.0 4240.7 4244.4 4246.7 4258.1 4261.5 4568.2 4901.5 4907.3 4923.3 4969.7 5784.2 5799.6 5801.4 5837.8 5845.2 1425.1 1428.7 1434.5 1435.0 1442.5 902.4 917.6 926.4 934.3 942.3 5028.4 5043.0 5068.0 5092.7 5115.5 5244.9 5323.6 5333.6 5398.7 5409.8 5098.4 5150.0 5164.6 5324.9 5791.8 3187.0 3192.3 3202.8 3212.8 3227.5 6129.9 6198.2 6218.8 6223.7 6249.8 6005.9 6029.0 6029.8 6179.2 6190.8 6216.6 6230.0 6233.8 6238.5 6262.3 5712.9 5936.7 5941.6 5991.3 6037.2 5958.3 5980.9 5986.2 6016.5 6026.0 6009.7 6053.4 6221.8 6239.2 6239.2 4152.8 4166.6 4174.2 4187.4 4192.0 5817.9 6039.9 6053.0 6064.8 6075.9 5783.3 5807.1 5809.4 5827.2 5837.6 5804.4 5826.7 5848.6 5861.1 5912.2 5431.3 5712.2 5762.3 5777.9 5805.6 5838.7 5840.5 5863.5 5902.2 5954.3 5575.0 5730.2 5763.5 5782.5 5795.9 09:49:43 INFO - PROCESS | 31978 | 09:49:43 INFO - PROCESS | 31978 | [#5] yui.html Cycles:180 Average:16350.65 Median:4663.18 stddev:20476.15 (439.1%) stddev-sans-first:20499.90 09:49:43 INFO - PROCESS | 31978 | Values: 709.4 729.6 749.0 756.9 762.2 13852.2 13945.5 14002.4 14057.3 14059.2 13260.2 13757.1 13815.1 13825.5 13870.5 682.2 817.6 823.9 833.4 833.7 798.4 818.4 821.7 828.3 831.3 869.8 870.2 872.4 874.0 874.3 866.4 871.1 871.4 871.5 873.0 632.3 633.2 634.1 634.2 636.4 14113.4 14128.8 14138.3 14159.2 14162.7 13691.4 13738.9 13939.3 14029.3 14297.8 11525.4 11545.1 11553.7 11607.4 11700.2 3787.1 3917.0 4002.8 4004.7 4014.1 54590.7 56412.0 56555.7 56631.2 58609.1 10942.9 11190.4 11516.6 11553.7 12012.7 19206.0 19302.3 19350.9 19417.6 19463.5 8103.0 8245.6 8508.4 8525.8 8731.0 4488.1 4516.7 4520.8 4543.7 4571.5 3262.5 3329.3 3338.1 3344.6 3372.3 699.0 706.3 708.4 716.7 717.3 728.1 739.1 758.5 765.3 795.1 9273.8 9405.8 9627.8 9776.6 9780.8 702.2 708.5 743.1 767.6 788.0 4302.6 4754.9 4757.3 4831.5 4861.5 73265.0 73826.0 73849.6 74417.0 74868.3 65594.3 66729.0 66871.0 68557.3 68590.3 61012.0 62059.4 62723.1 62806.0 63239.4 9029.4 9075.7 9101.9 9140.2 9167.5 40508.2 40656.4 41296.2 41356.2 41714.8 50200.0 57047.7 57166.7 57253.7 57327.4 11392.3 11448.2 11472.5 11663.7 11859.9 12762.9 12820.3 12868.0 12949.4 13026.0 12208.8 12376.9 12377.6 12507.2 12642.1 11936.1 12063.7 12104.4 12260.2 12575.8 10958.7 12418.9 12860.3 13082.1 13170.3 10623.6 10845.3 10879.9 10921.5 10934.9 10224.6 10368.8 10378.4 10410.8 10519.0 09:49:43 INFO - PROCESS | 31978 | -------- Summary: end -------- 09:49:43 INFO - PROCESS | 31978 | 09:49:44 INFO - TEST-INFO | 31978: exit 0 09:49:44 INFO - TEST-OK | dromaeo_css | took 1110575ms 09:49:44 INFO - TEST-START | kraken 09:49:44 INFO - operating with platform_type : linux_ 09:49:44 INFO - Initialising browser for kraken test... 09:49:44 INFO - TEST-INFO | started process 32205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxUXtj/profile http://localhost:40531/getInfo.html) 09:49:48 INFO - PROCESS | 32205 | 09:49:48 INFO - PROCESS | 32205 | (process:32273): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:49:49 INFO - PROCESS | 32205 | __metrics Screen width/height:1600/1200 09:49:49 INFO - PROCESS | 32205 | colorDepth:24 09:49:49 INFO - PROCESS | 32205 | Browser inner width/height: 1024/697 09:49:49 INFO - PROCESS | 32205 | __metrics 09:49:49 ERROR - PROCESS | 32205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:49:50 INFO - TEST-INFO | 32205: exit 0 09:49:50 INFO - Browser initialized. 09:49:50 INFO - Running cycle 1/1 for kraken test... 09:49:50 INFO - TEST-INFO | started process 32324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxUXtj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:52 INFO - PROCESS | 32324 | 09:49:52 INFO - PROCESS | 32324 | (process:32385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:50:02 INFO - PROCESS | 32324 | RSS: Main: 166006784 09:50:02 INFO - PROCESS | 32324 | 09:50:04 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40531/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:05 INFO - PROCESS | 32324 | RSS: Main: 171003904 09:50:05 INFO - PROCESS | 32324 | 09:50:08 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40531/tests/kraken/driver.html?testName=audio-dft) 09:50:09 INFO - PROCESS | 32324 | RSS: Main: 171663360 09:50:09 INFO - PROCESS | 32324 | 09:50:11 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40531/tests/kraken/driver.html?testName=audio-fft) 09:50:12 INFO - PROCESS | 32324 | RSS: Main: 165842944 09:50:12 INFO - PROCESS | 32324 | 09:50:14 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40531/tests/kraken/driver.html?testName=audio-oscillator) 09:50:15 INFO - PROCESS | 32324 | RSS: Main: 165957632 09:50:15 INFO - PROCESS | 32324 | 09:50:17 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:18 INFO - PROCESS | 32324 | RSS: Main: 166100992 09:50:18 INFO - PROCESS | 32324 | 09:50:21 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40531/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:21 INFO - PROCESS | 32324 | RSS: Main: 166240256 09:50:21 INFO - PROCESS | 32324 | 09:50:25 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40531/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:25 INFO - PROCESS | 32324 | RSS: Main: 166211584 09:50:25 INFO - PROCESS | 32324 | 09:50:28 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40531/tests/kraken/driver.html?testName=json-parse-financial) 09:50:29 INFO - PROCESS | 32324 | RSS: Main: 166965248 09:50:29 INFO - PROCESS | 32324 | 09:50:30 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:31 INFO - PROCESS | 32324 | RSS: Main: 166789120 09:50:31 INFO - PROCESS | 32324 | 09:50:33 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:33 INFO - PROCESS | 32324 | RSS: Main: 166785024 09:50:33 INFO - PROCESS | 32324 | 09:50:35 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:36 INFO - PROCESS | 32324 | RSS: Main: 167088128 09:50:36 INFO - PROCESS | 32324 | 09:50:39 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:39 INFO - PROCESS | 32324 | RSS: Main: 167141376 09:50:39 INFO - PROCESS | 32324 | 09:50:42 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:43 INFO - PROCESS | 32324 | RSS: Main: 166936576 09:50:43 INFO - PROCESS | 32324 | 09:50:44 INFO - PROCESS | 32324 | Cycle 1(1): loaded http://localhost:40531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40531/tests/kraken/driver.html?testName=ai-astar) 09:50:45 INFO - PROCESS | 32324 | RSS: Main: 168677376 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | __start_tp_report 09:50:45 INFO - PROCESS | 32324 | _x_x_mozilla_page_load 09:50:45 INFO - PROCESS | 32324 | _x_x_mozilla_page_load_details 09:50:45 INFO - PROCESS | 32324 | |i|pagename|runs| 09:50:45 INFO - PROCESS | 32324 | |0;ai-astar;112;106;110;113;113;113;111;111;111;112 09:50:45 INFO - PROCESS | 32324 | |1;audio-beat-detection;155;127;155;183;124;156;153;129;180;132 09:50:45 INFO - PROCESS | 32324 | |2;audio-dft;162;160;162;167;162;165;173;163;162;162 09:50:45 INFO - PROCESS | 32324 | |3;audio-fft;76;76;76;158;76;75;79;75;167;77 09:50:45 INFO - PROCESS | 32324 | |4;audio-oscillator;82;84;138;84;84;83;143;83;83;138 09:50:45 INFO - PROCESS | 32324 | |5;imaging-gaussian-blur;117;118;117;117;119;117;117;118;118;118 09:50:45 INFO - PROCESS | 32324 | |6;imaging-darkroom;147;148;147;147;147;147;147;147;147;147 09:50:45 INFO - PROCESS | 32324 | |7;imaging-desaturate;96;96;97;97;95;96;95;96;95;95 09:50:45 INFO - PROCESS | 32324 | |8;json-parse-financial;55;56;56;55;58;59;56;70;53;58 09:50:45 INFO - PROCESS | 32324 | |9;json-stringify-tinderbox;62;62;61;62;62;64;64;63;63;63 09:50:45 INFO - PROCESS | 32324 | |10;stanford-crypto-aes;80;80;80;79;82;81;81;83;82;83 09:50:45 INFO - PROCESS | 32324 | |11;stanford-crypto-ccm;126;133;121;128;121;128;122;127;163;139 09:50:45 INFO - PROCESS | 32324 | |12;stanford-crypto-pbkdf2;169;162;164;163;165;165;164;170;163;165 09:50:45 INFO - PROCESS | 32324 | |13;stanford-crypto-sha256-iterative;69;66;64;66;63;65;70;62;62;62 09:50:45 INFO - PROCESS | 32324 | __end_tp_report 09:50:45 INFO - PROCESS | 32324 | __start_cc_report 09:50:45 INFO - PROCESS | 32324 | _x_x_mozilla_cycle_collect,921 09:50:45 INFO - PROCESS | 32324 | __end_cc_report 09:50:45 INFO - PROCESS | 32324 | __startTimestamp1464195045191__endTimestamp 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | ------- Summary: start ------- 09:50:45 INFO - PROCESS | 32324 | Number of tests: 14 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.10 (1.9%) stddev-sans-first:2.20 09:50:45 INFO - PROCESS | 32324 | Values: 112.0 106.0 110.0 113.0 113.0 113.0 111.0 111.0 111.0 112.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.00 stddev:21.21 (13.7%) stddev-sans-first:22.40 09:50:45 INFO - PROCESS | 32324 | Values: 155.0 127.0 155.0 183.0 124.0 156.0 153.0 129.0 180.0 132.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#2] audio-dft Cycles:10 Average:163.80 Median:162.50 stddev:3.77 (2.3%) stddev-sans-first:3.94 09:50:45 INFO - PROCESS | 32324 | Values: 162.0 160.0 162.0 167.0 162.0 165.0 173.0 163.0 162.0 162.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.45 (48.0%) stddev-sans-first:38.10 09:50:45 INFO - PROCESS | 32324 | Values: 76.0 76.0 76.0 158.0 76.0 75.0 79.0 75.0 167.0 77.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:83.00 stddev:27.28 (32.9%) stddev-sans-first:28.12 09:50:45 INFO - PROCESS | 32324 | Values: 82.0 84.0 138.0 84.0 84.0 83.0 143.0 83.0 83.0 138.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 09:50:45 INFO - PROCESS | 32324 | Values: 117.0 118.0 117.0 117.0 119.0 117.0 117.0 118.0 118.0 118.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 09:50:45 INFO - PROCESS | 32324 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:50:45 INFO - PROCESS | 32324 | Values: 96.0 96.0 97.0 97.0 95.0 96.0 95.0 96.0 95.0 95.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:4.70 (8.2%) stddev-sans-first:4.88 09:50:45 INFO - PROCESS | 32324 | Values: 55.0 56.0 56.0 55.0 58.0 59.0 56.0 70.0 53.0 58.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 09:50:45 INFO - PROCESS | 32324 | Values: 62.0 62.0 61.0 62.0 62.0 64.0 64.0 63.0 63.0 63.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.37 (1.7%) stddev-sans-first:1.39 09:50:45 INFO - PROCESS | 32324 | Values: 80.0 80.0 80.0 79.0 82.0 81.0 81.0 83.0 82.0 83.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:128.00 stddev:12.61 (9.9%) stddev-sans-first:13.26 09:50:45 INFO - PROCESS | 32324 | Values: 126.0 133.0 121.0 128.0 121.0 128.0 122.0 127.0 163.0 139.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.30 09:50:45 INFO - PROCESS | 32324 | Values: 169.0 162.0 164.0 163.0 165.0 165.0 164.0 170.0 163.0 165.0 09:50:45 INFO - PROCESS | 32324 | 09:50:45 INFO - PROCESS | 32324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.88 (4.4%) stddev-sans-first:2.65 09:50:45 INFO - PROCESS | 32324 | Values: 69.0 66.0 64.0 66.0 63.0 65.0 70.0 62.0 62.0 62.0 09:50:45 INFO - PROCESS | 32324 | -------- Summary: end -------- 09:50:45 INFO - PROCESS | 32324 | 09:50:46 INFO - TEST-INFO | 32324: exit 0 09:50:46 INFO - TEST-OK | kraken | took 61665ms 09:50:46 INFO - SUITE-END | took 1172s 09:50:46 INFO - Completed test suite (00:19:32) 09:50:46 INFO - javascript benchmark 09:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7192.334880182289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.8752849886005, 3121.5005599104143, 3137.8274194919277, 3151.716345528902, 3155.8737650493968, 5405.567554595633, 5410.8917821643545, 5430.864228394292, 5481.835544933649, 5489.752961116749, 5379.515843574078, 5438.075527160382, 5441.319835020622, 5469.124940009599, 5503.669779813204, 4888.340074089988, 4941.3329200558, 5023.673461225027, 5045.318881950926, 5090.669106508084, 834.1617481447792, 4880.7071575705395, 4963.925541116886, 5013.924791128118, 5014.774335154927, 4984.102861484931, 4993.925091123636, 5001.17480615698, 5024.974875125601, 5038.8488345349515, 5001.624878134118, 5035.949640503622, 5047.293378926916, 5054.292399064134, 5071.822486212965, 4879.39007624047, 4921.26181072842, 4930.309756634074, 4936.777844996984, 4956.0, 5332.920006199872, 5369.570434365241, 5388.946110538884, 5406.864828379283, 5411.891762164774, 5687.004774164505, 5767.711614419262, 5770.480656740871, 5773.39379365169, 5800.680962547058, 5886.205362276123, 5896.852578685524, 5921.934051870661, 5964.284285885678, 5995.910061349084, 5465.781368745245, 5466.180072989044, 5468.26178465906, 5522.337319521643, 5524.867402182543, 5873.383294754075, 5929.169916211734, 5950.851228719317, 6063.878722425527, 6076.179715738407, 5719.571032172604, 5720.742566584514, 5727.140928860705, 5729.1119876419225, 5732.541396688255, 5823.5341172706085, 5860.765569377178, 5878.206442130343, 5882.705864706748, 5898.203742494794, 5740.626859254218, 5754.625949313281, 5800.970995144998, 5804.4775970162045, 5811.82564523065, 5778.335491418541, 5823.970880145572, 5828.562857785683, 5829.446202610745, 5834.445727655866, 4332.761698106571, 4419.049904270533, 4431.047324825178, 4435.246008178618, 4475.060237350193, 3873.4770805941403, 3894.435306880543, 3923.3330333843314, 3943.073377756225, 3948.5853985331128, 5535.58483113768, 5587.888242235133, 5612.719364031782, 5682.261306030189, 5689.715514224272, 5767.769289228384, 5918.171455996164, 5950.047992321208, 5952.077427998581, 5954.732037058343, 5565.582581306418, 5621.128725047624, 5633.971830140905, 5652.8869422611315, 5656.066748986454, 4888.193448081027, 4946.258061290835, 4955.306257124005, 4962.454130045692, 4979.676321039121, 5935.228420305332, 6013.729382177812, 6106.694665266719, 6109.14471973924, 6109.14471973924, 5871.588988770745, 5909.0, 5940.435658612425, 5957.523398128226, 5962.105684147413, 6034.698265086816, 6053.273607167168, 6061.878762424815, 6075.513958883367, 6090.604110732788, 5632.127020311858, 5706.657600543981, 5725.656460612377, 5807.796727114531, 5810.883782324415, 5861.0, 5876.588638795414, 5880.353161152356, 5908.940910591011, 5940.762369505172, 5722.570807189394, 5727.02640551099, 5738.971305143615, 5740.425957404394, 5743.712814359349, 5581.972090139523, 5605.467480589337, 5655.236543066633, 5686.630369026166, 5701.372848986691, 5596.356419011703, 5638.097904335286, 5688.8577785554035, 5704.087346024616, 5744.080947048452, 5735.082386818089, 5746.9712651436475, 5750.5112065474905, 5774.682392468455, 5792.986227410271, 5554.944450555605, 5589.972050139723, 5604.775808967595, 5680.289963754531, 5686.60193786431], "value": 5358.591160450655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.1982783586487, 635.0759644716937, 644.9161608990828, 657.4871600151881, 674.2852576269158, 39532.20935581287, 40303.0, 43109.13781724364, 43199.568004319946, 43289.35065974013, 44533.554664453346, 44750.77624611872, 44922.0, 44998.775006125004, 45165.322520162226, 8709.695160669378, 8867.866981995276, 8868.645254189825, 8889.377743557954, 8904.777380565472, 8506.489610623352, 8644.481331120121, 8644.524551149685, 8651.783705407352, 8670.696525621604, 8636.136386361344, 8643.2653224476, 8692.217700406962, 8698.826023479527, 8713.520756358397, 8564.057953625097, 8582.055973842873, 8636.352273579476, 8643.827123457528, 8659.134086591353, 8691.782705432415, 8747.343949203772, 8802.735917922408, 8818.691345802867, 8830.646774129027, 41312.793436032625, 41855.162896741895, 42053.78973105115, 42107.368389474184, 42195.578044219474, 3714.4428335749585, 3769.2649933263024, 3796.316663000659, 3981.840726370942, 4303.677224208197, 31731.682683173105, 32349.51475727866, 32403.83798081018, 33004.6699533004, 34247.14382140442, 4271.9359209611885, 4304.677149213821, 4307.181635489247, 4310.224159651261, 4377.802998865059, 339931.0, 340314.0, 340704.0, 341468.0, 341925.0, 50468.49531504638, 55575.16637250444, 57953.522788632814, 58218.70890645604, 58478.415215848145, 55840.720796395755, 60947.08579371313, 61239.0, 61447.385526144164, 61456.385436145065, 13053.673658158432, 13118.803217951738, 13155.276459794803, 13188.736225275441, 13202.603921882359, 12148.939255303843, 12222.572209972608, 12272.693182670504, 12331.630051098482, 12333.444994975247, 16440.917795410947, 16453.177341132894, 16479.176041197894, 16502.83497165037, 16568.337266509203, 6465.838354041187, 6514.413702766774, 6532.869342613121, 6577.14497115372, 6681.866362672817, 966.3380584299637, 1023.4473384372355, 1206.85517737872, 1212.0788200967152, 1268.5940499040403, 31533.36933261322, 31593.21016974594, 31647.367052658818, 31992.840035799672, 32125.678743212735, 1127.301073334538, 1137.1982752159709, 1229.9139060265875, 1251.0992085698283, 1254.8431446069242, 16647.66704665924, 16784.41254556085, 16921.7461738074, 16989.150542472828, 17036.14819259032, 486477.0, 487781.0, 492032.0, 492740.0, 494411.0, 56541.717291414105, 56584.0, 56721.0, 56762.432375675715, 56954.145687814715, 1399.524161784998, 1414.1373762005169, 1417.5322143692556, 1437.9496717615043, 1448.304813689435, 30042.69957300399, 31407.52888706717, 31516.212094697818, 31590.684093158776, 31923.521147182346, 48996.5100348992, 52798.472015280895, 54661.453385467226, 55087.44912550983, 59811.0, 381956.0, 385200.0, 387653.0, 388171.0, 389322.0, 26698.0, 26759.19722408331, 26776.33059173536, 26880.0, 27098.05156819502, 45507.54492455033, 45669.314960274955, 45710.54289457063, 45830.770846145555, 46802.53197467982, 39206.41190382204, 39208.607913920496, 40116.79941600273, 40204.0, 40255.1948961025, 39102.217955641296, 39384.0, 39431.408528872664, 39699.40450893297, 40107.59892401155, 34404.057480980955, 39590.40614390729, 42929.66568259734, 43302.0, 43424.78287608542, 35571.82214088913, 36131.277374451834, 36756.632433676394, 36946.0, 37039.25921481609, 28128.57807132854, 28151.155465336073, 28320.575191371732, 28370.574441383807, 28636.713632863404], "value": 19748.351443829415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9349010668188, 386.59214528672237, 394.1565050791306, 400.8116185392864, 407.67386091127094, 18373.356932507366, 19165.80834191661, 19186.42440726777, 19477.99999999998, 19538.90230548847, 17657.20542575584, 18201.81798182018, 18286.725699114522, 18472.907635461805, 18721.689481736285, 5534.640248383852, 5573.888522229553, 5667.886642267152, 5715.799947001856, 5729.3411257705275, 5437.755301011464, 5554.361248456439, 5571.247881536002, 5589.944100558983, 5596.300462442195, 5436.157395603668, 5453.15476101203, 5502.449755024506, 5506.724663766796, 5532.474414930575, 5420.512153906147, 5496.587755918302, 5500.954818584476, 5556.583256255797, 5595.104783234663, 4890.535399137077, 4939.135651261015, 4943.258511223309, 4945.109880221558, 4993.226049962262, 21902.89048554763, 22014.669779953314, 22350.2177423791, 22487.100515979506, 22531.549369012693, 2334.568104900582, 2362.362162216209, 2370.3481542575755, 2588.831725937808, 2729.2630989632885, 13478.595642130751, 13886.236257005861, 14024.929875350557, 14102.576922692335, 14623.488177913829, 1907.2847682119204, 1924.7786504552016, 1975.782663906969, 2022.2719820864477, 2054.897255137237, 75407.62296188538, 78903.0, 79098.0, 79565.20434795636, 80580.19419805786, 8406.873896891551, 9039.276857851357, 9123.220971910547, 9791.51042447889, 9911.553980070914, 12906.80639790404, 12977.805332920014, 12998.545050923361, 13003.08978371505, 13148.60554183376, 7338.156112047183, 7377.372923301579, 7394.815129621803, 7442.516236444614, 7451.2921272479025, 7258.491905566665, 7266.781996540112, 7295.306945840137, 7354.852902942018, 7393.706101432228, 4008.118213992917, 4118.670506359484, 4124.154548317588, 4129.215449064668, 4209.116085622054, 1858.5725283184943, 1911.4838993471963, 1967.5868067705942, 1972.1322618048014, 1972.378700709272, 922.5802259971697, 1029.6910926722103, 1056.4084112896803, 1070.7483741320784, 1084.6312253833735, 18876.33932812345, 19537.0, 19863.0, 19887.60224795496, 19898.0, 974.1524873360222, 995.7908839143861, 1019.6380284998867, 1023.97440063999, 1049.9632512862013, 9249.630014799333, 10846.132309415229, 11042.116630669527, 11045.447727613588, 11107.0, 480663.0, 485373.0, 502256.0, 505399.0, 505535.0, 101973.49013254886, 103141.0, 105541.47229263958, 105828.0, 106348.0, 967.0812727908515, 977.9217662586834, 984.9359791613522, 985.7929834734786, 988.7775250568565, 17160.48518544396, 17307.221175047405, 17337.393191238247, 17417.738733919254, 17773.289068437636, 42055.3691694631, 42502.0, 43255.351169731846, 43470.78264608657, 43579.782101089295, 55346.44653553574, 60358.698206508685, 61078.38921610727, 61345.38654613575, 62065.68967155135, 8484.490930544187, 8556.657733690583, 8617.65529378843, 8696.652133914573, 8792.560371981248, 9365.85951210746, 13380.732385352043, 13510.662233444242, 13571.52499662507, 13683.45266189381, 11177.441127943408, 11382.14633902444, 11386.544538218379, 11522.481488332878, 11751.529938802352, 11157.832632510681, 11164.330140191614, 11304.434778261219, 11413.08695304357, 11784.941075294568, 11423.885761142283, 11534.94232528832, 11587.246828956091, 11604.535818567163, 11816.82274765862, 7383.926160738324, 7770.0, 8400.87398689008, 8485.193906578865, 8553.315734741082, 11677.474513647076, 11683.357415342238, 11772.17594768358, 11815.113866459878, 12006.879931200576], "value": 9088.828148076165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.9122852628843, 1483.14719036554, 1651.4467653336133, 1788.09701100944, 1821.4899828048142, 7824.256695613922, 8753.824923501526, 8770.47377157371, 9316.673916412936, 9326.440413575181, 8849.159329863653, 9099.090090990898, 9158.908410915888, 9183.357164998453, 9185.402948808323, 2288.0275882749806, 2298.9655155172686, 2305.262316058862, 2313.687652166961, 2315.780000899912, 2325.5581439526522, 2339.9415014624688, 2370.8814559272055, 2379.119725701493, 2380.155044959032, 2285.874276914769, 2330.615448451012, 2338.485533182697, 2358.882055897207, 2376.6078597031556, 2287.0737351372554, 2297.4026753044245, 2308.1113771198125, 2310.7689231076924, 2314.2131675230503, 2277.7380601230907, 2288.405014696191, 2292.2779324512726, 2292.495650956787, 2301.8043466305385, 8902.243309318716, 9034.86447703285, 9043.186113249772, 9049.321300902458, 9058.682946096855, 4998.0, 5062.0888240116765, 5066.594672426197, 5067.847964561069, 5071.087204303224, 3190.5483005232795, 3390.3049874775857, 3401.268727223634, 3412.419888618916, 3431.4852772084137, 1146.776378606172, 1155.133649762678, 1155.4453862146133, 1172.349346112907, 1200.0579545057087, 12327.0, 12395.380230988414, 12425.875741242653, 12443.440045197987, 12455.314957677325, 4364.585364390377, 4645.187092258841, 4656.650751193674, 4662.32396302541, 4672.859814205579, 9939.65211217604, 9942.304038717364, 9968.700938971842, 9977.850332245021, 9983.15143212835, 5324.094903866352, 5330.280412144389, 5354.678719276856, 5358.973205134027, 5367.087595108841, 4324.545922678137, 4620.237660786, 4785.736784476818, 4951.603871690256, 4972.825951091694, 3885.0675837798726, 3928.9981054830837, 3999.8800035998966, 4045.7572545646767, 4116.217918595457, 1181.8463599731979, 1183.4319526627266, 1184.934828584419, 1194.8230992472409, 1204.644629834201, 983.9901600984042, 1008.7175590834578, 1017.5370206555999, 1025.7640742629087, 1042.4058286776465, 6227.750889964442, 6354.777582784581, 6376.776812811622, 6400.807975760735, 6535.052417399451, 965.5558443116245, 982.7985263021063, 996.0985308296003, 1013.1641395848308, 1021.6577446555339, 4232.280512312914, 4282.293421585404, 4285.807138678767, 4300.827966881352, 4423.314386270134, 10894.67315980522, 11110.166737494721, 11142.49858756358, 11148.721281968015, 11201.103911687045, 10661.78676426467, 10943.890561094446, 10990.780184396268, 11047.337159770439, 11108.888911110947, 8328.292095171857, 8427.705030323908, 8467.153284671484, 8482.363822713198, 8516.829663406821, 6204.689765511796, 6255.374462553708, 6478.708458119301, 6481.837954051187, 6534.967325163534, 10225.897741022793, 10471.476426178813, 10700.090492308242, 10726.249162558857, 10727.570897164025, 10572.629957951434, 10701.839472408075, 10729.678109656723, 10772.70727512672, 10778.838317425088, 7173.856522869409, 7818.452708310364, 8040.0, 8057.879131813144, 8260.091389946982, 8861.91138088611, 8908.10918908104, 8950.597223125105, 8984.05667404913, 9028.548572571213, 7481.70073197066, 7803.843923121619, 7849.882251766342, 7875.724349647735, 7884.172161922916, 7460.179380268275, 7669.616519173907, 7677.884831727641, 7808.648610812641, 7815.062192536932, 7117.928820711727, 7182.676779545038, 7327.523710958771, 7339.74310899116, 7373.5575865448245, 5059.367579052619, 5128.153854613947, 5176.327077479904, 5181.093308671043, 5218.66078704883, 5122.846314610568, 5123.820666276662, 5161.638685291993, 5168.560672342893, 5232.37211534603], "value": 4718.961168811434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.7783995523224, 323.68440770249003, 324.8192819102563, 324.8895375572305, 326.2479983637715, 5025.195968645008, 5529.91705124423, 5538.307711536058, 5564.276644036279, 5638.182463542794, 5477.835664930059, 5515.621094726318, 5524.502794748471, 5533.501984821365, 5536.474034966682, 4242.89392765181, 4281.12236991416, 4303.440552728141, 4320.438343015404, 4321.697481176319, 4175.31107367284, 4279.336702811053, 4288.76411797351, 4324.286492728712, 4342.934855977162, 4205.810738516759, 4219.831206751726, 4223.472065991751, 4247.171801498694, 4257.659387249028, 4225.894352641178, 4249.128928569636, 4266.018815672382, 4274.081072569397, 4292.7209731367675, 3627.383344831385, 3676.74262801604, 3699.5560532736245, 3724.21237805852, 3776.9433458498142, 5417.3770016447825, 5445.891082178374, 5446.739603064723, 5449.591280653927, 5453.536449401806, 4880.194767863299, 4880.389951256093, 4892.290617860391, 4930.704157750546, 4940.308356830046, 5481.397046324901, 5716.914246286309, 5762.654240745569, 5774.249347584829, 5781.653100813965, 4025.6175663311938, 4061.6547593454297, 4066.3900414937702, 4086.7547947123267, 4097.508299004109, 5809.651420914759, 5931.051031834929, 6040.939590604125, 6055.969720151371, 6067.696615169224, 4133.318002529549, 4149.792510374469, 4171.6036976487185, 4174.227767862955, 4185.016521117535, 4240.745555266694, 4244.363345498138, 4246.681498887534, 4258.1483703258855, 4261.4673165854265, 4568.17772800899, 4901.4805410322915, 4907.312976183337, 4923.261510773341, 4969.676970996874, 5784.1902133701315, 5799.594028417971, 5801.3908539602735, 5837.795677151279, 5845.181674565564, 1425.0879437160227, 1428.6999730056596, 1434.5337765226343, 1434.978475322871, 1442.5239670908575, 902.4224496322358, 917.5916717060977, 926.3561824531886, 934.275936149476, 942.3497786527412, 5028.396592408934, 5043.0, 5068.0, 5092.719900405439, 5115.488451154929, 5244.868878277997, 5323.604378029825, 5333.626646134733, 5398.676079435247, 5409.810656627078, 5098.388193416814, 5149.9742501287255, 5164.561012313995, 5324.893502129936, 5791.797287095016, 3187.0, 3192.329610781762, 3202.807831530069, 3212.823294718766, 3227.5320078588475, 6129.938700613026, 6198.2252218472695, 6218.81343559694, 6223.657698826518, 6249.750009999549, 6005.879882402328, 6029.0, 6029.78895738647, 6179.227596550431, 6190.845228869314, 6216.595921265103, 6230.003199488151, 6233.812985610439, 6238.500919926395, 6262.3111457739615, 5712.927615454303, 5936.703164841654, 5941.613795103304, 5991.310999235144, 6037.215162028908, 5958.285005799332, 5980.850478738066, 5986.191864098291, 6016.488598469179, 6025.969870150621, 6009.7295621698, 6053.424924632153, 6221.751129954751, 6239.1577137085915, 6239.188905442264, 4152.813123409514, 4166.604172603597, 4174.165166966558, 4187.413762073251, 4191.958080419279, 5817.854553636193, 6039.909401358896, 6053.0, 6064.787732429344, 6075.878482430238, 5783.277090363705, 5807.0998995155815, 5809.36097029318, 5827.155062515996, 5837.562182836219, 5804.448577385142, 5826.688994976096, 5848.619839710405, 5861.120831875252, 5912.172295878667, 5431.266778984945, 5712.171735098471, 5762.30852297727, 5777.942220577908, 5805.622634528742, 5838.678872662044, 5840.532757379485, 5863.530917526673, 5902.173695682522, 5954.315253745702, 5574.9721251393485, 5730.226419433323, 5763.538916886723, 5782.5373970081455, 5795.942040579709], "value": 4369.170268093473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.3757493405802, 729.62424351459, 748.9887651685226, 756.8751156059251, 762.2073044034205, 13852.168869867803, 13945.511907083253, 14002.369893354798, 14057.29713514324, 14059.156450612945, 13260.204387736743, 13757.10578812379, 13815.102018368823, 13825.516106936258, 13870.514531991383, 682.2290811383131, 817.5666896544841, 823.8764185372212, 833.4249367936135, 833.72487079264, 798.4371018432021, 818.382121498268, 821.6877586517145, 828.2545708862042, 831.2601784411878, 869.821686554258, 870.2254993056185, 872.3500991761115, 873.9519326437044, 874.3092956564307, 866.3805379153872, 871.1201686296822, 871.3682580129419, 871.4509858788954, 873.0134947509338, 632.3107812484368, 633.2464367402775, 634.0742515926753, 634.1534052040486, 636.430394796659, 14113.364898579588, 14128.788068178985, 14138.293085345795, 14159.22124283164, 14162.71674566503, 13691.383887725076, 13738.931305343509, 13939.303034848319, 14029.298535073205, 14297.78553321701, 11525.36610486423, 11545.076393888552, 11553.653390398302, 11607.419629018515, 11700.23948443357, 3787.1478917243676, 3917.0, 4002.779847108408, 4004.659603933669, 4014.0767623446477, 54590.72704636451, 56412.0, 56555.717221414045, 56631.150532742045, 58609.12086318708, 10942.945285273523, 11190.440477976068, 11516.596919107791, 11553.711157221136, 12012.738662440317, 19206.0, 19302.32441864528, 19350.903245483965, 19417.611647766964, 19463.513412164524, 8103.0, 8245.587720613945, 8508.361872859561, 8525.786855328666, 8730.956345218234, 4488.1472520221705, 4516.683832131785, 4520.819167233274, 4543.704659197141, 4571.451425828922, 3262.5269335946628, 3329.284203896174, 3338.115399419156, 3344.5819272590925, 3372.342393233345, 698.9709043432455, 706.2972342519226, 708.3801673535656, 716.7491378017652, 717.2648035763384, 728.0971595221887, 739.1241378965942, 758.4842307231136, 765.2691679446116, 795.0737390939606, 9273.814523709489, 9405.811883762422, 9627.759306017406, 9776.560054797408, 9780.755481113029, 702.2065066474953, 708.5111273221461, 743.0674503498076, 767.6315368623092, 787.9724209652635, 4302.591253830881, 4754.904901902012, 4757.286407038971, 4831.516848315211, 4861.490751140614, 73265.0, 73826.0, 73849.63075184589, 74417.0, 74868.25131748612, 65594.34405655978, 66729.0, 66871.0, 68557.3144268551, 68590.31409685839, 61012.0, 62059.379406206266, 62723.05915411272, 62806.0, 63239.36760632427, 9029.41308814925, 9075.727728168165, 9101.863472047793, 9140.223081038186, 9167.541622918961, 40508.1898362037, 40656.39015414831, 41296.1740765189, 41356.1728765417, 41714.79142604268, 50200.042955542296, 57047.71476142759, 57166.7141664289, 57253.713731431075, 57327.42672573388, 11392.25950313227, 11448.198626096093, 11472.541098355972, 11663.650090497298, 11859.94070029679, 12762.872371276168, 12820.294883781482, 12868.0, 12949.352532373532, 13026.0, 12208.755824883276, 12376.876231237573, 12377.566785162477, 12507.17899289345, 12642.115051946275, 11936.10479214045, 12063.698407539881, 12104.394780261127, 12260.203086799329, 12575.811362829749, 10958.671239862817, 12418.937905310415, 12860.2926839021, 13082.149660272053, 13170.275634840176, 10623.628173013907, 10845.349279043283, 10879.945600272265, 10921.453927303444, 10934.945325273322, 10224.642137525449, 10368.781947388106, 10378.42918639482, 10410.843837342294, 10519.0], "value": 6979.792312998879, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 113.0, 113.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 155.0, 183.0, 124.0, 156.0, 153.0, 129.0, 180.0, 132.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 167.0, 162.0, 165.0, 173.0, 163.0, 162.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 158.0, 76.0, 75.0, 79.0, 75.0, 167.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 138.0, 84.0, 84.0, 83.0, 143.0, 83.0, 83.0, 138.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 58.0, 59.0, 56.0, 70.0, 53.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 82.0, 81.0, 81.0, 83.0, 82.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 121.0, 128.0, 121.0, 128.0, 122.0, 127.0, 163.0, 139.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 164.0, 163.0, 165.0, 165.0, 164.0, 170.0, 163.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 64.0, 66.0, 63.0, 65.0, 70.0, 62.0, 62.0, 62.0], "value": 64.9, "unit": "score"}]}]} 09:50:46 INFO - Return code: 0 09:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:50:46 ERROR - # TBPL SUCCESS # 09:50:46 INFO - Running post-action listener: _resource_record_post_action 09:50:46 INFO - ##### 09:50:46 INFO - ##### Finished run-tests step (success) 09:50:46 INFO - ##### 09:50:46 INFO - Running post-run listener: _resource_record_post_run 09:50:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539561984; Read time: 8; Write time: 467332 09:50:46 INFO - TinderboxPrint: CPU usage
13.4% 09:50:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:50:46 INFO - TinderboxPrint: I/O write bytes / time
539,561,984 / 467,332 09:50:46 INFO - TinderboxPrint: CPU idle
8,217.6 (86.5%) 09:50:46 INFO - TinderboxPrint: CPU user
1,222.6 (12.9%) 09:50:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247365632; Read time: 0; Write time: 242416 09:50:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292196352; Read time: 8; Write time: 224916 09:50:47 INFO - Running post-run listener: _upload_blobber_files 09:50:47 INFO - Blob upload gear active. 09:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:47 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 09:50:47 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'] 09:50:47 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 09:50:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:48 INFO - (blobuploader) - INFO - Done attempting. 09:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:53 INFO - (blobuploader) - INFO - Done attempting. 09:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:54 INFO - (blobuploader) - INFO - Done attempting. 09:50:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:54 INFO - Return code: 0 09:50:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff59defa8f20706fbb02837aedb4199cd60f85cfaf9a81a0a3750c9b2ff0e7f751e673c9bbf881af3e4e3777dc52869ece1aeeeba8c62272016bc178537b414f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a1107637ca4a664acc83dcbce5b0e43a14384781149b6fb1022d58583e85cd28996b6a0d7bf0f4bc7d3197b294f1fba6f42c18a3736c57c0da1edb7de8a44b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5192f4a9a2f81ec3bceeb775bb8240dae22e1f807543f75634ee9a688e8a65358b643254aed3179a65153bcf84fc5647bc01187de29a625a52756af2c5b9a73"} 09:50:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:54 INFO - Contents: 09:50:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff59defa8f20706fbb02837aedb4199cd60f85cfaf9a81a0a3750c9b2ff0e7f751e673c9bbf881af3e4e3777dc52869ece1aeeeba8c62272016bc178537b414f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a1107637ca4a664acc83dcbce5b0e43a14384781149b6fb1022d58583e85cd28996b6a0d7bf0f4bc7d3197b294f1fba6f42c18a3736c57c0da1edb7de8a44b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5192f4a9a2f81ec3bceeb775bb8240dae22e1f807543f75634ee9a688e8a65358b643254aed3179a65153bcf84fc5647bc01187de29a625a52756af2c5b9a73"} 09:50:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:54 INFO - Copying logs to upload dir... 09:50:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.879059 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 09:50:54.152399) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 09:50:54.155864) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 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/ff59defa8f20706fbb02837aedb4199cd60f85cfaf9a81a0a3750c9b2ff0e7f751e673c9bbf881af3e4e3777dc52869ece1aeeeba8c62272016bc178537b414f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a1107637ca4a664acc83dcbce5b0e43a14384781149b6fb1022d58583e85cd28996b6a0d7bf0f4bc7d3197b294f1fba6f42c18a3736c57c0da1edb7de8a44b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5192f4a9a2f81ec3bceeb775bb8240dae22e1f807543f75634ee9a688e8a65358b643254aed3179a65153bcf84fc5647bc01187de29a625a52756af2c5b9a73"} build_url:https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/bKwnsZTBQmy6K8TpHRLwMQ/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/ff59defa8f20706fbb02837aedb4199cd60f85cfaf9a81a0a3750c9b2ff0e7f751e673c9bbf881af3e4e3777dc52869ece1aeeeba8c62272016bc178537b414f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a1107637ca4a664acc83dcbce5b0e43a14384781149b6fb1022d58583e85cd28996b6a0d7bf0f4bc7d3197b294f1fba6f42c18a3736c57c0da1edb7de8a44b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5192f4a9a2f81ec3bceeb775bb8240dae22e1f807543f75634ee9a688e8a65358b643254aed3179a65153bcf84fc5647bc01187de29a625a52756af2c5b9a73"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 09:50:54.183235) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:50:54.183602) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464193329.398068-1461804703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004715 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:50:54.271197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 09:50:54.271949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 09:50:54.272555) ========= ========= Total master_lag: 0.17 =========