builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1464619292.97 results: success (0) buildid: 20160530063038 builduid: d5106b02fbd2489aaefed5c209190034 revision: 3435dd7ad71fe9003bdeee18fd38d815e033beef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:32.971087) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:32.971732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:32.972035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:32.990987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:32.991267) ========= 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=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 07:41:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.0M=0s 2016-05-30 07:41:33 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121819 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.128289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.128635) ========= 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=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013617 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.178376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.178745) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3435dd7ad71fe9003bdeee18fd38d815e033beef --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 3435dd7ad71fe9003bdeee18fd38d815e033beef --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=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 07:41:33,390 truncating revision to first 12 chars 2016-05-30 07:41:33,390 Setting DEBUG logging. 2016-05-30 07:41:33,390 attempt 1/10 2016-05-30 07:41:33,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3435dd7ad71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 07:41:33,717 unpacking tar archive at: mozilla-central-3435dd7ad71f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.838066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.838476) ========= script_repo_revision: 3435dd7ad71fe9003bdeee18fd38d815e033beef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.839306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.840027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 07:41:33.850083) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-30 07:41:33.850492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:34 INFO - MultiFileLogger online at 20160530 07:41:34 in /builds/slave/test 07:41:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:41:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:34 INFO - {'append_to_log': False, 07:41:34 INFO - 'base_work_dir': '/builds/slave/test', 07:41:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:41:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:34 INFO - 'branch': 'Firefox-Non-PGO', 07:41:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:34 INFO - 'config_files': ('talos/linux_config.py',), 07:41:34 INFO - 'default_actions': ('clobber', 07:41:34 INFO - 'read-buildbot-config', 07:41:34 INFO - 'download-and-extract', 07:41:34 INFO - 'populate-webroot', 07:41:34 INFO - 'create-virtualenv', 07:41:34 INFO - 'install', 07:41:34 INFO - 'run-tests'), 07:41:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:34 INFO - 'download_minidump_stackwalk': True, 07:41:34 INFO - 'download_symbols': 'ondemand', 07:41:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:34 INFO - 'installer_path': 'installer.exe', 07:41:34 INFO - 'log_level': 'info', 07:41:34 INFO - 'log_name': 'talos', 07:41:34 INFO - 'log_to_console': True, 07:41:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:34 INFO - 'opt_config_files': (), 07:41:34 INFO - 'pip_index': False, 07:41:34 INFO - 'sps_profile': False, 07:41:34 INFO - 'sps_profile_interval': 0, 07:41:34 INFO - 'suite': 'dromaeojs-e10s', 07:41:34 INFO - 'system_bits': '32', 07:41:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:34 INFO - 'title': 'talos-linux64-ix-008', 07:41:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:34 INFO - 'use_talos_json': True, 07:41:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:34 INFO - 'work_dir': 'build'} 07:41:34 INFO - ##### 07:41:34 INFO - ##### Running clobber step. 07:41:34 INFO - ##### 07:41:34 INFO - Running pre-action listener: _resource_record_pre_action 07:41:34 INFO - Running main action method: clobber 07:41:34 INFO - rmtree: /builds/slave/test/build 07:41:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:35 INFO - Running post-action listener: _resource_record_post_action 07:41:35 INFO - ##### 07:41:35 INFO - ##### Finished clobber step (success) 07:41:35 INFO - ##### 07:41:35 INFO - ##### 07:41:35 INFO - ##### Running read-buildbot-config step. 07:41:35 INFO - ##### 07:41:35 INFO - Running pre-action listener: _resource_record_pre_action 07:41:35 INFO - Running main action method: read_buildbot_config 07:41:35 INFO - Using buildbot properties: 07:41:35 INFO - { 07:41:35 INFO - "project": "", 07:41:35 INFO - "product": "firefox", 07:41:35 INFO - "script_repo_revision": "production", 07:41:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:41:35 INFO - "repository": "", 07:41:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:41:35 INFO - "buildid": "20160530063038", 07:41:35 INFO - "pgo_build": "False", 07:41:35 INFO - "basedir": "/builds/slave/test", 07:41:35 INFO - "buildnumber": 72, 07:41:35 INFO - "slavename": "talos-linux64-ix-008", 07:41:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:41:35 INFO - "platform": "ubuntu64_hw", 07:41:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:41:35 INFO - "branch": "mozilla-central", 07:41:35 INFO - "repo_path": "mozilla-central", 07:41:35 INFO - "revision": "3435dd7ad71fe9003bdeee18fd38d815e033beef", 07:41:35 INFO - "stage_platform": "linux64", 07:41:35 INFO - "builduid": "d5106b02fbd2489aaefed5c209190034", 07:41:35 INFO - "slavebuilddir": "test" 07:41:35 INFO - } 07:41:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:41:35 INFO - Running post-action listener: _resource_record_post_action 07:41:35 INFO - ##### 07:41:35 INFO - ##### Finished read-buildbot-config step (success) 07:41:35 INFO - ##### 07:41:35 INFO - ##### 07:41:35 INFO - ##### Running download-and-extract step. 07:41:35 INFO - ##### 07:41:35 INFO - Running pre-action listener: _resource_record_pre_action 07:41:35 INFO - Running main action method: download_and_extract 07:41:35 INFO - mkdir: /builds/slave/test/build/tests 07:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:35 INFO - https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:41:35 INFO - Downloaded 1361 bytes. 07:41:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:35 INFO - Using the following test package requirements: 07:41:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:41:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'jsshell-linux-x86_64.zip'], 07:41:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:41:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:41:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:35 INFO - https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:41:38 INFO - Downloaded 22837411 bytes. 07:41:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:41:39 INFO - Return code: 0 07:41:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:41: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')]} 07:41:39 INFO - https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:41:40 INFO - Downloaded 22837411 bytes. 07:41:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:41:42 INFO - Return code: 0 07:41: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')]} 07:41:42 INFO - https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:41:46 INFO - Downloaded 10834055 bytes. 07:41:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:41:46 INFO - Return code: 0 07:41: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')]} 07:41:46 INFO - https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:41:47 INFO - Downloaded 54987893 bytes. 07:41:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:47 INFO - mkdir: /builds/slave/test/properties 07:41:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:47 INFO - Contents: 07:41:47 INFO - build_url:https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:48 INFO - Running post-action listener: _resource_record_post_action 07:41:48 INFO - Running post-action listener: set_extra_try_arguments 07:41:48 INFO - ##### 07:41:48 INFO - ##### Finished download-and-extract step (success) 07:41:48 INFO - ##### 07:41:48 INFO - ##### 07:41:48 INFO - ##### Running populate-webroot step. 07:41:48 INFO - ##### 07:41:48 INFO - Running pre-action listener: _resource_record_pre_action 07:41:48 INFO - Running main action method: populate_webroot 07:41:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:48 INFO - '--tppagecycles', 07:41:48 INFO - '7'], 07:41:48 INFO - 'tests': ['tsvgm']}}, 07:41:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['damp', 'tps']}, 07:41:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['damp', 'tps']}, 07:41:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['dromaeo_dom']}, 07:41:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore', 07:41:48 INFO - 'tabpaint']}, 07:41:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['tsvgx', 07:41:48 INFO - 'tsvgr_opacity', 07:41:48 INFO - 'tart', 07:41:48 INFO - 'tscrollx', 07:41:48 INFO - 'cart']}, 07:41:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:48 INFO - 'tsvgr_opacity', 07:41:48 INFO - 'tart', 07:41:48 INFO - 'tscrollx', 07:41:48 INFO - 'cart']}, 07:41:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--disable-e10s'], 07:41:48 INFO - 'tests': ['tp5o']}, 07:41:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['tp5o']}, 07:41:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--disable-e10s', 07:41:48 INFO - '--xperf_path', 07:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:48 INFO - 'tests': ['tp5n']}, 07:41:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--xperf_path', 07:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:48 INFO - 'tests': ['tp5n']}}, 07:41:48 INFO - 'talos.zip': {'path': '', 07:41:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:48 INFO - Running post-action listener: _resource_record_post_action 07:41:48 INFO - ##### 07:41:48 INFO - ##### Finished populate-webroot step (success) 07:41:48 INFO - ##### 07:41:48 INFO - ##### 07:41:48 INFO - ##### Running create-virtualenv step. 07:41:48 INFO - ##### 07:41:48 INFO - Running pre-action listener: _resource_record_pre_action 07:41:48 INFO - Running main action method: create_virtualenv 07:41:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:41:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:48 INFO - Using real prefix '/usr' 07:41:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:50 INFO - Installing pip.................done. 07:41:50 INFO - Return code: 0 07:41:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41: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', 'pip>=1.5'] in /builds/slave/test/build 07:41: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 pip>=1.5 07:41:50 INFO - Using env: {'DISPLAY': ':0', 07:41:50 INFO - 'HOME': '/home/cltbld', 07:41:50 INFO - 'LANG': 'en_US.UTF-8', 07:41:50 INFO - 'LANGUAGE': 'en_US:en', 07:41:50 INFO - 'LOGNAME': 'cltbld', 07:41:50 INFO - 'MAIL': '/var/mail/cltbld', 07:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:50 INFO - 'MOZ_NO_REMOTE': '1', 07:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:50 INFO - 'NO_EM_RESTART': '1', 07:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:50 INFO - 'PWD': '/builds/slave/test', 07:41:50 INFO - 'SHELL': '/bin/bash', 07:41:50 INFO - 'SHLVL': '1', 07:41:50 INFO - 'TERM': 'linux', 07:41:50 INFO - 'TMOUT': '86400', 07:41:50 INFO - 'USER': 'cltbld', 07:41:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:50 INFO - '_': '/tools/buildbot/bin/python'} 07:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:41:51 INFO - Cleaning up... 07:41:51 INFO - Return code: 0 07:41:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:41:51 INFO - Using env: {'DISPLAY': ':0', 07:41:51 INFO - 'HOME': '/home/cltbld', 07:41:51 INFO - 'LANG': 'en_US.UTF-8', 07:41:51 INFO - 'LANGUAGE': 'en_US:en', 07:41:51 INFO - 'LOGNAME': 'cltbld', 07:41:51 INFO - 'MAIL': '/var/mail/cltbld', 07:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:51 INFO - 'MOZ_NO_REMOTE': '1', 07:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:51 INFO - 'NO_EM_RESTART': '1', 07:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:51 INFO - 'PWD': '/builds/slave/test', 07:41:51 INFO - 'SHELL': '/bin/bash', 07:41:51 INFO - 'SHLVL': '1', 07:41:51 INFO - 'TERM': 'linux', 07:41:51 INFO - 'TMOUT': '86400', 07:41:51 INFO - 'USER': 'cltbld', 07:41:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:51 INFO - '_': '/tools/buildbot/bin/python'} 07:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:51 INFO - Downloading/unpacking psutil>=3.1.1 07:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:53 INFO - Installing collected packages: psutil 07:41:53 INFO - Running setup.py install for psutil 07:41:53 INFO - building 'psutil._psutil_linux' extension 07:41:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:41:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:41:53 INFO - building 'psutil._psutil_posix' extension 07:41:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:41:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:41:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:53 INFO - Successfully installed psutil 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:41:53 INFO - Using env: {'DISPLAY': ':0', 07:41:53 INFO - 'HOME': '/home/cltbld', 07:41:53 INFO - 'LANG': 'en_US.UTF-8', 07:41:53 INFO - 'LANGUAGE': 'en_US:en', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MAIL': '/var/mail/cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SHLVL': '1', 07:41:53 INFO - 'TERM': 'linux', 07:41:53 INFO - 'TMOUT': '86400', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - '_': '/tools/buildbot/bin/python'} 07:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:41:56 INFO - Installing collected packages: mozsystemmonitor 07:41:56 INFO - Running setup.py install for mozsystemmonitor 07:41:56 INFO - Successfully installed mozsystemmonitor 07:41:56 INFO - Cleaning up... 07:41:56 INFO - Return code: 0 07:41:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:41:56 INFO - Using env: {'DISPLAY': ':0', 07:41:56 INFO - 'HOME': '/home/cltbld', 07:41:56 INFO - 'LANG': 'en_US.UTF-8', 07:41:56 INFO - 'LANGUAGE': 'en_US:en', 07:41:56 INFO - 'LOGNAME': 'cltbld', 07:41:56 INFO - 'MAIL': '/var/mail/cltbld', 07:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:56 INFO - 'MOZ_NO_REMOTE': '1', 07:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:56 INFO - 'NO_EM_RESTART': '1', 07:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:56 INFO - 'PWD': '/builds/slave/test', 07:41:56 INFO - 'SHELL': '/bin/bash', 07:41:56 INFO - 'SHLVL': '1', 07:41:56 INFO - 'TERM': 'linux', 07:41:56 INFO - 'TMOUT': '86400', 07:41:56 INFO - 'USER': 'cltbld', 07:41:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:56 INFO - '_': '/tools/buildbot/bin/python'} 07:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:59 INFO - Downloading docopt-0.6.1.tar.gz 07:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:59 INFO - Running setup.py install for blobuploader 07:41:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:59 INFO - Running setup.py install for requests 07:41:59 INFO - Running setup.py install for docopt 07:41:59 INFO - Successfully installed blobuploader requests docopt 07:41:59 INFO - Cleaning up... 07:41:59 INFO - Return code: 0 07:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:59 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:59 INFO - Using env: {'DISPLAY': ':0', 07:41:59 INFO - 'HOME': '/home/cltbld', 07:41:59 INFO - 'LANG': 'en_US.UTF-8', 07:41:59 INFO - 'LANGUAGE': 'en_US:en', 07:41:59 INFO - 'LOGNAME': 'cltbld', 07:41:59 INFO - 'MAIL': '/var/mail/cltbld', 07:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:59 INFO - 'MOZ_NO_REMOTE': '1', 07:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:59 INFO - 'NO_EM_RESTART': '1', 07:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:59 INFO - 'PWD': '/builds/slave/test', 07:41:59 INFO - 'SHELL': '/bin/bash', 07:41:59 INFO - 'SHLVL': '1', 07:41:59 INFO - 'TERM': 'linux', 07:41:59 INFO - 'TMOUT': '86400', 07:41:59 INFO - 'USER': 'cltbld', 07:41:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:59 INFO - '_': '/tools/buildbot/bin/python'} 07:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:59 INFO - Running setup.py (path:/tmp/pip-UMqVPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:59 INFO - Running setup.py (path:/tmp/pip-eLcBCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:00 INFO - Running setup.py (path:/tmp/pip-a11Aaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:00 INFO - Running setup.py (path:/tmp/pip-UANDcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:00 INFO - Running setup.py (path:/tmp/pip-OyKU76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:00 INFO - Running setup.py (path:/tmp/pip-6RabJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:00 INFO - Running setup.py (path:/tmp/pip-71IpFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:00 INFO - Running setup.py (path:/tmp/pip-x1Hjcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:00 INFO - Running setup.py (path:/tmp/pip-VNUhzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:00 INFO - Running setup.py (path:/tmp/pip-SbSW3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:00 INFO - Running setup.py (path:/tmp/pip-ln8i6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:00 INFO - Running setup.py (path:/tmp/pip-5ZVTve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:00 INFO - Running setup.py (path:/tmp/pip-63Qek7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:00 INFO - Running setup.py (path:/tmp/pip-W5avRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:00 INFO - Running setup.py (path:/tmp/pip-H0XoMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:01 INFO - Running setup.py (path:/tmp/pip-w80Tyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:01 INFO - Running setup.py (path:/tmp/pip-gAnWV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:01 INFO - Running setup.py install for manifestparser 07:42:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozcrash 07:42:01 INFO - Running setup.py install for mozdebug 07:42:01 INFO - Running setup.py install for mozdevice 07:42:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozfile 07:42:01 INFO - Running setup.py install for mozhttpd 07:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozinfo 07:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozInstall 07:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozleak 07:42:02 INFO - Running setup.py install for mozlog 07:42:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for moznetwork 07:42:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for mozprocess 07:42:02 INFO - Running setup.py install for mozprofile 07:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for mozrunner 07:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for mozscreenshot 07:42:02 INFO - Running setup.py install for moztest 07:42:02 INFO - Running setup.py install for mozversion 07:42:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:02 INFO - Cleaning up... 07:42:02 INFO - Return code: 0 07:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:02 INFO - Using env: {'DISPLAY': ':0', 07:42:02 INFO - 'HOME': '/home/cltbld', 07:42:02 INFO - 'LANG': 'en_US.UTF-8', 07:42:02 INFO - 'LANGUAGE': 'en_US:en', 07:42:02 INFO - 'LOGNAME': 'cltbld', 07:42:02 INFO - 'MAIL': '/var/mail/cltbld', 07:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:02 INFO - 'MOZ_NO_REMOTE': '1', 07:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:02 INFO - 'NO_EM_RESTART': '1', 07:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:02 INFO - 'PWD': '/builds/slave/test', 07:42:02 INFO - 'SHELL': '/bin/bash', 07:42:02 INFO - 'SHLVL': '1', 07:42:02 INFO - 'TERM': 'linux', 07:42:02 INFO - 'TMOUT': '86400', 07:42:02 INFO - 'USER': 'cltbld', 07:42:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:02 INFO - '_': '/tools/buildbot/bin/python'} 07:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:03 INFO - Running setup.py (path:/tmp/pip-IHQnB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:03 INFO - Running setup.py (path:/tmp/pip-S1Sju5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:03 INFO - Running setup.py (path:/tmp/pip-PRE6v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:03 INFO - Running setup.py (path:/tmp/pip-NTqSCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:03 INFO - Running setup.py (path:/tmp/pip-oN4lwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:03 INFO - Running setup.py (path:/tmp/pip-8P652s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:03 INFO - Running setup.py (path:/tmp/pip-4Q2FEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:03 INFO - Running setup.py (path:/tmp/pip-sXlWqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:03 INFO - Running setup.py (path:/tmp/pip-hAcbO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:03 INFO - Running setup.py (path:/tmp/pip-fZ16Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:03 INFO - Running setup.py (path:/tmp/pip-a5EIoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:03 INFO - Running setup.py (path:/tmp/pip-IRCZzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:04 INFO - Running setup.py (path:/tmp/pip-3qoCXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:04 INFO - Running setup.py (path:/tmp/pip-ayPlil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:04 INFO - Running setup.py (path:/tmp/pip-rLEGTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:04 INFO - Running setup.py (path:/tmp/pip-mtg9Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:04 INFO - Running setup.py (path:/tmp/pip-Qaz7pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:06 INFO - Downloading blessings-1.6.tar.gz 07:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:06 INFO - Installing collected packages: blessings 07:42:06 INFO - Running setup.py install for blessings 07:42:06 INFO - Successfully installed blessings 07:42:06 INFO - Cleaning up... 07:42:06 INFO - Return code: 0 07:42:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:06 INFO - Reading from file tmpfile_stdout 07:42:06 INFO - Current package versions: 07:42:06 INFO - argparse == 1.2.1 07:42:06 INFO - blessings == 1.6 07:42:06 INFO - blobuploader == 1.2.4 07:42:06 INFO - docopt == 0.6.1 07:42:06 INFO - manifestparser == 1.1 07:42:06 INFO - mozInstall == 1.12 07:42:06 INFO - mozcrash == 0.17 07:42:06 INFO - mozdebug == 0.1 07:42:06 INFO - mozdevice == 0.48 07:42:06 INFO - mozfile == 1.2 07:42:06 INFO - mozhttpd == 0.7 07:42:06 INFO - mozinfo == 0.9 07:42:06 INFO - mozleak == 0.1 07:42:06 INFO - mozlog == 3.2 07:42:06 INFO - moznetwork == 0.27 07:42:06 INFO - mozprocess == 0.22 07:42:06 INFO - mozprofile == 0.28 07:42:06 INFO - mozrunner == 6.11 07:42:06 INFO - mozscreenshot == 0.1 07:42:06 INFO - mozsystemmonitor == 0.3 07:42:06 INFO - moztest == 0.7 07:42:06 INFO - mozversion == 1.4 07:42:06 INFO - psutil == 3.1.1 07:42:06 INFO - requests == 1.2.3 07:42:06 INFO - wsgiref == 0.1.2 07:42:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:06 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:06 INFO - Using env: {'DISPLAY': ':0', 07:42:06 INFO - 'HOME': '/home/cltbld', 07:42:06 INFO - 'LANG': 'en_US.UTF-8', 07:42:06 INFO - 'LANGUAGE': 'en_US:en', 07:42:06 INFO - 'LOGNAME': 'cltbld', 07:42:06 INFO - 'MAIL': '/var/mail/cltbld', 07:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:06 INFO - 'MOZ_NO_REMOTE': '1', 07:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:06 INFO - 'NO_EM_RESTART': '1', 07:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:06 INFO - 'PWD': '/builds/slave/test', 07:42:06 INFO - 'SHELL': '/bin/bash', 07:42:06 INFO - 'SHLVL': '1', 07:42:06 INFO - 'TERM': 'linux', 07:42:06 INFO - 'TMOUT': '86400', 07:42:06 INFO - 'USER': 'cltbld', 07:42:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:06 INFO - '_': '/tools/buildbot/bin/python'} 07:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:42:06 INFO - Cleaning up... 07:42:06 INFO - Return code: 0 07:42:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:42:06 INFO - Using env: {'DISPLAY': ':0', 07:42:06 INFO - 'HOME': '/home/cltbld', 07:42:06 INFO - 'LANG': 'en_US.UTF-8', 07:42:06 INFO - 'LANGUAGE': 'en_US:en', 07:42:06 INFO - 'LOGNAME': 'cltbld', 07:42:06 INFO - 'MAIL': '/var/mail/cltbld', 07:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:06 INFO - 'MOZ_NO_REMOTE': '1', 07:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:06 INFO - 'NO_EM_RESTART': '1', 07:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:06 INFO - 'PWD': '/builds/slave/test', 07:42:06 INFO - 'SHELL': '/bin/bash', 07:42:06 INFO - 'SHLVL': '1', 07:42:06 INFO - 'TERM': 'linux', 07:42:06 INFO - 'TMOUT': '86400', 07:42:06 INFO - 'USER': 'cltbld', 07:42:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:06 INFO - '_': '/tools/buildbot/bin/python'} 07:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:07 INFO - Downloading/unpacking jsonschema 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:09 INFO - Downloading/unpacking functools32 (from jsonschema) 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:09 INFO - warning: no files found matching '*.txt' 07:42:09 INFO - no previously-included directories found matching 'build' 07:42:09 INFO - no previously-included directories found matching 'dist' 07:42:09 INFO - no previously-included directories found matching '.git*' 07:42:09 INFO - Installing collected packages: jsonschema, functools32 07:42:09 INFO - Running setup.py install for functools32 07:42:09 INFO - warning: no files found matching '*.txt' 07:42:09 INFO - no previously-included directories found matching 'build' 07:42:09 INFO - no previously-included directories found matching 'dist' 07:42:09 INFO - no previously-included directories found matching '.git*' 07:42:09 INFO - Successfully installed jsonschema functools32 07:42:09 INFO - Cleaning up... 07:42:09 INFO - Return code: 0 07:42:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 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 0x7fadf5b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, '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': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:42:09 INFO - Using env: {'DISPLAY': ':0', 07:42:09 INFO - 'HOME': '/home/cltbld', 07:42:09 INFO - 'LANG': 'en_US.UTF-8', 07:42:09 INFO - 'LANGUAGE': 'en_US:en', 07:42:09 INFO - 'LOGNAME': 'cltbld', 07:42:09 INFO - 'MAIL': '/var/mail/cltbld', 07:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:09 INFO - 'MOZ_NO_REMOTE': '1', 07:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:09 INFO - 'NO_EM_RESTART': '1', 07:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:09 INFO - 'PWD': '/builds/slave/test', 07:42:09 INFO - 'SHELL': '/bin/bash', 07:42:09 INFO - 'SHLVL': '1', 07:42:09 INFO - 'TERM': 'linux', 07:42:09 INFO - 'TMOUT': '86400', 07:42:09 INFO - 'USER': 'cltbld', 07:42:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:09 INFO - '_': '/tools/buildbot/bin/python'} 07:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:09 INFO - Downloading/unpacking flake8 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:42:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:42:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:12 INFO - no previously-included directories found matching 'docs/_build' 07:42:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:42:12 INFO - Running setup.py install for pep8 07:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:12 INFO - no previously-included directories found matching 'docs/_build' 07:42:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:42:12 INFO - Cleaning up... 07:42:12 INFO - Return code: 0 07:42:12 INFO - Running post-action listener: _resource_record_post_action 07:42:12 INFO - Running post-action listener: _start_resource_monitoring 07:42:12 INFO - Starting resource monitoring. 07:42:12 INFO - ##### 07:42:12 INFO - ##### Finished create-virtualenv step (success) 07:42:12 INFO - ##### 07:42:12 INFO - ##### 07:42:12 INFO - ##### Running install step. 07:42:12 INFO - ##### 07:42:12 INFO - Running pre-action listener: _resource_record_pre_action 07:42:12 INFO - Running main action method: install 07:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:12 INFO - Reading from file tmpfile_stdout 07:42:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:12 INFO - Reading from file tmpfile_stdout 07:42:12 INFO - Output received: 07:42:12 INFO - Usage: mozinstall [options] installer 07:42:12 INFO - Options: 07:42:12 INFO - -h, --help show this help message and exit 07:42:12 INFO - -d DEST, --destination=DEST 07:42:12 INFO - Directory to install application into. [default: 07:42:12 INFO - "/builds/slave/test"] 07:42:12 INFO - --app=APP Application being installed. [default: firefox] 07:42:12 INFO - mkdir: /builds/slave/test/build/application 07:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:42:28 INFO - Reading from file tmpfile_stdout 07:42:28 INFO - Output received: 07:42:28 INFO - /builds/slave/test/build/application/firefox/firefox 07:42:28 INFO - Running post-action listener: _resource_record_post_action 07:42:28 INFO - ##### 07:42:28 INFO - ##### Finished install step (success) 07:42:28 INFO - ##### 07:42:28 INFO - ##### 07:42:28 INFO - ##### Running run-tests step. 07:42:28 INFO - ##### 07:42:28 INFO - Running pre-action listener: _resource_record_pre_action 07:42:28 INFO - Running main action method: run_tests 07:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:28 INFO - Python 2.7.3 07:42:28 INFO - Return code: 0 07:42:28 INFO - grabbing minidump binary from tooltool 07:42: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')]} 07:42:28 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 0x1fdf9c0>, '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 0x1fe08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:42:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:42:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:42:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:28 INFO - Return code: 0 07:42:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:42:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:42:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:29 INFO - Return code: 0 07:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 07:42:29 INFO - Using env: {'DISPLAY': ':0', 07:42:29 INFO - 'HOME': '/home/cltbld', 07:42:29 INFO - 'LANG': 'en_US.UTF-8', 07:42:29 INFO - 'LANGUAGE': 'en_US:en', 07:42:29 INFO - 'LOGNAME': 'cltbld', 07:42:29 INFO - 'MAIL': '/var/mail/cltbld', 07:42:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:29 INFO - 'MOZ_NO_REMOTE': '1', 07:42:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:29 INFO - 'NO_EM_RESTART': '1', 07:42:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:29 INFO - 'PWD': '/builds/slave/test', 07:42:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:29 INFO - 'SHELL': '/bin/bash', 07:42:29 INFO - 'SHLVL': '1', 07:42:29 INFO - 'TERM': 'linux', 07:42:29 INFO - 'TMOUT': '86400', 07:42:29 INFO - 'USER': 'cltbld', 07:42:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836', 07:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:29 INFO - '_': '/tools/buildbot/bin/python'} 07:42:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:42:29 INFO - mozversion application_buildid: 20160530063038 07:42:29 INFO - mozversion application_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 07:42:29 INFO - mozversion application_display_name: Nightly 07:42:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:29 INFO - mozversion application_name: Firefox 07:42:29 INFO - mozversion application_remotingname: firefox 07:42:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:42:29 INFO - mozversion application_vendor: Mozilla 07:42:29 INFO - mozversion application_version: 49.0a1 07:42:29 INFO - mozversion platform_buildid: 20160530063038 07:42:29 INFO - mozversion platform_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 07:42:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:42:29 INFO - mozversion platform_version: 49.0a1 07:42:29 INFO - using testdate: 1464619349 07:42:29 INFO - actual date: 1464619349 07:42:29 INFO - starting webserver on 'localhost:59554' 07:42:29 INFO - SUITE-START | Running 2 tests 07:42:29 INFO - TEST-START | dromaeo_css 07:42:29 INFO - operating with platform_type : linux_ 07:42:29 INFO - Initialising browser for dromaeo_css test... 07:42:29 INFO - TEST-INFO | started process 26901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpffs_oB/profile http://localhost:59554/getInfo.html) 07:42:34 INFO - PROCESS | 26901 | __metrics Screen width/height:1600/1200 07:42:34 INFO - PROCESS | 26901 | colorDepth:24 07:42:34 INFO - PROCESS | 26901 | Browser inner width/height: 1024/697 07:42:34 INFO - PROCESS | 26901 | __metrics 07:42:35 ERROR - PROCESS | 26901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:42:36 INFO - TEST-INFO | 26901: exit 0 07:42:36 INFO - Browser initialized. 07:42:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:36 INFO - TEST-INFO | started process 27020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpffs_oB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:48 INFO - PROCESS | 27020 | RSS: Main: 167673856 07:42:48 INFO - PROCESS | 27020 | 07:43:37 INFO - PROCESS | 27020 | 1464619417705 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:45:48 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59554/tests/dromaeo/cssquery-ext.html) 07:45:49 INFO - PROCESS | 27020 | RSS: Main: 170409984 07:45:49 INFO - PROCESS | 27020 | 07:48:52 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-ext.html (next: http://localhost:59554/tests/dromaeo/cssquery-jquery.html) 07:48:52 INFO - PROCESS | 27020 | RSS: Main: 170037248 07:48:52 INFO - PROCESS | 27020 | 07:51:54 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59554/tests/dromaeo/cssquery-mootools.html) 07:51:55 INFO - PROCESS | 27020 | RSS: Main: 170516480 07:51:55 INFO - PROCESS | 27020 | 07:54:57 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59554/tests/dromaeo/cssquery-prototype.html) 07:54:57 INFO - PROCESS | 27020 | RSS: Main: 168431616 07:54:57 INFO - PROCESS | 27020 | 07:58:00 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59554/tests/dromaeo/cssquery-yui.html) 07:58:01 INFO - PROCESS | 27020 | RSS: Main: 170364928 07:58:01 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | Cycle 1(1): loaded http://localhost:59554/tests/dromaeo/cssquery-yui.html (next: http://localhost:59554/tests/dromaeo/cssquery-dojo.html) 08:01:03 INFO - PROCESS | 27020 | RSS: Main: 171433984 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | __start_tp_report 08:01:03 INFO - PROCESS | 27020 | _x_x_mozilla_page_load 08:01:03 INFO - PROCESS | 27020 | _x_x_mozilla_page_load_details 08:01:03 INFO - PROCESS | 27020 | |i|pagename|runs| 08:01:03 INFO - PROCESS | 27020 | |0;dojo.html;2664.480426316868;2691.5962605609157;2701.8784154713035;2705.5941608758694;2716.0222319964796;4672.065586882624;4685.742284174369;4710.364100846385;4787.497312782151;4834.468208497063;4675.719456832592;4686.3907692000075;4723.740194289313;4775.617950563956;4792.329073929653;4367;4388.429504164455;4403.251447253959;4460.50934397216;4491.079328737617;4348.391225228471;4363.432753742025;4397.098594788077;4446.933296000562;4485.842995495158;541.2655114496885;4432.290833466646;4450.799714012877;4457.955420445786;4480.775961201944;4431.158079964796;4437.245668236407;4439.356293337448;4469.262571675702;4483.3723278741;4397.274449715793;4400.933985990213;4412;4429.269170586849;4457.66567507435;4543.977280113611;4552.795124219385;4585.151746926829;4688.109259240733;4705.270683044134;5051.267566202917;5068.265101560253;5071.39143302806;5073.188289873602;5133.640645154841;5096;5106;5109.335786347789;5140.845774626767;5164.638475306692;4680.204365257914;4698.224792909165;4711.316859055418;4716.434027916604;4726.527347265246;5177.637565370464;5204.037253108111;5212.139996900469;5230.424653288135;5262.815801446931;4933.679310844784;4965.553100220925;4968.826091086795;4978.925316120261;4980.77586508608;5086.287919691246;5133.8716532087;5140.717260550631;5141.2545180948555;5193.169092945111;5003.2995380646735;5096.388433388017;5103.870610036889;5111.948880511221;5141.53726164647;4947.90104197914;5024.723640199751;5026.145555255615;5084.41529224144;5094.057599344059;4091.8772436826944;4130.297849365555;4252.234597772431;4257.127288905767;4286.292761694348;3678.9448158277646;3718.4980027696456;3771.0195349209403;3776.9244615108096;3865.304245235828;4321.222180007629;4466.776661166994;4479.395281636937;4488.035072459437;4523.185826551186;5074.23886417033;5091.949080509147;5126.69239845603;5166.793328266903;5188.948110518922;4411.713238639478;4445.266531022345;4457.2199865023495;4479.529649386833;4502.459704835441;4494.033782736662;4527.411436513298;4597.816087356535;4598.471175814757;4623.907521849612;4815.446223684321;4839.903201935871;4855.8057677692495;4871.123197824426;4915.901681966412;5091.287219789158;5095.082885080721;5126.846194614168;5157.226416037474;5202.3497062867145;4754.904901902012;4800.0639875224;4828.782704778223;4844.4186697596515;4895.143349913822;5031.295618613471;5040.798368065236;5050.570701490415;5067.822626208065;5103.362079740033;5116.974415128049;5121.564667003347;5127.53852153308;5136.2552429898205;5149.6910185389;4839.588634966068;4979.502049794992;4992.226204938241;5003.924941125813;5059.418166910852;5019.698818070928;5046.621503387188;5061.114304996538;5061.620378471555;5118.155504341742;4967.875803104951;4977.328060711758;4979.0788704089855;5002.17464118431;5004.599632029502;4946.307516947558;5000.849974500771;5045.596352291735;5069.645124841373;5070.619703522177;4911.4106307243355;4974.104661161025;4985.152524070844;4987.12725273083;4997.675151115166 08:01:03 INFO - PROCESS | 27020 | |1;ext.html;560.0954458549442;583.2388732703822;600.8497875531116;610.3652201710222;631.728356806573;27414.451710965794;38779.806100969494;39836;39899.99999999996;40073.39889901654;40126;40401.59598404015;40511;40746;40772.59227407725;7548.622568871562;7681.155072941972;7724.9227507725045;7725.922740772605;7730.420218483609;7580.772576822704;7687.0391201099865;7688.538687678729;7693.615319234043;7697.461177717562;7709.113451953013;7714.498557593738;7742.341900938427;7767.145613982458;7779.688812447495;7478.326950574475;7561.054868141482;7564.243575642447;7564.735234266802;7591.240875912365;7546.132194797614;7584.089909210875;7596.240375962415;7632.122305934833;7654.578998155099;36848.44727329092;37293.44059839105;37295.25409491822;37310.25379492422;37350.25299493995;2873.3104055026643;2950.365671380642;2979.7765167612297;3236.9965310753505;3251.5447837302795;27758.306042349104;28120.29699257535;28419;28675.713242867514;28914.27714307138;3371.2077661749468;3409.1647546351055;3412.1640198151613;3421;3477.8087205203706;215035;215095;215252;216058;217846;31019.68980310213;51347;51910;52079.47920520822;52286.73856630692;32746.508802367982;34736.65263347334;34912.30175396478;34923.825380873444;34981.82509087489;13139.868601313865;13174.407151678197;13228.867711322957;13270.535531256359;13290.66773330655;10870.673879783619;10902.890971090188;10904.073153782017;10909.23635345534;10943.726406839893;7879.724209652634;8014.15851335613;8037.477563958324;8081.515109093473;8120.878186827084;3106.7048630380077;3126.7649278535305;3141.9214519636735;3147.4806656901815;3190.6330771961057;840.3025488844245;845.9069502354736;846.4751853850652;933.8552524358736;985.3644399362371;28039;28791.99228027009;28853.134405967856;28861.56707649387;29008;878.5695009445326;926.5228407370209;988.2390559269322;1023.8361862102176;1051.8850018979754;14933.850661493247;15326.540203793904;15449;15847.683046339009;16221.59446013859;382689;382901;383368;385145;385624;50465;51038.48961510412;51113.233301500506;51155.488445115814;51201.23198152031;1134.6993046842592;1190.5237904838134;1191.6008137273936;1195.3485350484007;1209.4678341529698;28997.42005159927;29743.702562974093;29985.700142998292;30057.69942300549;30480.237994050327;43819.34270985874;43917.78041109774;44262;44581.33128003018;44691.55308446874;348053;350749;352015;352437;355665;24908.37729056788;25392.730363481383;25699.486010280063;25701.742982570682;25757.227283181535;39506.209875801746;42889.142217154855;43901.341479878465;43946;44173;36328.45507317445;37342.253154937294;37404.25191496209;37407.81296093611;37509.249815003;36465;36776.81611592032;36934.26131477409;36985.26029479449;37179.44230836486;31541.842290788398;35675.46486802648;36633.63366366302;37144.44283335698;37308;33051;34156;34603.826980864935;34673.30653386868;34754.652453476156;26029.349266268495;26196;26326.86836565805;26501;26876.731232687423 08:01:03 INFO - PROCESS | 27020 | |2;jquery.html;341.6668747970728;347.69402925425624;356.93039857227853;362.7823306016389;365.5887126982145;15716;16537.834621653794;17702;17738.467845964624;17814.109294535287;15729.213539323016;16318.102504362256;16466.588335291624;16515.174241287918;16532.173391330445;4803.495632958541;5103.2855400244;5107.361579802525;5112.565431938271;5123.487651234866;3691.427828686558;4995.950040499585;5662;5956.7319470623925;5967.194428752128;5976.2230909981645;5994.850128746794;6000.459958603725;6007.219061521996;6008.128821320905;5782.421757824226;5943.049112142036;5982.37185095563;5984.581079324449;5987.101934709828;5005.647345747493;5191.480851914816;5197.688138711689;5197.7401129943355;5226.346706661668;17763.289468421248;18706.90646546772;20779.480512987295;21079.68380474279;21095.894520527298;1711.1187738314777;1723.4484964811265;1743.0587482759295;1848.5840685845712;2357.3635118518077;8901.421407608485;9177.311701622404;9256.213221876149;9284.932232793248;9300.604909263597;1598.45652478158;1734.4363081998401;1787.2493552707895;1802.7295905614133;1810.1401834128815;69064.30935690629;71823.64088179579;72619.27380726178;73009;74107;9080.40977336471;9226.30802689801;9243.445393276425;9273.258139348836;9384.8592271116;12026;12066.517339306329;12116.515339386502;12123.393830308449;12152.817707734392;6884.827879303058;6918.342757438036;6927.618980956096;6993.545419547713;7030.718771249195;6584.275729669733;6663.267040625527;6881.793546193622;6887.552309099892;6890.931090689029;3755.4742336072973;3763.8494460221286;3827.138893748884;3908.179282350681;3917.5103112110987;1527.900686455377;1545.9845401546065;1550.1241798384103;1636.0919689572402;1657.4199030339284;795.5147360110328;891.9643214271487;906.7053207707521;932.8600709893434;958.3195930889008;16529.504114876574;16561.337546498005;16841.15794210309;17005.23476443563;17078.29217078282;790.1505881177757;820.3642177312511;822.7901885019402;827.8096037911314;839.7774589733725;9382.10869967352;9536.952315238519;9575.616975320909;9603.471809050568;9898.010198980044;368864;380667;384118;384838;385360;55858.720706396205;75270;77532.2246777525;78037.60981195058;79531.60234198792;910.6357457017247;927.1655510041018;961.4711908450464;988.4662282367441;995.5420506566916;15521.84478155204;15794.9210253948;15927.283272253007;16070.517884463485;16278.348866045226;35834.64165358313;36956.81521592375;37339.25321493609;37371;38816;50863.08855453312;51186;51683.48316516787;51997;52105.739471302404;6802.693878775566;6936.861262774615;7150.821229469097;7320.15818180916;7332.19345871943;8460.98468183822;9606.991265916979;9882.50587470638;10163.593456261668;10514.894851051391;8210.096889342049;9558.139767420687;9612.855807162758;9616.23070154372;9778.511074446107;9597.856032159383;9683.080107389787;9805.901940980784;9815.85276220843;10016;9267.212286955415;9344.205742511962;9450.716478505656;9498.19265362452;9844.852327215242;7104.325089116525;7172.856542869218;7259.891101633374;7283.963580182065;7290.854182916418;9095.590698418455;9300.162985331082;9421.62313507452;9574.56914438838;9735.221182305257 08:01:03 INFO - PROCESS | 27020 | |3;mootools.html;1422.445246353922;1429.421084460793;1546.2887071946905;1732.211843611157;1751.2119546204203;6879.27767584404;7475.775726728193;7480.62596870157;8062;8062.556559389232;7604.125525564562;7894.565798881059;7897.763067107981;7917.722879699211;7961.7213397531095;2127.6489379252403;2155.062547791708;2161.329987703809;2162.0378931375544;2165.761766205724;2152.6878602602615;2173.293679554143;2204.812590929773;2215.966760498594;2216.3794137641485;2115.048228297265;2123.2568600989684;2126.957460850782;2127.914883404662;2155.91376344946;2087.4572611121066;2094.4554415851835;2095.947601309972;2102.054075665949;2109.177420805887;2066.9793302066937;2144.4102871710247;2152.13914434226;2168.6638571021517;2169.2190811307914;7876.684932602689;7919.247671471258;7928.722494712715;7938.126806051329;7961.522308661499;4575.267957126844;4641.0949864776385;4681.1105889881155;4697.7181369117625;4704.223803072489;2876.5828954801646;2964.095950735025;3040.528718048706;3053.5267033609825;3054.068509104722;820.766081666728;881.6914080071988;893.678275820704;896.3367108339781;902.0888902208751;10355.326903751233;10359;10373;10413.843792343045;10455.947720261425;4155.501339839178;4194.769287689206;4259.254630439661;4291.9785401072795;4317.158154159909;8962.372633915564;9062.275017998545;9064.54677266134;9117.08829117083;9128.041555636695;4556.749378784199;4577.267637178035;4584.6561507887045;4597.0346227291975;4619.099275641218;3729.5151630287887;4211.642010429086;4221.831126754895;4226.429432026637;4353.412289340962;3678.613745556678;3686.852525898934;3766.472693822867;3766.8681596144;3801.3347664159214;1176.2589568571746;1189.3161432176532;1201.6335017819474;1203.6148432501516;1217.184486394118;745.6420917959301;805.6173317674175;822.761399194227;826.991070893509;847.3475423923544;4909.950900491021;5079.5428411443145;5085.898282034339;5135.255387968724;5149.639525233272;829.1708291708292;835.6615570693879;840.2899549880341;858.965641374338;860.475110182788;3579.158897659048;3638.0541059324764;3642.0894776305922;3668.3396988541786;3716.851325946932;9593.13661770444;9796.314258001872;9850.901490985141;9858.605655773832;9902.752431189278;9665.855012174823;9726.541018847229;9742.46416447088;9747.3664211826;9754.561044753003;7194.820129496805;7202.747903823446;7389.667464964197;7403.22266162056;7417.554946703215;4853.39332583427;4948.802047918043;5003.524665156804;5036.06832735945;5059.721715305546;8843.204111629726;8853.114688531095;8941.329400295133;9121.589528471102;9150.40522366044;9053.275737940818;9074.591643375932;9089.136532029446;9095.317851161322;9230.630774769203;5839.182514448065;6328.873422531431;6543.869122617616;6552.24649165333;6582.308857569887;7728.304452599293;7755.991721076224;7761.107472640719;7801.3368863644955;7823.726169584037;6717.2946840581035;6915.896261556181;6997.965010174917;7012.509124361246;7147.392471639969;6849.280825513449;6851.760188393382;6864.5881247125335;6930.7227710891;7047.260037695968;6255.186825712628;6275.34108918557;6292.056191571301;6347.143135676624;6359.7456101755415;4616.261398176276;4638.420197475316;4647.697899636512;4651.2557990721325;4741.265103908761;4650.093231819763;4650.37219975299;4665.6967297125575;4747.430308363018;4800.087983283165 08:01:03 INFO - PROCESS | 27020 | |4;prototype.html;284.4581073055828;288.12841155504594;289.92027192522056;296.618844784452;298.8759664739133;4805.255185446253;4819.3734814474155;5003.824866129682;5039.874003149923;5044.545990860822;4797.664163508556;4844.709317440947;4854.635902307332;4878.804847806093;4883.755812209384;3873.6513713765758;3874.903127421816;3874.9418758718643;3878.1274213302063;3886.4947556817574;3665.9450108248398;3869.4582758413844;3906.726529142961;3934.783586902719;3951.111000024986;3797.582265950743;3802.2965751335955;3804.258169656918;3809.5047643806265;3818.026403267163;3856.8842934712;3858.7684738915755;3861.7489863158944;3864.6328598783352;3885.805709714531;3375.206826395795;3408.9829550852337;3410.420228561126;3410.925558449105;3417.9316413671836;4665.560091516784;4780.617550595979;4784.258439941815;4806.303086052503;4871.685949174114;4335.328024156261;4349.543297953733;4366.235908715994;4368.847090351855;4378.562143785628;5139.460356662534;5146.716930568818;5156.767945442427;5183.740812959375;5209.088409528355;3498.545189125423;3614.8915532534065;3622.6920711739535;3634.000649821294;3642.417213245868;5465.316835395575;5473.17902314656;5478.506934375885;5482.698451585161;5492.835214943558;3798.2213646202463;3817.141143242748;3818.7589033564204;3825.617438256152;3828.636279553438;3859.305325041463;3897.9805100974313;3898.941515877264;3903.980480097581;3906.453096566483;4172.7913604319665;4377.474703035656;4391.60475557195;4409.206342858252;4412.911741765147;5173.3533308336455;5180.922286165711;5183.922241166386;5224.9738751306;5233.424323324507;1238.8327575777334;1308.1823860087445;1336.9532066377824;1338.464614154346;1345.4416417186758;851.7061613743249;853.9957300213459;867.6572753762229;875.5272153037416;883.3551507399634;4000;4054.3107671695884;4071.572484889103;4107.486564179478;4146.647534959502;4695;4725.4565724941385;4762.9521505268785;4772.785224664898;4798.49615790344;4062.918741625151;4101.97949010259;4105.384192371168;4112.383142528584;4120.505539335299;2517.9118730844334;2661.9733802662113;2868.827870327787;2883.7116288370994;2903.637045369329;5073.619478539124;5085.898282034339;5133.153029750049;5170.431252562215;5204.609654275944;5320.494553017457;5552.611847038241;5568.192612071227;5577.749001294951;5632.943670563324;5063.999999999926;5071.290019397287;5077.009983053417;5103.336566246438;5113.335266415343;5362.892742145214;5393.164059570773;5438.347398312228;5438.809641662523;5465.672059676433;5084.796608135781;5220.112580861339;5270.578353731769;5308.389535203501;5337.866553336197;5082.745862706924;5089.491050894881;5112.897742045064;5115.335006449138;5118.240036765844;3593.317269718745;3598.5861625913353;3611.2777444510675;3640.5267315249907;3648.160922987781;5240.868978275574;5364.275822763877;5364.463553644604;5378.435264297193;5399.78400863961;5157.277981082727;5188.9740551297;5194.532492075731;5218.921716174184;5225.503577160163;5149.716765577929;5212.462323614619;5227.712475813867;5233.424323324355;5237.240600113038;5010.924836127534;5119.46245644202;5120.849243317741;5147.3308469898675;5173.198154286091;5221.608379371638;5234.869128271824;5252.133397989289;5254.845513339513;5285.603579731459;5076.898462030813;5128.743562821918;5138.766695993009;5217.869553261199;5233.476652334736 08:01:03 INFO - PROCESS | 27020 | |5;yui.html;673.3468535520543;690.9136357955256;723.4501778648226;740.8296091898864;758.9241075892415;11697.35664538451;12139.08956828237;12535.31055791931;12550.811737823917;12587.433565489551;12819;12844.293563853984;12855.614331570068;12915;12924.030697697663;624.3288464900251;791.1139523733398;795.2524626850757;803.8231589050429;803.8834369016489;802.314021511608;802.7792357101814;803.5901690138043;804.2199066905092;807.3137832842096;837.2590257622018;842.2335674536173;842.4608250719544;845.1970627903486;846.6190214403513;836.2306677856386;836.3518273338151;837.7947402886301;838.5010918503481;838.861587838006;614.1095411653121;615.0804547201917;617.4874853871275;619.164128426625;620.5221979076086;11260;11345.546178152865;11362.829557556643;11367.602133925273;11388.943055284753;12149.453274602663;12601.558945436956;12712.745745085047;12996.87003129966;13027.153235039692;10245.538950747234;10303.175745940307;10349;10497.160227181806;10723.517441715141;3281.392942305657;3314.734821214297;3325.833708314575;3367.9494807577908;3370.9157271068175;50355;51639.74180129075;51847.481525184645;51962;52242;9327.347085704072;9634.277429192838;9862.112409883002;9930.50347482623;10007.699769006942;17813.287468501116;17819.287228510715;17844.19701113427;17844.286228550973;17869.285228590972;6410.61536307823;6605.339466053452;6621.437177839937;6648.601083934979;6736.124303840469;3710.7031437485475;3733.2346868891814;3744.3260213161893;3747.1381582235695;3760.379537376357;2889.8266104033823;2996.715312045352;2997.565353023799;2997.8800847965836;2999.115260998011;507.53814029233956;519.6803965561153;523.3667262612206;523.4294618865455;543.6439132368305;566.5722379603455;587.7384563869037;593.1340243244911;594.6135012242078;623.7536173211647;7449.515781474187;7619.4285428593075;7636.732714354971;7748.496347737379;7843.6470358833985;562.2774734466192;569.2173261765073;575.4360726488065;578.2709698002941;581.9185314056035;3568.3041806847937;3573.5890372606964;3632.3461776880417;3663.8900832975055;3701.555813302367;58679;59832.401675982685;61091;63461.36538634555;64140.679296603215;57118;57242.141367878685;57456;59077;59912.40087599068;51585.48414515882;52153.47846521638;52499.73750131225;53372;54367.72816135894;7549;7604.8479030420185;7821.960890195513;7863.528188308491;8269.751907442786;30235.395292094476;31117.688823112385;31696.841515792272;31748.68251317457;32165.517517236793;40332.1933561333;40934;41382;41896.162076758905;42337.15325693407;10316.381017138996;10451.320664156805;10519.684409467422;10601.46992650349;10842.241043126905;11333.077792324822;11413.60052398162;12023.45894434735;12158.878411215775;12302;10588.841167382341;10884.94557527239;10978.890211097787;11140.108791296514;11299.152563557602;10252.538635761557;10499.107575856138;10565;10755.892441075803;11369.488373023069;10251.58993640246;10626.029654036292;10845.349279043283;10846.403447810446;11025.83461248098;9211.030542519073;9950.601975920883;9957.751056223653;9959.950200248952;10035.949820251144;9294.72115836526;9560.330776845554;9566.712998610054;9654.27592930519;9707.223422126353 08:01:03 INFO - PROCESS | 27020 | __end_tp_report 08:01:03 INFO - PROCESS | 27020 | __start_cc_report 08:01:03 INFO - PROCESS | 27020 | _x_x_mozilla_cycle_collect,379 08:01:03 INFO - PROCESS | 27020 | __end_cc_report 08:01:03 INFO - PROCESS | 27020 | __startTimestamp1464620463850__endTimestamp 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | ------- Summary: start ------- 08:01:03 INFO - PROCESS | 27020 | Number of tests: 6 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#0] dojo.html Cycles:165 Average:4700.60 Median:4871.12 stddev:591.47 (12.1%) stddev-sans-first:571.31 08:01:03 INFO - PROCESS | 27020 | Values: 2664.5 2691.6 2701.9 2705.6 2716.0 4672.1 4685.7 4710.4 4787.5 4834.5 4675.7 4686.4 4723.7 4775.6 4792.3 4367.0 4388.4 4403.3 4460.5 4491.1 4348.4 4363.4 4397.1 4446.9 4485.8 541.3 4432.3 4450.8 4458.0 4480.8 4431.2 4437.2 4439.4 4469.3 4483.4 4397.3 4400.9 4412.0 4429.3 4457.7 4544.0 4552.8 4585.2 4688.1 4705.3 5051.3 5068.3 5071.4 5073.2 5133.6 5096.0 5106.0 5109.3 5140.8 5164.6 4680.2 4698.2 4711.3 4716.4 4726.5 5177.6 5204.0 5212.1 5230.4 5262.8 4933.7 4965.6 4968.8 4978.9 4980.8 5086.3 5133.9 5140.7 5141.3 5193.2 5003.3 5096.4 5103.9 5111.9 5141.5 4947.9 5024.7 5026.1 5084.4 5094.1 4091.9 4130.3 4252.2 4257.1 4286.3 3678.9 3718.5 3771.0 3776.9 3865.3 4321.2 4466.8 4479.4 4488.0 4523.2 5074.2 5091.9 5126.7 5166.8 5188.9 4411.7 4445.3 4457.2 4479.5 4502.5 4494.0 4527.4 4597.8 4598.5 4623.9 4815.4 4839.9 4855.8 4871.1 4915.9 5091.3 5095.1 5126.8 5157.2 5202.3 4754.9 4800.1 4828.8 4844.4 4895.1 5031.3 5040.8 5050.6 5067.8 5103.4 5117.0 5121.6 5127.5 5136.3 5149.7 4839.6 4979.5 4992.2 5003.9 5059.4 5019.7 5046.6 5061.1 5061.6 5118.2 4967.9 4977.3 4979.1 5002.2 5004.6 4946.3 5000.8 5045.6 5069.6 5070.6 4911.4 4974.1 4985.2 4987.1 4997.7 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#1] ext.html Cycles:180 Average:46357.13 Median:36891.35 stddev:85998.11 (233.1%) stddev-sans-first:86170.62 08:01:03 INFO - PROCESS | 27020 | Values: 560.1 583.2 600.8 610.4 631.7 27414.5 38779.8 39836.0 39900.0 40073.4 40126.0 40401.6 40511.0 40746.0 40772.6 7548.6 7681.2 7724.9 7725.9 7730.4 7580.8 7687.0 7688.5 7693.6 7697.5 7709.1 7714.5 7742.3 7767.1 7779.7 7478.3 7561.1 7564.2 7564.7 7591.2 7546.1 7584.1 7596.2 7632.1 7654.6 36848.4 37293.4 37295.3 37310.3 37350.3 2873.3 2950.4 2979.8 3237.0 3251.5 27758.3 28120.3 28419.0 28675.7 28914.3 3371.2 3409.2 3412.2 3421.0 3477.8 215035.0 215095.0 215252.0 216058.0 217846.0 31019.7 51347.0 51910.0 52079.5 52286.7 32746.5 34736.7 34912.3 34923.8 34981.8 13139.9 13174.4 13228.9 13270.5 13290.7 10870.7 10902.9 10904.1 10909.2 10943.7 7879.7 8014.2 8037.5 8081.5 8120.9 3106.7 3126.8 3141.9 3147.5 3190.6 840.3 845.9 846.5 933.9 985.4 28039.0 28792.0 28853.1 28861.6 29008.0 878.6 926.5 988.2 1023.8 1051.9 14933.9 15326.5 15449.0 15847.7 16221.6 382689.0 382901.0 383368.0 385145.0 385624.0 50465.0 51038.5 51113.2 51155.5 51201.2 1134.7 1190.5 1191.6 1195.3 1209.5 28997.4 29743.7 29985.7 30057.7 30480.2 43819.3 43917.8 44262.0 44581.3 44691.6 348053.0 350749.0 352015.0 352437.0 355665.0 24908.4 25392.7 25699.5 25701.7 25757.2 39506.2 42889.1 43901.3 43946.0 44173.0 36328.5 37342.3 37404.3 37407.8 37509.2 36465.0 36776.8 36934.3 36985.3 37179.4 31541.8 35675.5 36633.6 37144.4 37308.0 33051.0 34156.0 34603.8 34673.3 34754.7 26029.3 26196.0 26326.9 26501.0 26876.7 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#2] jquery.html Cycles:180 Average:23789.44 Median:5971.71 stddev:62997.60 (1054.9%) stddev-sans-first:63149.73 08:01:03 INFO - PROCESS | 27020 | Values: 341.7 347.7 356.9 362.8 365.6 15716.0 16537.8 17702.0 17738.5 17814.1 15729.2 16318.1 16466.6 16515.2 16532.2 4803.5 5103.3 5107.4 5112.6 5123.5 3691.4 4996.0 5662.0 5956.7 5967.2 5976.2 5994.9 6000.5 6007.2 6008.1 5782.4 5943.0 5982.4 5984.6 5987.1 5005.6 5191.5 5197.7 5197.7 5226.3 17763.3 18706.9 20779.5 21079.7 21095.9 1711.1 1723.4 1743.1 1848.6 2357.4 8901.4 9177.3 9256.2 9284.9 9300.6 1598.5 1734.4 1787.2 1802.7 1810.1 69064.3 71823.6 72619.3 73009.0 74107.0 9080.4 9226.3 9243.4 9273.3 9384.9 12026.0 12066.5 12116.5 12123.4 12152.8 6884.8 6918.3 6927.6 6993.5 7030.7 6584.3 6663.3 6881.8 6887.6 6890.9 3755.5 3763.8 3827.1 3908.2 3917.5 1527.9 1546.0 1550.1 1636.1 1657.4 795.5 892.0 906.7 932.9 958.3 16529.5 16561.3 16841.2 17005.2 17078.3 790.2 820.4 822.8 827.8 839.8 9382.1 9537.0 9575.6 9603.5 9898.0 368864.0 380667.0 384118.0 384838.0 385360.0 55858.7 75270.0 77532.2 78037.6 79531.6 910.6 927.2 961.5 988.5 995.5 15521.8 15794.9 15927.3 16070.5 16278.3 35834.6 36956.8 37339.3 37371.0 38816.0 50863.1 51186.0 51683.5 51997.0 52105.7 6802.7 6936.9 7150.8 7320.2 7332.2 8461.0 9607.0 9882.5 10163.6 10514.9 8210.1 9558.1 9612.9 9616.2 9778.5 9597.9 9683.1 9805.9 9815.9 10016.0 9267.2 9344.2 9450.7 9498.2 9844.9 7104.3 7172.9 7259.9 7284.0 7290.9 9095.6 9300.2 9421.6 9574.6 9735.2 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#3] mootools.html Cycles:180 Average:5154.13 Median:5069.63 stddev:2889.69 (57.0%) stddev-sans-first:2884.19 08:01:03 INFO - PROCESS | 27020 | Values: 1422.4 1429.4 1546.3 1732.2 1751.2 6879.3 7475.8 7480.6 8062.0 8062.6 7604.1 7894.6 7897.8 7917.7 7961.7 2127.6 2155.1 2161.3 2162.0 2165.8 2152.7 2173.3 2204.8 2216.0 2216.4 2115.0 2123.3 2127.0 2127.9 2155.9 2087.5 2094.5 2095.9 2102.1 2109.2 2067.0 2144.4 2152.1 2168.7 2169.2 7876.7 7919.2 7928.7 7938.1 7961.5 4575.3 4641.1 4681.1 4697.7 4704.2 2876.6 2964.1 3040.5 3053.5 3054.1 820.8 881.7 893.7 896.3 902.1 10355.3 10359.0 10373.0 10413.8 10455.9 4155.5 4194.8 4259.3 4292.0 4317.2 8962.4 9062.3 9064.5 9117.1 9128.0 4556.7 4577.3 4584.7 4597.0 4619.1 3729.5 4211.6 4221.8 4226.4 4353.4 3678.6 3686.9 3766.5 3766.9 3801.3 1176.3 1189.3 1201.6 1203.6 1217.2 745.6 805.6 822.8 827.0 847.3 4910.0 5079.5 5085.9 5135.3 5149.6 829.2 835.7 840.3 859.0 860.5 3579.2 3638.1 3642.1 3668.3 3716.9 9593.1 9796.3 9850.9 9858.6 9902.8 9665.9 9726.5 9742.5 9747.4 9754.6 7194.8 7202.7 7389.7 7403.2 7417.6 4853.4 4948.8 5003.5 5036.1 5059.7 8843.2 8853.1 8941.3 9121.6 9150.4 9053.3 9074.6 9089.1 9095.3 9230.6 5839.2 6328.9 6543.9 6552.2 6582.3 7728.3 7756.0 7761.1 7801.3 7823.7 6717.3 6915.9 6998.0 7012.5 7147.4 6849.3 6851.8 6864.6 6930.7 7047.3 6255.2 6275.3 6292.1 6347.1 6359.7 4616.3 4638.4 4647.7 4651.3 4741.3 4650.1 4650.4 4665.7 4747.4 4800.1 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#4] prototype.html Cycles:180 Average:4273.65 Median:4812.84 stddev:1261.98 (26.2%) stddev-sans-first:1229.49 08:01:03 INFO - PROCESS | 27020 | Values: 284.5 288.1 289.9 296.6 298.9 4805.3 4819.4 5003.8 5039.9 5044.5 4797.7 4844.7 4854.6 4878.8 4883.8 3873.7 3874.9 3874.9 3878.1 3886.5 3665.9 3869.5 3906.7 3934.8 3951.1 3797.6 3802.3 3804.3 3809.5 3818.0 3856.9 3858.8 3861.7 3864.6 3885.8 3375.2 3409.0 3410.4 3410.9 3417.9 4665.6 4780.6 4784.3 4806.3 4871.7 4335.3 4349.5 4366.2 4368.8 4378.6 5139.5 5146.7 5156.8 5183.7 5209.1 3498.5 3614.9 3622.7 3634.0 3642.4 5465.3 5473.2 5478.5 5482.7 5492.8 3798.2 3817.1 3818.8 3825.6 3828.6 3859.3 3898.0 3898.9 3904.0 3906.5 4172.8 4377.5 4391.6 4409.2 4412.9 5173.4 5180.9 5183.9 5225.0 5233.4 1238.8 1308.2 1337.0 1338.5 1345.4 851.7 854.0 867.7 875.5 883.4 4000.0 4054.3 4071.6 4107.5 4146.6 4695.0 4725.5 4763.0 4772.8 4798.5 4062.9 4102.0 4105.4 4112.4 4120.5 2517.9 2662.0 2868.8 2883.7 2903.6 5073.6 5085.9 5133.2 5170.4 5204.6 5320.5 5552.6 5568.2 5577.7 5632.9 5064.0 5071.3 5077.0 5103.3 5113.3 5362.9 5393.2 5438.3 5438.8 5465.7 5084.8 5220.1 5270.6 5308.4 5337.9 5082.7 5089.5 5112.9 5115.3 5118.2 3593.3 3598.6 3611.3 3640.5 3648.2 5240.9 5364.3 5364.5 5378.4 5399.8 5157.3 5189.0 5194.5 5218.9 5225.5 5149.7 5212.5 5227.7 5233.4 5237.2 5010.9 5119.5 5120.8 5147.3 5173.2 5221.6 5234.9 5252.1 5254.8 5285.6 5076.9 5128.7 5138.8 5217.9 5233.5 08:01:03 INFO - PROCESS | 27020 | 08:01:03 INFO - PROCESS | 27020 | [#5] yui.html Cycles:180 Average:13894.40 Median:51743.61 stddev:17124.33 (33.1%) stddev-sans-first:17143.59 08:01:03 INFO - PROCESS | 27020 | Values: 673.3 690.9 723.5 740.8 758.9 11697.4 12139.1 12535.3 12550.8 12587.4 12819.0 12844.3 12855.6 12915.0 12924.0 624.3 791.1 795.3 803.8 803.9 802.3 802.8 803.6 804.2 807.3 837.3 842.2 842.5 845.2 846.6 836.2 836.4 837.8 838.5 838.9 614.1 615.1 617.5 619.2 620.5 11260.0 11345.5 11362.8 11367.6 11388.9 12149.5 12601.6 12712.7 12996.9 13027.2 10245.5 10303.2 10349.0 10497.2 10723.5 3281.4 3314.7 3325.8 3367.9 3370.9 50355.0 51639.7 51847.5 51962.0 52242.0 9327.3 9634.3 9862.1 9930.5 10007.7 17813.3 17819.3 17844.2 17844.3 17869.3 6410.6 6605.3 6621.4 6648.6 6736.1 3710.7 3733.2 3744.3 3747.1 3760.4 2889.8 2996.7 2997.6 2997.9 2999.1 507.5 519.7 523.4 523.4 543.6 566.6 587.7 593.1 594.6 623.8 7449.5 7619.4 7636.7 7748.5 7843.6 562.3 569.2 575.4 578.3 581.9 3568.3 3573.6 3632.3 3663.9 3701.6 58679.0 59832.4 61091.0 63461.4 64140.7 57118.0 57242.1 57456.0 59077.0 59912.4 51585.5 52153.5 52499.7 53372.0 54367.7 7549.0 7604.8 7822.0 7863.5 8269.8 30235.4 31117.7 31696.8 31748.7 32165.5 40332.2 40934.0 41382.0 41896.2 42337.2 10316.4 10451.3 10519.7 10601.5 10842.2 11333.1 11413.6 12023.5 12158.9 12302.0 10588.8 10884.9 10978.9 11140.1 11299.2 10252.5 10499.1 10565.0 10755.9 11369.5 10251.6 10626.0 10845.3 10846.4 11025.8 9211.0 9950.6 9957.8 9960.0 10035.9 9294.7 9560.3 9566.7 9654.3 9707.2 08:01:03 INFO - PROCESS | 27020 | -------- Summary: end -------- 08:01:03 INFO - PROCESS | 27020 | 08:01:04 INFO - TEST-INFO | 27020: exit 0 08:01:04 INFO - TEST-OK | dromaeo_css | took 1114755ms 08:01:04 INFO - TEST-START | kraken 08:01:04 INFO - operating with platform_type : linux_ 08:01:04 INFO - Initialising browser for kraken test... 08:01:04 INFO - TEST-INFO | started process 27256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppS4Tmc/profile http://localhost:59554/getInfo.html) 08:01:09 INFO - PROCESS | 27256 | __metrics Screen width/height:1600/1200 08:01:09 INFO - PROCESS | 27256 | colorDepth:24 08:01:09 INFO - PROCESS | 27256 | Browser inner width/height: 1024/697 08:01:09 INFO - PROCESS | 27256 | __metrics 08:01:09 ERROR - PROCESS | 27256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:01:10 INFO - TEST-INFO | 27256: exit 0 08:01:10 INFO - Browser initialized. 08:01:10 INFO - Running cycle 1/1 for kraken test... 08:01:10 INFO - TEST-INFO | started process 27373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppS4Tmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:22 INFO - PROCESS | 27373 | RSS: Main: 167981056 08:01:22 INFO - PROCESS | 27373 | 08:01:25 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59554/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:26 INFO - PROCESS | 27373 | RSS: Main: 172232704 08:01:26 INFO - PROCESS | 27373 | 08:01:29 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59554/tests/kraken/driver.html?testName=audio-dft) 08:01:29 INFO - PROCESS | 27373 | RSS: Main: 171855872 08:01:29 INFO - PROCESS | 27373 | 08:01:32 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59554/tests/kraken/driver.html?testName=audio-fft) 08:01:33 INFO - PROCESS | 27373 | RSS: Main: 167354368 08:01:33 INFO - PROCESS | 27373 | 08:01:35 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59554/tests/kraken/driver.html?testName=audio-oscillator) 08:01:36 INFO - PROCESS | 27373 | RSS: Main: 168210432 08:01:36 INFO - PROCESS | 27373 | 08:01:38 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:38 INFO - PROCESS | 27373 | RSS: Main: 168853504 08:01:38 INFO - PROCESS | 27373 | 08:01:42 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59554/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:42 INFO - PROCESS | 27373 | RSS: Main: 168726528 08:01:42 INFO - PROCESS | 27373 | 08:01:46 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59554/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:46 INFO - PROCESS | 27373 | RSS: Main: 166260736 08:01:46 INFO - PROCESS | 27373 | 08:01:49 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59554/tests/kraken/driver.html?testName=json-parse-financial) 08:01:50 INFO - PROCESS | 27373 | RSS: Main: 167849984 08:01:50 INFO - PROCESS | 27373 | 08:01:52 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:52 INFO - PROCESS | 27373 | RSS: Main: 167727104 08:01:52 INFO - PROCESS | 27373 | 08:01:54 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:55 INFO - PROCESS | 27373 | RSS: Main: 168095744 08:01:55 INFO - PROCESS | 27373 | 08:01:57 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:58 INFO - PROCESS | 27373 | RSS: Main: 168505344 08:01:58 INFO - PROCESS | 27373 | 08:02:00 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:01 INFO - PROCESS | 27373 | RSS: Main: 168439808 08:02:01 INFO - PROCESS | 27373 | 08:02:04 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:05 INFO - PROCESS | 27373 | RSS: Main: 168706048 08:02:05 INFO - PROCESS | 27373 | 08:02:06 INFO - PROCESS | 27373 | Cycle 1(1): loaded http://localhost:59554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59554/tests/kraken/driver.html?testName=ai-astar) 08:02:07 INFO - PROCESS | 27373 | RSS: Main: 169476096 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | __start_tp_report 08:02:07 INFO - PROCESS | 27373 | _x_x_mozilla_page_load 08:02:07 INFO - PROCESS | 27373 | _x_x_mozilla_page_load_details 08:02:07 INFO - PROCESS | 27373 | |i|pagename|runs| 08:02:07 INFO - PROCESS | 27373 | |0;ai-astar;117;110;114;112;112;114;114;113;113;113 08:02:07 INFO - PROCESS | 27373 | |1;audio-beat-detection;163;132;156;177;132;171;157;139;213;139 08:02:07 INFO - PROCESS | 27373 | |2;audio-dft;162;163;165;175;163;162;164;164;164;162 08:02:07 INFO - PROCESS | 27373 | |3;audio-fft;76;77;75;173;76;75;76;77;161;77 08:02:07 INFO - PROCESS | 27373 | |4;audio-oscillator;85;85;148;84;85;84;139;85;85;142 08:02:07 INFO - PROCESS | 27373 | |5;imaging-gaussian-blur;117;118;117;119;117;117;118;118;118;118 08:02:07 INFO - PROCESS | 27373 | |6;imaging-darkroom;147;147;146;150;150;150;147;148;146;148 08:02:07 INFO - PROCESS | 27373 | |7;imaging-desaturate;95;95;95;94;95;96;101;100;96;95 08:02:07 INFO - PROCESS | 27373 | |8;json-parse-financial;62;65;64;62;66;63;63;62;62;64 08:02:07 INFO - PROCESS | 27373 | |9;json-stringify-tinderbox;65;66;66;65;65;66;65;66;65;65 08:02:07 INFO - PROCESS | 27373 | |10;stanford-crypto-aes;85;87;83;85;85;85;86;85;112;84 08:02:07 INFO - PROCESS | 27373 | |11;stanford-crypto-ccm;150;149;153;128;132;136;138;136;137;131 08:02:07 INFO - PROCESS | 27373 | |12;stanford-crypto-pbkdf2;174;170;169;169;172;173;168;169;174;170 08:02:07 INFO - PROCESS | 27373 | |13;stanford-crypto-sha256-iterative;75;72;70;68;67;70;68;67;67;67 08:02:07 INFO - PROCESS | 27373 | __end_tp_report 08:02:07 INFO - PROCESS | 27373 | __start_cc_report 08:02:07 INFO - PROCESS | 27373 | _x_x_mozilla_cycle_collect,962 08:02:07 INFO - PROCESS | 27373 | __end_cc_report 08:02:07 INFO - PROCESS | 27373 | __startTimestamp1464620527173__endTimestamp 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | ------- Summary: start ------- 08:02:07 INFO - PROCESS | 27373 | Number of tests: 14 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.81 (1.6%) stddev-sans-first:1.30 08:02:07 INFO - PROCESS | 27373 | Values: 117.0 110.0 114.0 112.0 112.0 114.0 114.0 113.0 113.0 113.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:160.00 stddev:25.08 (15.7%) stddev-sans-first:26.53 08:02:07 INFO - PROCESS | 27373 | Values: 163.0 132.0 156.0 177.0 132.0 171.0 157.0 139.0 213.0 139.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.86 (2.4%) stddev-sans-first:4.00 08:02:07 INFO - PROCESS | 27373 | Values: 162.0 163.0 165.0 175.0 163.0 162.0 164.0 164.0 164.0 162.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.43 (50.6%) stddev-sans-first:40.18 08:02:07 INFO - PROCESS | 27373 | Values: 76.0 77.0 75.0 173.0 76.0 75.0 76.0 77.0 161.0 77.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.00 stddev:28.24 (33.2%) stddev-sans-first:29.26 08:02:07 INFO - PROCESS | 27373 | Values: 85.0 85.0 148.0 84.0 85.0 84.0 139.0 85.0 85.0 142.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:02:07 INFO - PROCESS | 27373 | Values: 117.0 118.0 117.0 119.0 117.0 117.0 118.0 118.0 118.0 118.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:1.66 08:02:07 INFO - PROCESS | 27373 | Values: 147.0 147.0 146.0 150.0 150.0 150.0 147.0 148.0 146.0 148.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.00 stddev:2.35 (2.5%) stddev-sans-first:2.45 08:02:07 INFO - PROCESS | 27373 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 101.0 100.0 96.0 95.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:1.42 (2.2%) stddev-sans-first:1.42 08:02:07 INFO - PROCESS | 27373 | Values: 62.0 65.0 64.0 62.0 66.0 63.0 63.0 62.0 62.0 64.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:02:07 INFO - PROCESS | 27373 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 65.0 65.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:8.60 (10.1%) stddev-sans-first:9.07 08:02:07 INFO - PROCESS | 27373 | Values: 85.0 87.0 83.0 85.0 85.0 85.0 86.0 85.0 112.0 84.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:137.50 stddev:8.65 (6.3%) stddev-sans-first:8.21 08:02:07 INFO - PROCESS | 27373 | Values: 150.0 149.0 153.0 128.0 132.0 136.0 138.0 136.0 137.0 131.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:2.25 (1.3%) stddev-sans-first:2.07 08:02:07 INFO - PROCESS | 27373 | Values: 174.0 170.0 169.0 169.0 172.0 173.0 168.0 169.0 174.0 170.0 08:02:07 INFO - PROCESS | 27373 | 08:02:07 INFO - PROCESS | 27373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.69 (3.9%) stddev-sans-first:1.81 08:02:07 INFO - PROCESS | 27373 | Values: 75.0 72.0 70.0 68.0 67.0 70.0 68.0 67.0 67.0 67.0 08:02:07 INFO - PROCESS | 27373 | -------- Summary: end -------- 08:02:07 INFO - PROCESS | 27373 | 08:02:08 INFO - TEST-INFO | 27373: exit 0 08:02:08 INFO - TEST-OK | kraken | took 63574ms 08:02:08 INFO - SUITE-END | took 1178s 08:02:08 INFO - Completed test suite (00:19:38) 08:02:08 INFO - javascript benchmark 08:02:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6247.433232439796, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.480426316868, 2691.5962605609157, 2701.8784154713035, 2705.5941608758694, 2716.0222319964796, 4672.065586882624, 4685.742284174369, 4710.364100846385, 4787.497312782151, 4834.468208497063, 4675.719456832592, 4686.3907692000075, 4723.740194289313, 4775.617950563956, 4792.329073929653, 4367.0, 4388.429504164455, 4403.251447253959, 4460.50934397216, 4491.079328737617, 4348.391225228471, 4363.432753742025, 4397.098594788077, 4446.933296000562, 4485.842995495158, 541.2655114496885, 4432.290833466646, 4450.799714012877, 4457.955420445786, 4480.775961201944, 4431.158079964796, 4437.245668236407, 4439.356293337448, 4469.262571675702, 4483.3723278741, 4397.274449715793, 4400.933985990213, 4412.0, 4429.269170586849, 4457.66567507435, 4543.977280113611, 4552.795124219385, 4585.151746926829, 4688.109259240733, 4705.270683044134, 5051.267566202917, 5068.265101560253, 5071.39143302806, 5073.188289873602, 5133.640645154841, 5096.0, 5106.0, 5109.335786347789, 5140.845774626767, 5164.638475306692, 4680.204365257914, 4698.224792909165, 4711.316859055418, 4716.434027916604, 4726.527347265246, 5177.637565370464, 5204.037253108111, 5212.139996900469, 5230.424653288135, 5262.815801446931, 4933.679310844784, 4965.553100220925, 4968.826091086795, 4978.925316120261, 4980.77586508608, 5086.287919691246, 5133.8716532087, 5140.717260550631, 5141.2545180948555, 5193.169092945111, 5003.2995380646735, 5096.388433388017, 5103.870610036889, 5111.948880511221, 5141.53726164647, 4947.90104197914, 5024.723640199751, 5026.145555255615, 5084.41529224144, 5094.057599344059, 4091.8772436826944, 4130.297849365555, 4252.234597772431, 4257.127288905767, 4286.292761694348, 3678.9448158277646, 3718.4980027696456, 3771.0195349209403, 3776.9244615108096, 3865.304245235828, 4321.222180007629, 4466.776661166994, 4479.395281636937, 4488.035072459437, 4523.185826551186, 5074.23886417033, 5091.949080509147, 5126.69239845603, 5166.793328266903, 5188.948110518922, 4411.713238639478, 4445.266531022345, 4457.2199865023495, 4479.529649386833, 4502.459704835441, 4494.033782736662, 4527.411436513298, 4597.816087356535, 4598.471175814757, 4623.907521849612, 4815.446223684321, 4839.903201935871, 4855.8057677692495, 4871.123197824426, 4915.901681966412, 5091.287219789158, 5095.082885080721, 5126.846194614168, 5157.226416037474, 5202.3497062867145, 4754.904901902012, 4800.0639875224, 4828.782704778223, 4844.4186697596515, 4895.143349913822, 5031.295618613471, 5040.798368065236, 5050.570701490415, 5067.822626208065, 5103.362079740033, 5116.974415128049, 5121.564667003347, 5127.53852153308, 5136.2552429898205, 5149.6910185389, 4839.588634966068, 4979.502049794992, 4992.226204938241, 5003.924941125813, 5059.418166910852, 5019.698818070928, 5046.621503387188, 5061.114304996538, 5061.620378471555, 5118.155504341742, 4967.875803104951, 4977.328060711758, 4979.0788704089855, 5002.17464118431, 5004.599632029502, 4946.307516947558, 5000.849974500771, 5045.596352291735, 5069.645124841373, 5070.619703522177, 4911.4106307243355, 4974.104661161025, 4985.152524070844, 4987.12725273083, 4997.675151115166], "value": 4665.591388931012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.0954458549442, 583.2388732703822, 600.8497875531116, 610.3652201710222, 631.728356806573, 27414.451710965794, 38779.806100969494, 39836.0, 39899.99999999996, 40073.39889901654, 40126.0, 40401.59598404015, 40511.0, 40746.0, 40772.59227407725, 7548.622568871562, 7681.155072941972, 7724.9227507725045, 7725.922740772605, 7730.420218483609, 7580.772576822704, 7687.0391201099865, 7688.538687678729, 7693.615319234043, 7697.461177717562, 7709.113451953013, 7714.498557593738, 7742.341900938427, 7767.145613982458, 7779.688812447495, 7478.326950574475, 7561.054868141482, 7564.243575642447, 7564.735234266802, 7591.240875912365, 7546.132194797614, 7584.089909210875, 7596.240375962415, 7632.122305934833, 7654.578998155099, 36848.44727329092, 37293.44059839105, 37295.25409491822, 37310.25379492422, 37350.25299493995, 2873.3104055026643, 2950.365671380642, 2979.7765167612297, 3236.9965310753505, 3251.5447837302795, 27758.306042349104, 28120.29699257535, 28419.0, 28675.713242867514, 28914.27714307138, 3371.2077661749468, 3409.1647546351055, 3412.1640198151613, 3421.0, 3477.8087205203706, 215035.0, 215095.0, 215252.0, 216058.0, 217846.0, 31019.68980310213, 51347.0, 51910.0, 52079.47920520822, 52286.73856630692, 32746.508802367982, 34736.65263347334, 34912.30175396478, 34923.825380873444, 34981.82509087489, 13139.868601313865, 13174.407151678197, 13228.867711322957, 13270.535531256359, 13290.66773330655, 10870.673879783619, 10902.890971090188, 10904.073153782017, 10909.23635345534, 10943.726406839893, 7879.724209652634, 8014.15851335613, 8037.477563958324, 8081.515109093473, 8120.878186827084, 3106.7048630380077, 3126.7649278535305, 3141.9214519636735, 3147.4806656901815, 3190.6330771961057, 840.3025488844245, 845.9069502354736, 846.4751853850652, 933.8552524358736, 985.3644399362371, 28039.0, 28791.99228027009, 28853.134405967856, 28861.56707649387, 29008.0, 878.5695009445326, 926.5228407370209, 988.2390559269322, 1023.8361862102176, 1051.8850018979754, 14933.850661493247, 15326.540203793904, 15449.0, 15847.683046339009, 16221.59446013859, 382689.0, 382901.0, 383368.0, 385145.0, 385624.0, 50465.0, 51038.48961510412, 51113.233301500506, 51155.488445115814, 51201.23198152031, 1134.6993046842592, 1190.5237904838134, 1191.6008137273936, 1195.3485350484007, 1209.4678341529698, 28997.42005159927, 29743.702562974093, 29985.700142998292, 30057.69942300549, 30480.237994050327, 43819.34270985874, 43917.78041109774, 44262.0, 44581.33128003018, 44691.55308446874, 348053.0, 350749.0, 352015.0, 352437.0, 355665.0, 24908.37729056788, 25392.730363481383, 25699.486010280063, 25701.742982570682, 25757.227283181535, 39506.209875801746, 42889.142217154855, 43901.341479878465, 43946.0, 44173.0, 36328.45507317445, 37342.253154937294, 37404.25191496209, 37407.81296093611, 37509.249815003, 36465.0, 36776.81611592032, 36934.26131477409, 36985.26029479449, 37179.44230836486, 31541.842290788398, 35675.46486802648, 36633.63366366302, 37144.44283335698, 37308.0, 33051.0, 34156.0, 34603.826980864935, 34673.30653386868, 34754.652453476156, 26029.349266268495, 26196.0, 26326.86836565805, 26501.0, 26876.731232687423], "value": 16503.988215762078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6668747970728, 347.69402925425624, 356.93039857227853, 362.7823306016389, 365.5887126982145, 15716.0, 16537.834621653794, 17702.0, 17738.467845964624, 17814.109294535287, 15729.213539323016, 16318.102504362256, 16466.588335291624, 16515.174241287918, 16532.173391330445, 4803.495632958541, 5103.2855400244, 5107.361579802525, 5112.565431938271, 5123.487651234866, 3691.427828686558, 4995.950040499585, 5662.0, 5956.7319470623925, 5967.194428752128, 5976.2230909981645, 5994.850128746794, 6000.459958603725, 6007.219061521996, 6008.128821320905, 5782.421757824226, 5943.049112142036, 5982.37185095563, 5984.581079324449, 5987.101934709828, 5005.647345747493, 5191.480851914816, 5197.688138711689, 5197.7401129943355, 5226.346706661668, 17763.289468421248, 18706.90646546772, 20779.480512987295, 21079.68380474279, 21095.894520527298, 1711.1187738314777, 1723.4484964811265, 1743.0587482759295, 1848.5840685845712, 2357.3635118518077, 8901.421407608485, 9177.311701622404, 9256.213221876149, 9284.932232793248, 9300.604909263597, 1598.45652478158, 1734.4363081998401, 1787.2493552707895, 1802.7295905614133, 1810.1401834128815, 69064.30935690629, 71823.64088179579, 72619.27380726178, 73009.0, 74107.0, 9080.40977336471, 9226.30802689801, 9243.445393276425, 9273.258139348836, 9384.8592271116, 12026.0, 12066.517339306329, 12116.515339386502, 12123.393830308449, 12152.817707734392, 6884.827879303058, 6918.342757438036, 6927.618980956096, 6993.545419547713, 7030.718771249195, 6584.275729669733, 6663.267040625527, 6881.793546193622, 6887.552309099892, 6890.931090689029, 3755.4742336072973, 3763.8494460221286, 3827.138893748884, 3908.179282350681, 3917.5103112110987, 1527.900686455377, 1545.9845401546065, 1550.1241798384103, 1636.0919689572402, 1657.4199030339284, 795.5147360110328, 891.9643214271487, 906.7053207707521, 932.8600709893434, 958.3195930889008, 16529.504114876574, 16561.337546498005, 16841.15794210309, 17005.23476443563, 17078.29217078282, 790.1505881177757, 820.3642177312511, 822.7901885019402, 827.8096037911314, 839.7774589733725, 9382.10869967352, 9536.952315238519, 9575.616975320909, 9603.471809050568, 9898.010198980044, 368864.0, 380667.0, 384118.0, 384838.0, 385360.0, 55858.720706396205, 75270.0, 77532.2246777525, 78037.60981195058, 79531.60234198792, 910.6357457017247, 927.1655510041018, 961.4711908450464, 988.4662282367441, 995.5420506566916, 15521.84478155204, 15794.9210253948, 15927.283272253007, 16070.517884463485, 16278.348866045226, 35834.64165358313, 36956.81521592375, 37339.25321493609, 37371.0, 38816.0, 50863.08855453312, 51186.0, 51683.48316516787, 51997.0, 52105.739471302404, 6802.693878775566, 6936.861262774615, 7150.821229469097, 7320.15818180916, 7332.19345871943, 8460.98468183822, 9606.991265916979, 9882.50587470638, 10163.593456261668, 10514.894851051391, 8210.096889342049, 9558.139767420687, 9612.855807162758, 9616.23070154372, 9778.511074446107, 9597.856032159383, 9683.080107389787, 9805.901940980784, 9815.85276220843, 10016.0, 9267.212286955415, 9344.205742511962, 9450.716478505656, 9498.19265362452, 9844.852327215242, 7104.325089116525, 7172.856542869218, 7259.891101633374, 7283.963580182065, 7290.854182916418, 9095.590698418455, 9300.162985331082, 9421.62313507452, 9574.56914438838, 9735.221182305257], "value": 7955.660444122297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.445246353922, 1429.421084460793, 1546.2887071946905, 1732.211843611157, 1751.2119546204203, 6879.27767584404, 7475.775726728193, 7480.62596870157, 8062.0, 8062.556559389232, 7604.125525564562, 7894.565798881059, 7897.763067107981, 7917.722879699211, 7961.7213397531095, 2127.6489379252403, 2155.062547791708, 2161.329987703809, 2162.0378931375544, 2165.761766205724, 2152.6878602602615, 2173.293679554143, 2204.812590929773, 2215.966760498594, 2216.3794137641485, 2115.048228297265, 2123.2568600989684, 2126.957460850782, 2127.914883404662, 2155.91376344946, 2087.4572611121066, 2094.4554415851835, 2095.947601309972, 2102.054075665949, 2109.177420805887, 2066.9793302066937, 2144.4102871710247, 2152.13914434226, 2168.6638571021517, 2169.2190811307914, 7876.684932602689, 7919.247671471258, 7928.722494712715, 7938.126806051329, 7961.522308661499, 4575.267957126844, 4641.0949864776385, 4681.1105889881155, 4697.7181369117625, 4704.223803072489, 2876.5828954801646, 2964.095950735025, 3040.528718048706, 3053.5267033609825, 3054.068509104722, 820.766081666728, 881.6914080071988, 893.678275820704, 896.3367108339781, 902.0888902208751, 10355.326903751233, 10359.0, 10373.0, 10413.843792343045, 10455.947720261425, 4155.501339839178, 4194.769287689206, 4259.254630439661, 4291.9785401072795, 4317.158154159909, 8962.372633915564, 9062.275017998545, 9064.54677266134, 9117.08829117083, 9128.041555636695, 4556.749378784199, 4577.267637178035, 4584.6561507887045, 4597.0346227291975, 4619.099275641218, 3729.5151630287887, 4211.642010429086, 4221.831126754895, 4226.429432026637, 4353.412289340962, 3678.613745556678, 3686.852525898934, 3766.472693822867, 3766.8681596144, 3801.3347664159214, 1176.2589568571746, 1189.3161432176532, 1201.6335017819474, 1203.6148432501516, 1217.184486394118, 745.6420917959301, 805.6173317674175, 822.761399194227, 826.991070893509, 847.3475423923544, 4909.950900491021, 5079.5428411443145, 5085.898282034339, 5135.255387968724, 5149.639525233272, 829.1708291708292, 835.6615570693879, 840.2899549880341, 858.965641374338, 860.475110182788, 3579.158897659048, 3638.0541059324764, 3642.0894776305922, 3668.3396988541786, 3716.851325946932, 9593.13661770444, 9796.314258001872, 9850.901490985141, 9858.605655773832, 9902.752431189278, 9665.855012174823, 9726.541018847229, 9742.46416447088, 9747.3664211826, 9754.561044753003, 7194.820129496805, 7202.747903823446, 7389.667464964197, 7403.22266162056, 7417.554946703215, 4853.39332583427, 4948.802047918043, 5003.524665156804, 5036.06832735945, 5059.721715305546, 8843.204111629726, 8853.114688531095, 8941.329400295133, 9121.589528471102, 9150.40522366044, 9053.275737940818, 9074.591643375932, 9089.136532029446, 9095.317851161322, 9230.630774769203, 5839.182514448065, 6328.873422531431, 6543.869122617616, 6552.24649165333, 6582.308857569887, 7728.304452599293, 7755.991721076224, 7761.107472640719, 7801.3368863644955, 7823.726169584037, 6717.2946840581035, 6915.896261556181, 6997.965010174917, 7012.509124361246, 7147.392471639969, 6849.280825513449, 6851.760188393382, 6864.5881247125335, 6930.7227710891, 7047.260037695968, 6255.186825712628, 6275.34108918557, 6292.056191571301, 6347.143135676624, 6359.7456101755415, 4616.261398176276, 4638.420197475316, 4647.697899636512, 4651.2557990721325, 4741.265103908761, 4650.093231819763, 4650.37219975299, 4665.6967297125575, 4747.430308363018, 4800.087983283165], "value": 4143.018844191507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.4581073055828, 288.12841155504594, 289.92027192522056, 296.618844784452, 298.8759664739133, 4805.255185446253, 4819.3734814474155, 5003.824866129682, 5039.874003149923, 5044.545990860822, 4797.664163508556, 4844.709317440947, 4854.635902307332, 4878.804847806093, 4883.755812209384, 3873.6513713765758, 3874.903127421816, 3874.9418758718643, 3878.1274213302063, 3886.4947556817574, 3665.9450108248398, 3869.4582758413844, 3906.726529142961, 3934.783586902719, 3951.111000024986, 3797.582265950743, 3802.2965751335955, 3804.258169656918, 3809.5047643806265, 3818.026403267163, 3856.8842934712, 3858.7684738915755, 3861.7489863158944, 3864.6328598783352, 3885.805709714531, 3375.206826395795, 3408.9829550852337, 3410.420228561126, 3410.925558449105, 3417.9316413671836, 4665.560091516784, 4780.617550595979, 4784.258439941815, 4806.303086052503, 4871.685949174114, 4335.328024156261, 4349.543297953733, 4366.235908715994, 4368.847090351855, 4378.562143785628, 5139.460356662534, 5146.716930568818, 5156.767945442427, 5183.740812959375, 5209.088409528355, 3498.545189125423, 3614.8915532534065, 3622.6920711739535, 3634.000649821294, 3642.417213245868, 5465.316835395575, 5473.17902314656, 5478.506934375885, 5482.698451585161, 5492.835214943558, 3798.2213646202463, 3817.141143242748, 3818.7589033564204, 3825.617438256152, 3828.636279553438, 3859.305325041463, 3897.9805100974313, 3898.941515877264, 3903.980480097581, 3906.453096566483, 4172.7913604319665, 4377.474703035656, 4391.60475557195, 4409.206342858252, 4412.911741765147, 5173.3533308336455, 5180.922286165711, 5183.922241166386, 5224.9738751306, 5233.424323324507, 1238.8327575777334, 1308.1823860087445, 1336.9532066377824, 1338.464614154346, 1345.4416417186758, 851.7061613743249, 853.9957300213459, 867.6572753762229, 875.5272153037416, 883.3551507399634, 4000.0, 4054.3107671695884, 4071.572484889103, 4107.486564179478, 4146.647534959502, 4695.0, 4725.4565724941385, 4762.9521505268785, 4772.785224664898, 4798.49615790344, 4062.918741625151, 4101.97949010259, 4105.384192371168, 4112.383142528584, 4120.505539335299, 2517.9118730844334, 2661.9733802662113, 2868.827870327787, 2883.7116288370994, 2903.637045369329, 5073.619478539124, 5085.898282034339, 5133.153029750049, 5170.431252562215, 5204.609654275944, 5320.494553017457, 5552.611847038241, 5568.192612071227, 5577.749001294951, 5632.943670563324, 5063.999999999926, 5071.290019397287, 5077.009983053417, 5103.336566246438, 5113.335266415343, 5362.892742145214, 5393.164059570773, 5438.347398312228, 5438.809641662523, 5465.672059676433, 5084.796608135781, 5220.112580861339, 5270.578353731769, 5308.389535203501, 5337.866553336197, 5082.745862706924, 5089.491050894881, 5112.897742045064, 5115.335006449138, 5118.240036765844, 3593.317269718745, 3598.5861625913353, 3611.2777444510675, 3640.5267315249907, 3648.160922987781, 5240.868978275574, 5364.275822763877, 5364.463553644604, 5378.435264297193, 5399.78400863961, 5157.277981082727, 5188.9740551297, 5194.532492075731, 5218.921716174184, 5225.503577160163, 5149.716765577929, 5212.462323614619, 5227.712475813867, 5233.424323324355, 5237.240600113038, 5010.924836127534, 5119.46245644202, 5120.849243317741, 5147.3308469898675, 5173.198154286091, 5221.608379371638, 5234.869128271824, 5252.133397989289, 5254.845513339513, 5285.603579731459, 5076.898462030813, 5128.743562821918, 5138.766695993009, 5217.869553261199, 5233.476652334736], "value": 3869.713042295844, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.3468535520543, 690.9136357955256, 723.4501778648226, 740.8296091898864, 758.9241075892415, 11697.35664538451, 12139.08956828237, 12535.31055791931, 12550.811737823917, 12587.433565489551, 12819.0, 12844.293563853984, 12855.614331570068, 12915.0, 12924.030697697663, 624.3288464900251, 791.1139523733398, 795.2524626850757, 803.8231589050429, 803.8834369016489, 802.314021511608, 802.7792357101814, 803.5901690138043, 804.2199066905092, 807.3137832842096, 837.2590257622018, 842.2335674536173, 842.4608250719544, 845.1970627903486, 846.6190214403513, 836.2306677856386, 836.3518273338151, 837.7947402886301, 838.5010918503481, 838.861587838006, 614.1095411653121, 615.0804547201917, 617.4874853871275, 619.164128426625, 620.5221979076086, 11260.0, 11345.546178152865, 11362.829557556643, 11367.602133925273, 11388.943055284753, 12149.453274602663, 12601.558945436956, 12712.745745085047, 12996.87003129966, 13027.153235039692, 10245.538950747234, 10303.175745940307, 10349.0, 10497.160227181806, 10723.517441715141, 3281.392942305657, 3314.734821214297, 3325.833708314575, 3367.9494807577908, 3370.9157271068175, 50355.0, 51639.74180129075, 51847.481525184645, 51962.0, 52242.0, 9327.347085704072, 9634.277429192838, 9862.112409883002, 9930.50347482623, 10007.699769006942, 17813.287468501116, 17819.287228510715, 17844.19701113427, 17844.286228550973, 17869.285228590972, 6410.61536307823, 6605.339466053452, 6621.437177839937, 6648.601083934979, 6736.124303840469, 3710.7031437485475, 3733.2346868891814, 3744.3260213161893, 3747.1381582235695, 3760.379537376357, 2889.8266104033823, 2996.715312045352, 2997.565353023799, 2997.8800847965836, 2999.115260998011, 507.53814029233956, 519.6803965561153, 523.3667262612206, 523.4294618865455, 543.6439132368305, 566.5722379603455, 587.7384563869037, 593.1340243244911, 594.6135012242078, 623.7536173211647, 7449.515781474187, 7619.4285428593075, 7636.732714354971, 7748.496347737379, 7843.6470358833985, 562.2774734466192, 569.2173261765073, 575.4360726488065, 578.2709698002941, 581.9185314056035, 3568.3041806847937, 3573.5890372606964, 3632.3461776880417, 3663.8900832975055, 3701.555813302367, 58679.0, 59832.401675982685, 61091.0, 63461.36538634555, 64140.679296603215, 57118.0, 57242.141367878685, 57456.0, 59077.0, 59912.40087599068, 51585.48414515882, 52153.47846521638, 52499.73750131225, 53372.0, 54367.72816135894, 7549.0, 7604.8479030420185, 7821.960890195513, 7863.528188308491, 8269.751907442786, 30235.395292094476, 31117.688823112385, 31696.841515792272, 31748.68251317457, 32165.517517236793, 40332.1933561333, 40934.0, 41382.0, 41896.162076758905, 42337.15325693407, 10316.381017138996, 10451.320664156805, 10519.684409467422, 10601.46992650349, 10842.241043126905, 11333.077792324822, 11413.60052398162, 12023.45894434735, 12158.878411215775, 12302.0, 10588.841167382341, 10884.94557527239, 10978.890211097787, 11140.108791296514, 11299.152563557602, 10252.538635761557, 10499.107575856138, 10565.0, 10755.892441075803, 11369.488373023069, 10251.58993640246, 10626.029654036292, 10845.349279043283, 10846.403447810446, 11025.83461248098, 9211.030542519073, 9950.601975920883, 9957.751056223653, 9959.950200248952, 10035.949820251144, 9294.72115836526, 9560.330776845554, 9566.712998610054, 9654.27592930519, 9707.223422126353], "value": 6053.360615027742, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 114.0, 112.0, 112.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 156.0, 177.0, 132.0, 171.0, 157.0, 139.0, 213.0, 139.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 175.0, 163.0, 162.0, 164.0, 164.0, 164.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 173.0, 76.0, 75.0, 76.0, 77.0, 161.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 84.0, 85.0, 84.0, 139.0, 85.0, 85.0, 142.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 150.0, 150.0, 150.0, 147.0, 148.0, 146.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 101.0, 100.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 62.0, 66.0, 63.0, 63.0, 62.0, 62.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 83.0, 85.0, 85.0, 85.0, 86.0, 85.0, 112.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 153.0, 128.0, 132.0, 136.0, 138.0, 136.0, 137.0, 131.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 169.0, 169.0, 172.0, 173.0, 168.0, 169.0, 174.0, 170.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 70.0, 68.0, 67.0, 70.0, 68.0, 67.0, 67.0, 67.0], "value": 69.1, "unit": "score"}]}]} 08:02:08 INFO - Return code: 0 08:02:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:02:08 ERROR - # TBPL SUCCESS # 08:02:08 INFO - Running post-action listener: _resource_record_post_action 08:02:08 INFO - ##### 08:02:08 INFO - ##### Finished run-tests step (success) 08:02:08 INFO - ##### 08:02:08 INFO - Running post-run listener: _resource_record_post_run 08:02:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523329536; Read time: 12; Write time: 456160 08:02:08 INFO - TinderboxPrint: CPU usage
13.4% 08:02:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:02:08 INFO - TinderboxPrint: I/O write bytes / time
523,329,536 / 456,160 08:02:08 INFO - TinderboxPrint: CPU idle
8,251.9 (86.5%) 08:02:08 INFO - TinderboxPrint: CPU user
1,229.0 (12.9%) 08:02:08 INFO - TinderboxPrint: Swap in / out
0 / 0 08:02:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 135827456; Read time: 0; Write time: 145776 08:02:08 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279900160; Read time: 12; Write time: 208624 08:02:09 INFO - Running post-run listener: _upload_blobber_files 08:02:09 INFO - Blob upload gear active. 08:02:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:09 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 08:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:02:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:13 INFO - (blobuploader) - INFO - Done attempting. 08:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:14 INFO - (blobuploader) - INFO - Done attempting. 08:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:15 INFO - (blobuploader) - INFO - Done attempting. 08:02:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:15 INFO - Return code: 0 08:02:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc2e8836d6fbf04442b34a2a11a4c3cd2c9e0a0ed2e0512ea87d00cbb2637f756ae3e36e3d1a7d288022c56d3d3257c4a22e660c19c0fa85cb6c107e31d80892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61df78c4087e9ad41290746f2786835921201eedbb4b9ffc206960f99ab7d19448b6d6dfef4a769a452460936fe6da7f49d0a321024878411c01c4e04d27895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abf9a52356b3b3b196b55a16f93817bbf90f217ae2680bfa83ed84c392048a3858ecce8f40b9eb1e8e2860bdb02f05b8a7e3a06a11fcd240e3b85058677b30da"} 08:02:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:15 INFO - Contents: 08:02:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc2e8836d6fbf04442b34a2a11a4c3cd2c9e0a0ed2e0512ea87d00cbb2637f756ae3e36e3d1a7d288022c56d3d3257c4a22e660c19c0fa85cb6c107e31d80892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61df78c4087e9ad41290746f2786835921201eedbb4b9ffc206960f99ab7d19448b6d6dfef4a769a452460936fe6da7f49d0a321024878411c01c4e04d27895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abf9a52356b3b3b196b55a16f93817bbf90f217ae2680bfa83ed84c392048a3858ecce8f40b9eb1e8e2860bdb02f05b8a7e3a06a11fcd240e3b85058677b30da"} 08:02:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:15 INFO - Copying logs to upload dir... 08:02:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.456004 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-30 08:02:15.321230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:02:15.324963) ========= 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=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 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-Non-PGO/sha512/cc2e8836d6fbf04442b34a2a11a4c3cd2c9e0a0ed2e0512ea87d00cbb2637f756ae3e36e3d1a7d288022c56d3d3257c4a22e660c19c0fa85cb6c107e31d80892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61df78c4087e9ad41290746f2786835921201eedbb4b9ffc206960f99ab7d19448b6d6dfef4a769a452460936fe6da7f49d0a321024878411c01c4e04d27895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abf9a52356b3b3b196b55a16f93817bbf90f217ae2680bfa83ed84c392048a3858ecce8f40b9eb1e8e2860bdb02f05b8a7e3a06a11fcd240e3b85058677b30da"} build_url:https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/cOqc5N79S0mnvxiikItrnw/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-Non-PGO/sha512/cc2e8836d6fbf04442b34a2a11a4c3cd2c9e0a0ed2e0512ea87d00cbb2637f756ae3e36e3d1a7d288022c56d3d3257c4a22e660c19c0fa85cb6c107e31d80892", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61df78c4087e9ad41290746f2786835921201eedbb4b9ffc206960f99ab7d19448b6d6dfef4a769a452460936fe6da7f49d0a321024878411c01c4e04d27895", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abf9a52356b3b3b196b55a16f93817bbf90f217ae2680bfa83ed84c392048a3858ecce8f40b9eb1e8e2860bdb02f05b8a7e3a06a11fcd240e3b85058677b30da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:02:15.351803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:02:15.352157) ========= 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=32c5991c409366f7fec8a718000001d2-1464618932.450269-570138836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:02:15.436775) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:02:15.437416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:02:15.437874) ========= ========= Total master_lag: 0.18 =========