builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1464775694.27 results: success (0) buildid: 20160601002322 builduid: 2626cdfc65fb4fc7bfa72d5f99172c38 revision: b6fe7fa88db0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.266877) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.267379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.267672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.282035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.282295) ========= 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=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 03:08:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-06-01 03:08:15 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.372716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.373038) ========= 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=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016566 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.421929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:14.422244) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b6fe7fa88db0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b6fe7fa88db0 --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=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 03:08:15,498 Setting DEBUG logging. 2016-06-01 03:08:15,498 attempt 1/10 2016-06-01 03:08:15,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b6fe7fa88db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 03:08:16,011 unpacking tar archive at: mozilla-inbound-b6fe7fa88db0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.848951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:15.284895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:15.285243) ========= script_repo_revision: b6fe7fa88db0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:15.285659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:15.285940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 03:08:15.296577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 03:08:15.296854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:16 INFO - MultiFileLogger online at 20160601 03:08:16 in /builds/slave/test 03:08:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:08:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:16 INFO - {'append_to_log': False, 03:08:16 INFO - 'base_work_dir': '/builds/slave/test', 03:08:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:08:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:16 INFO - 'branch': 'Mozilla-Inbound', 03:08:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:16 INFO - 'config_files': ('talos/linux_config.py',), 03:08:16 INFO - 'default_actions': ('clobber', 03:08:16 INFO - 'read-buildbot-config', 03:08:16 INFO - 'download-and-extract', 03:08:16 INFO - 'populate-webroot', 03:08:16 INFO - 'create-virtualenv', 03:08:16 INFO - 'install', 03:08:16 INFO - 'run-tests'), 03:08:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:16 INFO - 'download_minidump_stackwalk': True, 03:08:16 INFO - 'download_symbols': 'ondemand', 03:08:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:16 INFO - 'installer_path': 'installer.exe', 03:08:16 INFO - 'log_level': 'info', 03:08:16 INFO - 'log_name': 'talos', 03:08:16 INFO - 'log_to_console': True, 03:08:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:16 INFO - 'opt_config_files': (), 03:08:16 INFO - 'pip_index': False, 03:08:16 INFO - 'sps_profile': False, 03:08:16 INFO - 'sps_profile_interval': 0, 03:08:16 INFO - 'suite': 'dromaeojs-e10s', 03:08:16 INFO - 'system_bits': '32', 03:08:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:16 INFO - 'title': 'talos-linux64-ix-053', 03:08:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:16 INFO - 'use_talos_json': True, 03:08:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:16 INFO - 'work_dir': 'build'} 03:08:16 INFO - ##### 03:08:16 INFO - ##### Running clobber step. 03:08:16 INFO - ##### 03:08:16 INFO - Running pre-action listener: _resource_record_pre_action 03:08:16 INFO - Running main action method: clobber 03:08:16 INFO - rmtree: /builds/slave/test/build 03:08:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:17 INFO - Running post-action listener: _resource_record_post_action 03:08:17 INFO - ##### 03:08:17 INFO - ##### Finished clobber step (success) 03:08:17 INFO - ##### 03:08:17 INFO - ##### 03:08:17 INFO - ##### Running read-buildbot-config step. 03:08:17 INFO - ##### 03:08:17 INFO - Running pre-action listener: _resource_record_pre_action 03:08:17 INFO - Running main action method: read_buildbot_config 03:08:17 INFO - Using buildbot properties: 03:08:17 INFO - { 03:08:17 INFO - "project": "", 03:08:17 INFO - "product": "firefox", 03:08:17 INFO - "script_repo_revision": "production", 03:08:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:08:17 INFO - "repository": "", 03:08:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:08:17 INFO - "buildid": "20160601002322", 03:08:17 INFO - "pgo_build": "True", 03:08:17 INFO - "basedir": "/builds/slave/test", 03:08:17 INFO - "buildnumber": 773, 03:08:17 INFO - "slavename": "talos-linux64-ix-053", 03:08:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:08:17 INFO - "platform": "ubuntu64_hw", 03:08:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:08:17 INFO - "branch": "mozilla-inbound", 03:08:17 INFO - "repo_path": "integration/mozilla-inbound", 03:08:17 INFO - "revision": "b6fe7fa88db0", 03:08:17 INFO - "stage_platform": "linux64-pgo", 03:08:17 INFO - "builduid": "2626cdfc65fb4fc7bfa72d5f99172c38", 03:08:17 INFO - "slavebuilddir": "test" 03:08:17 INFO - } 03:08:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:08:17 INFO - Running post-action listener: _resource_record_post_action 03:08:17 INFO - ##### 03:08:17 INFO - ##### Finished read-buildbot-config step (success) 03:08:17 INFO - ##### 03:08:17 INFO - ##### 03:08:17 INFO - ##### Running download-and-extract step. 03:08:17 INFO - ##### 03:08:17 INFO - Running pre-action listener: _resource_record_pre_action 03:08:17 INFO - Running main action method: download_and_extract 03:08:17 INFO - mkdir: /builds/slave/test/build/tests 03:08:17 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')]} 03:08:17 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:18 INFO - Downloaded 1361 bytes. 03:08:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:18 INFO - Using the following test package requirements: 03:08:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:08:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:08:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'jsshell-linux-x86_64.zip'], 03:08:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:08:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:08:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:08:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:18 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')]} 03:08:18 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:19 INFO - Downloaded 24422470 bytes. 03:08:19 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'] 03:08:19 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 03:08:20 INFO - Return code: 0 03:08:20 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 03:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:20 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:21 INFO - Downloaded 24422470 bytes. 03:08:21 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'] 03:08:21 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 03:08:23 INFO - Return code: 0 03:08:23 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')]} 03:08:23 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:24 INFO - Downloaded 10834055 bytes. 03:08:24 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'] 03:08:24 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 03:08:24 INFO - Return code: 0 03:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:24 INFO - https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULxNMRFPRwCBNigiFjpwrg/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 03:08:25 INFO - Downloaded 59015252 bytes. 03:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:08:25 INFO - mkdir: /builds/slave/test/properties 03:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:08:25 INFO - Contents: 03:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:08:26 INFO - Running post-action listener: _resource_record_post_action 03:08:26 INFO - Running post-action listener: set_extra_try_arguments 03:08:26 INFO - ##### 03:08:26 INFO - ##### Finished download-and-extract step (success) 03:08:26 INFO - ##### 03:08:26 INFO - ##### 03:08:26 INFO - ##### Running populate-webroot step. 03:08:26 INFO - ##### 03:08:26 INFO - Running pre-action listener: _resource_record_pre_action 03:08:26 INFO - Running main action method: populate_webroot 03:08:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:26 INFO - '--tppagecycles', 03:08:26 INFO - '7'], 03:08:26 INFO - 'tests': ['tsvgm']}}, 03:08:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:08:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:08:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:08:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['damp', 'tps']}, 03:08:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'tests': ['damp', 'tps']}, 03:08:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['dromaeo_dom']}, 03:08:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['a11yr', 03:08:26 INFO - 'ts_paint', 03:08:26 INFO - 'tpaint', 03:08:26 INFO - 'sessionrestore', 03:08:26 INFO - 'sessionrestore_no_auto_restore', 03:08:26 INFO - 'tabpaint']}, 03:08:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['tsvgx', 03:08:26 INFO - 'tsvgr_opacity', 03:08:26 INFO - 'tart', 03:08:26 INFO - 'tscrollx', 03:08:26 INFO - 'cart']}, 03:08:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:08:26 INFO - 'tsvgr_opacity', 03:08:26 INFO - 'tart', 03:08:26 INFO - 'tscrollx', 03:08:26 INFO - 'cart']}, 03:08:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'talos_options': ['--disable-e10s'], 03:08:26 INFO - 'tests': ['tp5o']}, 03:08:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'tests': ['tp5o']}, 03:08:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'talos_options': ['--disable-e10s', 03:08:26 INFO - '--xperf_path', 03:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:26 INFO - 'tests': ['tp5n']}, 03:08:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:26 INFO - 'talos_options': ['--xperf_path', 03:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:26 INFO - 'tests': ['tp5n']}}, 03:08:26 INFO - 'talos.zip': {'path': '', 03:08:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:26 INFO - Running post-action listener: _resource_record_post_action 03:08:26 INFO - ##### 03:08:26 INFO - ##### Finished populate-webroot step (success) 03:08:26 INFO - ##### 03:08:26 INFO - ##### 03:08:26 INFO - ##### Running create-virtualenv step. 03:08:26 INFO - ##### 03:08:26 INFO - Running pre-action listener: _resource_record_pre_action 03:08:26 INFO - Running main action method: create_virtualenv 03:08:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:08:26 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 03:08:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:26 INFO - Using real prefix '/usr' 03:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:08:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:29 INFO - Installing pip.................done. 03:08:29 INFO - Return code: 0 03:08:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08:29 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')]} 03:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:29 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')]} 03:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:29 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:29 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 03:08:29 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 03:08:29 INFO - Using env: {'DISPLAY': ':0', 03:08:29 INFO - 'HOME': '/home/cltbld', 03:08:29 INFO - 'LANG': 'en_US.UTF-8', 03:08:29 INFO - 'LANGUAGE': 'en_US:en', 03:08:29 INFO - 'LOGNAME': 'cltbld', 03:08:29 INFO - 'MAIL': '/var/mail/cltbld', 03:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:29 INFO - 'MOZ_NO_REMOTE': '1', 03:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:29 INFO - 'NO_EM_RESTART': '1', 03:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:29 INFO - 'PWD': '/builds/slave/test', 03:08:29 INFO - 'SHELL': '/bin/bash', 03:08:29 INFO - 'SHLVL': '1', 03:08:29 INFO - 'TERM': 'linux', 03:08:29 INFO - 'TMOUT': '86400', 03:08:29 INFO - 'USER': 'cltbld', 03:08:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:29 INFO - '_': '/tools/buildbot/bin/python'} 03:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:29 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 03:08:29 INFO - Cleaning up... 03:08:29 INFO - Return code: 0 03:08:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:08:29 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')]} 03:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:29 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')]} 03:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:29 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:29 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 03:08:29 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 03:08:29 INFO - Using env: {'DISPLAY': ':0', 03:08:29 INFO - 'HOME': '/home/cltbld', 03:08:29 INFO - 'LANG': 'en_US.UTF-8', 03:08:29 INFO - 'LANGUAGE': 'en_US:en', 03:08:29 INFO - 'LOGNAME': 'cltbld', 03:08:29 INFO - 'MAIL': '/var/mail/cltbld', 03:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:29 INFO - 'MOZ_NO_REMOTE': '1', 03:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:29 INFO - 'NO_EM_RESTART': '1', 03:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:29 INFO - 'PWD': '/builds/slave/test', 03:08:29 INFO - 'SHELL': '/bin/bash', 03:08:29 INFO - 'SHLVL': '1', 03:08:29 INFO - 'TERM': 'linux', 03:08:29 INFO - 'TMOUT': '86400', 03:08:29 INFO - 'USER': 'cltbld', 03:08:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:29 INFO - '_': '/tools/buildbot/bin/python'} 03:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:29 INFO - Downloading/unpacking psutil>=3.1.1 03:08:29 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 03:08:29 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 03:08:29 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 03:08:29 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 03:08:29 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 03:08:29 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 03:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:31 INFO - Installing collected packages: psutil 03:08:31 INFO - Running setup.py install for psutil 03:08:31 INFO - building 'psutil._psutil_linux' extension 03:08:31 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 03:08:31 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 03:08:31 INFO - building 'psutil._psutil_posix' extension 03:08:31 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 03:08:32 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 03:08:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:32 INFO - Successfully installed psutil 03:08:32 INFO - Cleaning up... 03:08:32 INFO - Return code: 0 03:08:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:08:32 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')]} 03:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:32 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')]} 03:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:32 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:32 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 03:08:32 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 03:08:32 INFO - Using env: {'DISPLAY': ':0', 03:08:32 INFO - 'HOME': '/home/cltbld', 03:08:32 INFO - 'LANG': 'en_US.UTF-8', 03:08:32 INFO - 'LANGUAGE': 'en_US:en', 03:08:32 INFO - 'LOGNAME': 'cltbld', 03:08:32 INFO - 'MAIL': '/var/mail/cltbld', 03:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:32 INFO - 'MOZ_NO_REMOTE': '1', 03:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:32 INFO - 'NO_EM_RESTART': '1', 03:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:32 INFO - 'PWD': '/builds/slave/test', 03:08:32 INFO - 'SHELL': '/bin/bash', 03:08:32 INFO - 'SHLVL': '1', 03:08:32 INFO - 'TERM': 'linux', 03:08:32 INFO - 'TMOUT': '86400', 03:08:32 INFO - 'USER': 'cltbld', 03:08:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:32 INFO - '_': '/tools/buildbot/bin/python'} 03:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:08:32 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 03:08:32 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 03:08:32 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 03:08:32 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 03:08:32 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 03:08:32 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 03:08:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:08:34 INFO - Installing collected packages: mozsystemmonitor 03:08:34 INFO - Running setup.py install for mozsystemmonitor 03:08:34 INFO - Successfully installed mozsystemmonitor 03:08:34 INFO - Cleaning up... 03:08:34 INFO - Return code: 0 03:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:08:34 INFO - Using env: {'DISPLAY': ':0', 03:08:34 INFO - 'HOME': '/home/cltbld', 03:08:34 INFO - 'LANG': 'en_US.UTF-8', 03:08:34 INFO - 'LANGUAGE': 'en_US:en', 03:08:34 INFO - 'LOGNAME': 'cltbld', 03:08:34 INFO - 'MAIL': '/var/mail/cltbld', 03:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:34 INFO - 'MOZ_NO_REMOTE': '1', 03:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:34 INFO - 'NO_EM_RESTART': '1', 03:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:34 INFO - 'PWD': '/builds/slave/test', 03:08:34 INFO - 'SHELL': '/bin/bash', 03:08:34 INFO - 'SHLVL': '1', 03:08:34 INFO - 'TERM': 'linux', 03:08:34 INFO - 'TMOUT': '86400', 03:08:34 INFO - 'USER': 'cltbld', 03:08:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:34 INFO - '_': '/tools/buildbot/bin/python'} 03:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:08:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:37 INFO - Downloading docopt-0.6.1.tar.gz 03:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:37 INFO - Running setup.py install for blobuploader 03:08:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:08:37 INFO - Running setup.py install for requests 03:08:37 INFO - Running setup.py install for docopt 03:08:37 INFO - Successfully installed blobuploader requests docopt 03:08:37 INFO - Cleaning up... 03:08:37 INFO - Return code: 0 03:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:37 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 03:08:37 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 03:08:37 INFO - Using env: {'DISPLAY': ':0', 03:08:37 INFO - 'HOME': '/home/cltbld', 03:08:37 INFO - 'LANG': 'en_US.UTF-8', 03:08:37 INFO - 'LANGUAGE': 'en_US:en', 03:08:37 INFO - 'LOGNAME': 'cltbld', 03:08:37 INFO - 'MAIL': '/var/mail/cltbld', 03:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:37 INFO - 'MOZ_NO_REMOTE': '1', 03:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:37 INFO - 'NO_EM_RESTART': '1', 03:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:37 INFO - 'PWD': '/builds/slave/test', 03:08:37 INFO - 'SHELL': '/bin/bash', 03:08:37 INFO - 'SHLVL': '1', 03:08:37 INFO - 'TERM': 'linux', 03:08:37 INFO - 'TMOUT': '86400', 03:08:37 INFO - 'USER': 'cltbld', 03:08:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:37 INFO - '_': '/tools/buildbot/bin/python'} 03:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:38 INFO - Running setup.py (path:/tmp/pip-wlI8tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:38 INFO - Running setup.py (path:/tmp/pip-IxYq4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:38 INFO - Running setup.py (path:/tmp/pip-QMITtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:38 INFO - Running setup.py (path:/tmp/pip-MKN2iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:38 INFO - Running setup.py (path:/tmp/pip-sHfU_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:38 INFO - Running setup.py (path:/tmp/pip-MfnFRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:38 INFO - Running setup.py (path:/tmp/pip-NRFLm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:38 INFO - Running setup.py (path:/tmp/pip-9I6ujc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:38 INFO - Running setup.py (path:/tmp/pip-gh0KKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:38 INFO - Running setup.py (path:/tmp/pip-FV4Iow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:38 INFO - Running setup.py (path:/tmp/pip-0YmPvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:38 INFO - Running setup.py (path:/tmp/pip-IDqRJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:39 INFO - Running setup.py (path:/tmp/pip-0kvzCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:39 INFO - Running setup.py (path:/tmp/pip-D2RETh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:39 INFO - Running setup.py (path:/tmp/pip-uoHk2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:39 INFO - Running setup.py (path:/tmp/pip-TWnGEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:39 INFO - Running setup.py (path:/tmp/pip-ar42NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:39 INFO - Running setup.py install for manifestparser 03:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozcrash 03:08:39 INFO - Running setup.py install for mozdebug 03:08:39 INFO - Running setup.py install for mozdevice 03:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozfile 03:08:39 INFO - Running setup.py install for mozhttpd 03:08:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozinfo 03:08:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozInstall 03:08:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozleak 03:08:40 INFO - Running setup.py install for mozlog 03:08:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for moznetwork 03:08:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozprocess 03:08:40 INFO - Running setup.py install for mozprofile 03:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozrunner 03:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozscreenshot 03:08:40 INFO - Running setup.py install for moztest 03:08:41 INFO - Running setup.py install for mozversion 03:08:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:08:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:41 INFO - Cleaning up... 03:08:41 INFO - Return code: 0 03:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:41 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:41 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 03:08:41 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 03:08:41 INFO - Using env: {'DISPLAY': ':0', 03:08:41 INFO - 'HOME': '/home/cltbld', 03:08:41 INFO - 'LANG': 'en_US.UTF-8', 03:08:41 INFO - 'LANGUAGE': 'en_US:en', 03:08:41 INFO - 'LOGNAME': 'cltbld', 03:08:41 INFO - 'MAIL': '/var/mail/cltbld', 03:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:41 INFO - 'MOZ_NO_REMOTE': '1', 03:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:41 INFO - 'NO_EM_RESTART': '1', 03:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:41 INFO - 'PWD': '/builds/slave/test', 03:08:41 INFO - 'SHELL': '/bin/bash', 03:08:41 INFO - 'SHLVL': '1', 03:08:41 INFO - 'TERM': 'linux', 03:08:41 INFO - 'TMOUT': '86400', 03:08:41 INFO - 'USER': 'cltbld', 03:08:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:41 INFO - '_': '/tools/buildbot/bin/python'} 03:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:41 INFO - Running setup.py (path:/tmp/pip-GwgTSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:41 INFO - Running setup.py (path:/tmp/pip-RP6a_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:41 INFO - Running setup.py (path:/tmp/pip-9LK3pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:41 INFO - Running setup.py (path:/tmp/pip-KsRUQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:41 INFO - Running setup.py (path:/tmp/pip-mcvT5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:41 INFO - Running setup.py (path:/tmp/pip-kYqWjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:41 INFO - Running setup.py (path:/tmp/pip-9voCDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:41 INFO - Running setup.py (path:/tmp/pip-ZSQN3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:41 INFO - Running setup.py (path:/tmp/pip-Eexzjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:42 INFO - Running setup.py (path:/tmp/pip-Lmvmkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:42 INFO - Running setup.py (path:/tmp/pip-3j3fUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:42 INFO - Running setup.py (path:/tmp/pip-RoIDrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:42 INFO - Running setup.py (path:/tmp/pip-N9aci7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:42 INFO - Running setup.py (path:/tmp/pip-HcMLJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:42 INFO - Running setup.py (path:/tmp/pip-qiV7Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:42 INFO - Running setup.py (path:/tmp/pip-0z0GBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:42 INFO - Running setup.py (path:/tmp/pip-2XAU5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:44 INFO - Downloading blessings-1.6.tar.gz 03:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:44 INFO - Installing collected packages: blessings 03:08:44 INFO - Running setup.py install for blessings 03:08:44 INFO - Successfully installed blessings 03:08:44 INFO - Cleaning up... 03:08:44 INFO - Return code: 0 03:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:44 INFO - Reading from file tmpfile_stdout 03:08:44 INFO - Current package versions: 03:08:44 INFO - argparse == 1.2.1 03:08:44 INFO - blessings == 1.6 03:08:44 INFO - blobuploader == 1.2.4 03:08:44 INFO - docopt == 0.6.1 03:08:44 INFO - manifestparser == 1.1 03:08:44 INFO - mozInstall == 1.12 03:08:44 INFO - mozcrash == 0.17 03:08:44 INFO - mozdebug == 0.1 03:08:44 INFO - mozdevice == 0.48 03:08:44 INFO - mozfile == 1.2 03:08:44 INFO - mozhttpd == 0.7 03:08:44 INFO - mozinfo == 0.9 03:08:44 INFO - mozleak == 0.1 03:08:44 INFO - mozlog == 3.2 03:08:44 INFO - moznetwork == 0.27 03:08:44 INFO - mozprocess == 0.22 03:08:44 INFO - mozprofile == 0.28 03:08:44 INFO - mozrunner == 6.11 03:08:44 INFO - mozscreenshot == 0.1 03:08:44 INFO - mozsystemmonitor == 0.3 03:08:44 INFO - moztest == 0.7 03:08:44 INFO - mozversion == 1.4 03:08:44 INFO - psutil == 3.1.1 03:08:44 INFO - requests == 1.2.3 03:08:44 INFO - wsgiref == 0.1.2 03:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:44 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')]} 03:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:44 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')]} 03:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:44 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:44 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 03:08:44 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 03:08:44 INFO - Using env: {'DISPLAY': ':0', 03:08:44 INFO - 'HOME': '/home/cltbld', 03:08:44 INFO - 'LANG': 'en_US.UTF-8', 03:08:44 INFO - 'LANGUAGE': 'en_US:en', 03:08:44 INFO - 'LOGNAME': 'cltbld', 03:08:44 INFO - 'MAIL': '/var/mail/cltbld', 03:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:44 INFO - 'MOZ_NO_REMOTE': '1', 03:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:44 INFO - 'NO_EM_RESTART': '1', 03:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:44 INFO - 'PWD': '/builds/slave/test', 03:08:44 INFO - 'SHELL': '/bin/bash', 03:08:44 INFO - 'SHLVL': '1', 03:08:44 INFO - 'TERM': 'linux', 03:08:44 INFO - 'TMOUT': '86400', 03:08:44 INFO - 'USER': 'cltbld', 03:08:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:44 INFO - '_': '/tools/buildbot/bin/python'} 03:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 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)) 03:08:45 INFO - Cleaning up... 03:08:45 INFO - Return code: 0 03:08:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:45 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')]} 03:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:45 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')]} 03:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:45 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 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:45 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 03:08:45 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 03:08:45 INFO - Using env: {'DISPLAY': ':0', 03:08:45 INFO - 'HOME': '/home/cltbld', 03:08:45 INFO - 'LANG': 'en_US.UTF-8', 03:08:45 INFO - 'LANGUAGE': 'en_US:en', 03:08:45 INFO - 'LOGNAME': 'cltbld', 03:08:45 INFO - 'MAIL': '/var/mail/cltbld', 03:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:45 INFO - 'MOZ_NO_REMOTE': '1', 03:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:45 INFO - 'NO_EM_RESTART': '1', 03:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:45 INFO - 'PWD': '/builds/slave/test', 03:08:45 INFO - 'SHELL': '/bin/bash', 03:08:45 INFO - 'SHLVL': '1', 03:08:45 INFO - 'TERM': 'linux', 03:08:45 INFO - 'TMOUT': '86400', 03:08:45 INFO - 'USER': 'cltbld', 03:08:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:45 INFO - '_': '/tools/buildbot/bin/python'} 03:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:45 INFO - Downloading/unpacking jsonschema 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:08:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:08:47 INFO - warning: no files found matching '*.txt' 03:08:47 INFO - no previously-included directories found matching 'build' 03:08:47 INFO - no previously-included directories found matching 'dist' 03:08:47 INFO - no previously-included directories found matching '.git*' 03:08:47 INFO - Installing collected packages: jsonschema, functools32 03:08:47 INFO - Running setup.py install for functools32 03:08:47 INFO - warning: no files found matching '*.txt' 03:08:47 INFO - no previously-included directories found matching 'build' 03:08:47 INFO - no previously-included directories found matching 'dist' 03:08:47 INFO - no previously-included directories found matching '.git*' 03:08:47 INFO - Successfully installed jsonschema functools32 03:08:47 INFO - Cleaning up... 03:08:47 INFO - Return code: 0 03:08:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabfe8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, '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': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', '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 03:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:08:47 INFO - Using env: {'DISPLAY': ':0', 03:08:47 INFO - 'HOME': '/home/cltbld', 03:08:47 INFO - 'LANG': 'en_US.UTF-8', 03:08:47 INFO - 'LANGUAGE': 'en_US:en', 03:08:47 INFO - 'LOGNAME': 'cltbld', 03:08:47 INFO - 'MAIL': '/var/mail/cltbld', 03:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:47 INFO - 'MOZ_NO_REMOTE': '1', 03:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:47 INFO - 'NO_EM_RESTART': '1', 03:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:47 INFO - 'PWD': '/builds/slave/test', 03:08:47 INFO - 'SHELL': '/bin/bash', 03:08:47 INFO - 'SHLVL': '1', 03:08:47 INFO - 'TERM': 'linux', 03:08:47 INFO - 'TMOUT': '86400', 03:08:47 INFO - 'USER': 'cltbld', 03:08:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:47 INFO - '_': '/tools/buildbot/bin/python'} 03:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:48 INFO - Downloading/unpacking flake8 03:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:08:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:08:49 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 03:08:49 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 03:08:49 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 03:08:49 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 03:08:49 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 03:08:49 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 03:08:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:08:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:50 INFO - no previously-included directories found matching 'docs/_build' 03:08:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:08:50 INFO - Running setup.py install for pep8 03:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:50 INFO - no previously-included directories found matching 'docs/_build' 03:08:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:08:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:08:50 INFO - Cleaning up... 03:08:50 INFO - Return code: 0 03:08:50 INFO - Running post-action listener: _resource_record_post_action 03:08:50 INFO - Running post-action listener: _start_resource_monitoring 03:08:50 INFO - Starting resource monitoring. 03:08:50 INFO - ##### 03:08:50 INFO - ##### Finished create-virtualenv step (success) 03:08:50 INFO - ##### 03:08:50 INFO - ##### 03:08:50 INFO - ##### Running install step. 03:08:50 INFO - ##### 03:08:50 INFO - Running pre-action listener: _resource_record_pre_action 03:08:50 INFO - Running main action method: install 03:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:51 INFO - Reading from file tmpfile_stdout 03:08:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:51 INFO - Reading from file tmpfile_stdout 03:08:51 INFO - Output received: 03:08:51 INFO - Usage: mozinstall [options] installer 03:08:51 INFO - Options: 03:08:51 INFO - -h, --help show this help message and exit 03:08:51 INFO - -d DEST, --destination=DEST 03:08:51 INFO - Directory to install application into. [default: 03:08:51 INFO - "/builds/slave/test"] 03:08:51 INFO - --app=APP Application being installed. [default: firefox] 03:08:51 INFO - mkdir: /builds/slave/test/build/application 03:08:51 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'] 03:08:51 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 03:09:08 INFO - Reading from file tmpfile_stdout 03:09:08 INFO - Output received: 03:09:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:09:08 INFO - Running post-action listener: _resource_record_post_action 03:09:08 INFO - ##### 03:09:08 INFO - ##### Finished install step (success) 03:09:08 INFO - ##### 03:09:08 INFO - ##### 03:09:08 INFO - ##### Running run-tests step. 03:09:08 INFO - ##### 03:09:08 INFO - Running pre-action listener: _resource_record_pre_action 03:09:08 INFO - Running main action method: run_tests 03:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:08 INFO - Python 2.7.3 03:09:08 INFO - Return code: 0 03:09:08 INFO - grabbing minidump binary from tooltool 03:09:08 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')]} 03:09:08 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 0x18aa9c0>, '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 0x18ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18abd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:08 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 03:09:08 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 03:09:08 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 03:09:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:08 INFO - Return code: 0 03:09:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:09:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:09:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:09:09 INFO - Return code: 0 03:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 03:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 03:09:09 INFO - Using env: {'DISPLAY': ':0', 03:09:09 INFO - 'HOME': '/home/cltbld', 03:09:09 INFO - 'LANG': 'en_US.UTF-8', 03:09:09 INFO - 'LANGUAGE': 'en_US:en', 03:09:09 INFO - 'LOGNAME': 'cltbld', 03:09:09 INFO - 'MAIL': '/var/mail/cltbld', 03:09:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:09 INFO - 'MOZ_NO_REMOTE': '1', 03:09:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:09 INFO - 'NO_EM_RESTART': '1', 03:09:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:09 INFO - 'PWD': '/builds/slave/test', 03:09:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:09 INFO - 'SHELL': '/bin/bash', 03:09:09 INFO - 'SHLVL': '1', 03:09:09 INFO - 'TERM': 'linux', 03:09:09 INFO - 'TMOUT': '86400', 03:09:09 INFO - 'USER': 'cltbld', 03:09:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709', 03:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:09 INFO - '_': '/tools/buildbot/bin/python'} 03:09:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 03:09:09 INFO - mozversion application_buildid: 20160601002322 03:09:09 INFO - mozversion application_changeset: b6fe7fa88db0a4103d175bf5b02cd47c2c6722e6 03:09:09 INFO - mozversion application_display_name: Nightly 03:09:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:09 INFO - mozversion application_name: Firefox 03:09:09 INFO - mozversion application_remotingname: firefox 03:09:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:09:09 INFO - mozversion application_vendor: Mozilla 03:09:09 INFO - mozversion application_version: 49.0a1 03:09:09 INFO - mozversion platform_buildid: 20160601002322 03:09:09 INFO - mozversion platform_changeset: b6fe7fa88db0a4103d175bf5b02cd47c2c6722e6 03:09:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:09:09 INFO - mozversion platform_version: 49.0a1 03:09:09 INFO - using testdate: 1464775749 03:09:09 INFO - actual date: 1464775749 03:09:09 INFO - starting webserver on 'localhost:51876' 03:09:09 INFO - SUITE-START | Running 2 tests 03:09:09 INFO - TEST-START | dromaeo_css 03:09:09 INFO - operating with platform_type : linux_ 03:09:09 INFO - Initialising browser for dromaeo_css test... 03:09:09 INFO - TEST-INFO | started process 11516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKZ7vl/profile http://localhost:51876/getInfo.html) 03:09:14 INFO - PROCESS | 11516 | __metrics Screen width/height:1600/1200 03:09:14 INFO - PROCESS | 11516 | colorDepth:24 03:09:14 INFO - PROCESS | 11516 | Browser inner width/height: 1024/697 03:09:14 INFO - PROCESS | 11516 | __metrics 03:09:14 ERROR - PROCESS | 11516 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:09:15 INFO - TEST-INFO | 11516: exit 0 03:09:15 INFO - Browser initialized. 03:09:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:09:15 INFO - TEST-INFO | started process 11636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKZ7vl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:27 INFO - PROCESS | 11636 | RSS: Main: 166473728 03:09:27 INFO - PROCESS | 11636 | 03:10:17 INFO - PROCESS | 11636 | 1464775817235 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] 03:12:25 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51876/tests/dromaeo/cssquery-ext.html) 03:12:26 INFO - PROCESS | 11636 | RSS: Main: 171073536 03:12:26 INFO - PROCESS | 11636 | 03:15:28 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-ext.html (next: http://localhost:51876/tests/dromaeo/cssquery-jquery.html) 03:15:28 INFO - PROCESS | 11636 | RSS: Main: 169623552 03:15:28 INFO - PROCESS | 11636 | 03:18:30 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51876/tests/dromaeo/cssquery-mootools.html) 03:18:31 INFO - PROCESS | 11636 | RSS: Main: 171175936 03:18:31 INFO - PROCESS | 11636 | 03:21:33 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51876/tests/dromaeo/cssquery-prototype.html) 03:21:33 INFO - PROCESS | 11636 | RSS: Main: 168853504 03:21:33 INFO - PROCESS | 11636 | 03:24:36 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51876/tests/dromaeo/cssquery-yui.html) 03:24:36 INFO - PROCESS | 11636 | RSS: Main: 170950656 03:24:36 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | Cycle 1(1): loaded http://localhost:51876/tests/dromaeo/cssquery-yui.html (next: http://localhost:51876/tests/dromaeo/cssquery-dojo.html) 03:27:39 INFO - PROCESS | 11636 | RSS: Main: 171753472 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | __start_tp_report 03:27:39 INFO - PROCESS | 11636 | _x_x_mozilla_page_load 03:27:39 INFO - PROCESS | 11636 | _x_x_mozilla_page_load_details 03:27:39 INFO - PROCESS | 11636 | |i|pagename|runs| 03:27:39 INFO - PROCESS | 11636 | |0;dojo.html;3139.293658926741;3182.4430724623185;3197.8401079946;3211.3095684427844;3212.2772376215353;5546.334439867222;5563.8887222255535;5594.328680558334;5603.719814009303;5656.519195868346;5437.728113594324;5505.146702261156;5513.724313784315;5586.469285417878;5624.746886390112;4866.659333846632;4906.215005599105;5010.223415370623;5046.268291097788;5093.490650934914;1007.8284625450543;4946.060248552782;4967.379077615298;5058.7976480940715;5095.6178286628465;5003.699778013331;5020.021095886304;5028.296038554568;5047.066292735855;5053.191489361703;5069.594432445396;5077.441481437039;5079.263506791494;5080.644354895159;5083.389993200803;4864.391951006124;4966.751662416865;4967;4981.750912454399;5025.6733312334945;5410.91883621746;5436.456354364572;5445.210444485567;5454.91817622736;5479.643823151482;5933.050711886078;5949.405059494059;5984.521238300926;5990.430909063675;6029.21620189377;5933.22868027158;5957.791477298274;5964.582479226456;6035;6057.091436284549;5600.635958662674;5612.831615051555;5614.606977511576;5614.859628509279;5615.438456154393;6007.189029480965;6067.423594758491;6156.6921653917125;6166.229221347332;6168.506519478431;5818.44724751148;5848.005839007379;5856.8535786604825;5912.645241285537;5922.052471604523;5977.910331345033;5985.191999080155;5986.191864098291;5987.700614969234;5992.730327135289;5823.2429784128635;5926.1999630049395;5966.731497082642;5977.252843394575;5979.910301345483;5822.82531524055;5836.4747172753805;5848.707564621752;5909.468147866713;5935.52515798735;4407.603315701603;4452.354408610733;4462.241418958784;4490.3040028795585;4524.140413321458;3925.0579860833764;3979.303621866162;3984.820683069269;4006.59934006597;4033.032072302626;5695.629784064023;5711.371749107595;5746.885062298814;5774.364819869811;5808.535317174616;6057.061155520902;6078.574499784972;6085.543584231112;6090.512758979271;6092.360302168208;5613.298337707786;5653.180288858092;5659.405762394971;5751.827445176651;5759.539236861041;5154.793808247703;5157.948420515821;5165.070287348313;5167.896642067213;5192.506711862443;6212.968935155295;6217.813465596039;6223.751049958041;6224.315325314303;6227.1282020516255;5883;5899.380565040609;5934.821955341346;5950.464458198783;6022.397760223943;6143.631382117087;6147.754089836357;6156.26124865019;6167.198264225622;6171.290301615371;5811.79658711943;5826.213461182856;5868.471837534642;5872.354041055395;5875.6474611523445;5875.853103672443;5994.850128746816;6020.247469066367;6100.938990610037;6121.724522396592;5896.469317761422;5902.468777810018;5904.498117660047;5913.70431478433;5929.466348028698;5727.369989301257;5916.733746981482;5924.7037648118285;5931;5947.851303717442;5646.096624540218;5663.292088488939;5666.688332141772;5691.772329106955;5695.487406133468;5779.508741756998;5830.300363956352;5855.063189889597;5872.471477567039;5885.852853678693;5671.120976248688;5794.536437084938;5805.10020946754;5806.1000544915605;5809.796657116981 03:27:39 INFO - PROCESS | 11636 | |1;ext.html;585.2041223935447;624.6814124796354;631.5736877607619;644.0821828893825;662.0367365483222;42951.570484295145;43755.34366984498;43791.78104109479;43970.34044489327;47345.526544734545;43564.78217608907;44112.77943610286;44569.33146002812;44572.554274457325;44610.77694611531;8729.607167677454;8927.107289271085;8928.866067009;8931.240844528224;8970.282377409792;8776.429532080427;8870.42342247752;8876.911230887705;8897.110288971084;8901.243394311492;8827.646894124227;8986.775330616754;9014.774630634221;9025.277977761763;9034.32242581809;8883.555822208897;8886.4668119913;8890.022097569263;8919.42023768453;8948.284137269035;8788.165124313244;8879.911200888038;8902.42134261271;8931.553422328923;8943.5975381108;41174.38238426426;41547.169056619;41596.79201604003;41744.582554174376;41748.58251417477;3514.525539052246;3572.464130380438;3593.1376469647357;3616.5840928293055;3690.741648084635;32095.83952080248;32206.35587288241;32246.355072898645;32831.83584082088;33446.498302525484;4069.674426045909;4134.91730165398;4137.689673274486;4163.83344666213;4212.705110642256;336412;337718;337721;338498;341136.2943185293;56786.432135678115;56910.7154464225;56920;56944.430555694744;57062.00565960343;35549.28901421957;35848.82075589606;35990.64009359925;38233;38601.42097868534;16871.83128168727;17063.744043839353;17067.06131162773;17125.828741712674;17138.485845424657;12627;12831;12840.55058072963;12854.100212985188;12857.807132893015;19331.51671208231;19576.8042319575;19610.509737256398;19645.705314420295;19778.20887164526;7347.044884165024;7348.52234604749;7386.261373862678;7531.962340188264;7545.320921117016;974.7173319737196;1051.6266725312557;1115.7154925493946;1183.7810005149074;1184.9585264515702;30939.226519336746;30959.226019349695;30968.380632387227;31520.211994700316;31524;1172.302480024384;1211.4669545399995;1212.781699294118;1215.9452824622913;1219.432963671897;15919;16437.917810410872;16520.173991300628;16612.50162495127;16717.080560569284;433385;437828;438208;438712;440506;55038.17442738362;56261.718691406284;56292.43707562954;56416.43583564194;56537;1339.9397027133803;1359.157322460081;1380.9378577964017;1391.067984450441;1396.5112210726165;29283.975060872766;30180.396392071598;30363.544546832258;30806.537901931937;30835;48509.27236091532;48654.513454864995;48665.75667121642;48718.51281487282;49083;359084;364763;366665;367264;368213;26719.19448457884;27197.86401067982;27232.727672723813;27249.86375068112;27281.31796705098;44796;45345.54654453413;45566.77216613896;46304.53695463002;46808;39197.804010979766;39586.604133958295;39941;39993;40037.99905002398;39102.217955641296;39488.60511394849;39516;40019.3997090038;40074.79962600285;38294.2341153181;39274.214515708954;42643.5735642652;43263;43267.78366108149;34978.65021349754;36063;36881.81559092188;37606.43590346092;37917;27937.860310698317;28671.42657146887;28802.567961481014;28854.567181491875;28942.421151577273 03:27:39 INFO - PROCESS | 11636 | |2;jquery.html;391.1804769008927;394.2450207851963;398.9408121437583;399.97600143991343;409.4922296352522;18015.18931648076;18793.62412751744;19510.512237194078;19547.120379582935;19632.803671963276;16899.493015209533;17222.13889305533;17239.39662111823;17453.650926981452;17495.125243737824;5179.067767801795;5443.510084092431;5610.747516361764;5794.449527294901;5794.536437085023;5377.247185394048;5420.891582168354;5430.782768689248;5500.642458240201;5508.20131080995;5378.865528361783;5619.4099619539975;5667.178259152421;5702.1446782982675;5705.57360659835;5520.227168196456;5616.129499927518;5846.766129354842;5847.619904706181;5852.502537284336;5620;5654.9717251413895;5657.434256574351;5716.314042314907;5724.799632012901;12697.365131743469;13563.457461701619;13695.383707733175;13707.040507164502;13754.518591849237;2047.9180832766672;2191.594555007313;2222.6205413156613;2312.213847291912;2340.461693810433;10103.545340459623;10290.176785857113;11977.700557486045;12031.338276394883;15002.549923502313;1911.9330823421253;1913.6268427656612;1913.9234430622757;1944.0377013378468;1985.662437385648;69267.30732692659;82422;85743.5712821432;85765.14234857634;85837;10858.511366988505;11090.778184436265;11183.888161118284;11290.040346570633;11486.851314868614;15745.763813542806;15753.921230393775;15760.527184184493;15782.526524204291;15850.52448426549;8092.3930705197345;8341.708040218564;8432.325413966868;8588.699395521127;8660.653573856975;8114.594270286462;8157.265846073882;8293.419460637697;8334.749957501284;8342.37432192588;4576.679632425765;4648.535146485325;4665.720056796603;4831.710097394168;4865.56209941107;1947.6396866579728;1961.1076959983172;1972.447714639903;1984.583237520108;2001.129508663736;951.8619800128943;1010.4796030044533;1057.281048886749;1086.9076128529005;1088.5261574927044;18529.166187521594;19611.21555137807;19808.60382792336;19815.306464273683;19932.70100948487;1003.5885287032281;1010.141379827141;1036.1658864613908;1050.364529459681;1064.0423618743193;10813.18901082422;11206.38364889939;11248.550057997752;11301.361302611076;11351.772964540663;510581;524024;524295;526866;530730;67792.32207677959;81942;83856.58071709602;94145.5292723532;96135.51932240294;992.8808542974889;995.2137811129271;1014.9949250253554;1023.4319952426326;1030.6289735695143;17932.372366967094;17966.820331796516;18206.18072186781;18342;18682.906585466986;42805.78597106995;43003;43326.35010474782;43368.6147261891;44116.77941610271;60158.69920650369;61263.38736612577;61359.38640613537;61843;62291.688541557;8336.791580210544;8406.957965210135;8494.447860889022;8644.740657780276;8730.956345218234;9249.722508324761;12583.93708031454;13243.536476223286;13702.794458082937;14161.433542658178;11928.940355298168;12225.205361651464;12375.453068366454;12399;12537.686557836127;11965.282083075042;12130.878691213327;12255.387230638611;12265.69335766613;12378.876211238132;12390.876091238972;12562.120651554304;12605.117641764988;12717.10980231375;12729.618111456672;8519.787005324668;8587.184217499327;8673.219410252856;8712.912870871463;8798;11674.94162529182;11882.28706277626;11961.64115076549;12029.4586743595;12135.817962730744 03:27:39 INFO - PROCESS | 11636 | |3;mootools.html;1467.9119252844828;1494.3648949196588;1635.149722144485;1782.3939860447445;1796.802351741309;7939.325157361631;8508.61711222995;8605.053444121142;9115.54422278886;9119.498427586488;8693.7826554336;8924;8981.326400519954;8984.056674049229;8984.2812574994;2346.6597343385197;2354.3996280948336;2360.9527809443803;2364.326167042393;2366.160013195317;2311.491471876193;2357.127862690807;2393.1384701507445;2403.4472071423584;2406.518696260755;2331.2190416210506;2363.6690863279155;2369.9763002370014;2377.7741114594173;2385.33210701004;2326.232343326698;2335.381124002141;2341.3093137524556;2342.636891281854;2357.5167090746354;2304.8501847380035;2319.4085508195303;2328.4877326988035;2336.719593648756;2341.683872677184;8966.686165984225;8978.910210897873;9006.59470323837;9024.729258122266;9051.592678329425;5290.523852853224;5355.839324820262;5395.865103372447;5416.702081385522;5429.592780541475;3366.4781958796425;3388.491726241059;3474.774139680938;3478.721702263813;3498.1079824644808;1132.5243397772872;1137.3346592243547;1153.9942300288528;1155.9711007224803;1171.1275100050516;12362.567310144103;12388.81416778749;12397.194182378207;12414.565490207799;12416.379181040911;4583.381243532147;4589.449266088091;4689.109069276895;4725.385699858996;4770.833020844254;10424.68725938223;10448.738781530523;10452.68641940743;10461;10480.947595261974;5379.78480860769;5413.323334583177;5413.621046526784;5432.538234250133;5459.29029226206;4370.322599997005;4867;5002.324686167393;5013.473585273567;5033.5721463676;4104.748051844216;4133.152703695735;4139.275626765304;4166.812458449327;4205.2640787862;1294.5469085819889;1330.4146175682863;1338.404410037524;1344.4487760018346;1347.8449978252431;928.3037721708719;939.272064150289;957.2820384711466;959.596969272907;980.2843923935567;5803.767849285981;5959.374265702126;6000.249968753906;6058.8654729836235;6182.28903676083;434.32679347012004;447.9014616784302;1011.3729487717662;1097.4896673047072;1107.025817280804;3702.389105797567;3818.3127037133027;3887.7667339959694;3900.7659540427667;3904.531456225271;10889.564417423215;11247.044001259821;11272.887271127183;11286.774264514828;11307.717307067389;11136.832947505633;11185.440727963569;11190.32858028521;11224.775504489864;11247.83128253077;8108.351331893435;8332.708355207538;8433.873491897626;8487.702930397407;8504.192101750325;5729.770809167587;5863.442972917566;5884.146798714248;5995.6702381367695;6029.216201893726;10295.94852025765;10404.635837745642;10523.526441310007;10539.104176145114;10566.630167944086;10451.895481045396;10718.571257149626;10752.569897204025;10884.673459796219;10899.182561307774;7364.189939106801;7830.647620856961;7993.040835099825;7995.960020199862;8147.75556733299;8902.59938302765;8920.643174272956;8923.063078376937;8947.776305592151;8977.371583989057;7738;7932.286094251314;8044.074931382966;8075.0432288179545;8082.515049097073;7543.245675432632;7606.96196519036;7672.117706463828;7721.498102623312;7770.844583108194;7040.718371265297;7166.211716711262;7291.635418229173;7296.671649775667;7298.890516642361;5020.221865610836;5105.974470127626;5118;5190.299309593157;5198.194279886472;5141.562967147835;5228;5276.604254680991;5302.840914772563;5371.946280537301 03:27:39 INFO - PROCESS | 11636 | |4;prototype.html;330.85277051711984;338.4280565843724;338.71040260577206;340.36521886681345;341.90255777103516;5436.320459942507;5584.129316678917;5585.52523035542;5612.915806262899;5620.718964051791;5549.6115271930985;5565.387807341189;5570.2480165177685;5578.470045345696;5583.944160558393;4112.83548658054;4187.1625674865;4304.826062838262;4326.005018845667;4345.152695224432;4296.97851510742;4312.374705667677;4342.435483387171;4343.261645520269;4387.561243875619;4306.138772245547;4327.740335579875;4335.6965012449145;4348.369486424466;4354.346847972798;3990.720649554547;4169.958300416987;4176.686748493875;4194.706370554062;4313.352997050436;3627.6916462100753;3660.633936606345;3673.246984368198;3678.2091850252054;3693.372126738434;5372.221027950925;5401.78392864285;5412.675239485643;5415.214793854909;5427.62006659534;4606.976965115153;4874.780634871404;4885.316055752198;4887.608991280689;4896.81706890524;5765.971170144165;5776.33572139201;5794.942795307647;5796.50729687977;5799.710014499258;4121.505419349667;4121.5466298707115;4135.6898232632375;4150.211459822624;4151.833926642961;5925.111233314994;6049.848753781147;6071.210742603477;6101.267847858286;6120.479759220471;4149.25313443577;4167.416561681367;4182.9333519952215;4192.517860446027;4194.643455306272;4218.8523401681405;4241.27898257297;4241.745495270294;4273.786310684453;4278.379634952915;4711.199096153662;4849.854504364875;4871.878203044881;4890.315355850184;4930.235813448921;5788.7684492620665;5801.6519008859605;5855.882882342329;5864.354920958691;5891.175235467038;1450.9347079381453;1482.1181397068726;1483.3621542736728;1500.579837645461;1501.4744839306156;928.3687092776977;947.0718695678274;954.4178051388648;972.3922548407245;1003.7942221844651;5555.722093987607;5605.383407825136;5642.605017648807;5652.321721393377;5653.265075540154;5888.823335299948;5941.168236446901;5975.611585246945;5976.462118409364;5993.220881285492;5379.973100134474;5653.293338332708;5772.855678608068;5772.884542309131;5810.273715785527;3188.756385009848;3208.7806633479595;3243.918902027421;3248;3250.154959710492;6124.142620033199;6157.692115394212;6218.533609979269;6261.467775239155;6265.87214301421;6101.786437474667;6178.443940045418;6200.720967556471;6206.968965155145;6217.253929528486;6137.539684523768;6239.656818875005;6245.375462453719;6291;6303.747850085945;6074.878502429839;6109.686417420276;6138.815835524942;6146.969265153645;6156.891759483336;5982.88034239304;6008.639481631116;6033.42682445167;6033.487153591994;6039.275286965592;5953.583249172516;6205;6236.501079913687;6249.843753906189;6302.180716506825;4182.519010313853;4183.163367326486;4224;4225.450691410097;4284.757420348064;6001.609895356788;6075.207813694882;6089.847753806013;6091.695415229309;6164.8767024658355;5868.706564671835;5904.940950590439;5913.704314784158;5918.260217472816;5927.614705044159;5893.911591326219;5900.64596124234;5913.438223368773;5914.4381283777975;5968.881047228171;5292.761825717775;5800.404888655485;5804.24544809189;5815.94184058154;5817.825465236049;5879.235699359056;5887.234659494238;5912.787878484814;5913.02435098204;5935.821925342247;5556.583256255878;5786.479216870333;5807.883842323045;5814.895169917702;5815.563832712648 03:27:39 INFO - PROCESS | 11636 | |5;yui.html;752.7704050264671;758.0486489455732;804.0070512916551;807.1739952624561;863.1368631368631;14107.224102674349;15281.388744450236;15289.617759556017;15291.847081529182;15306.081635101873;13309.866901330985;13358.398872050757;13359.53241636543;13423.530176443826;13831.170129792194;663.4427081251747;806.2864365036941;811.6591031766673;811.9391045671568;817.7015389382863;766.5209244222361;811.5901469757764;815.4658698552457;820.1060843680388;821.8274162425897;848.9830203395928;853.4324674091722;857.7383897911135;859.4241857955154;860.6729442811722;851.2551517422255;853.3770347646191;854.2141230068352;856.7215654912147;858.5363903492107;620.8478922663932;622.4740094620039;624.1573875268397;625.6183727925961;626.2234828812285;13880.861191388058;14015.089019213821;14024.509142179975;14044.578662640137;14058.648533786738;14228.857711422857;14303;14342.426302947973;14360;14575;11712.121590880633;11755.35345555994;11840.28958262507;11889.524419023315;11926.821097683542;3740.214554943465;3835.328817456934;3853.6339047790416;3873.4189871519216;3964.207158568298;58438.41561584415;58484.70757646184;58513.41486585122;58679.41320586782;58731.11903321411;10066.345687530287;10242.59029638821;10363.49729289264;10402.531886065146;10428.5828566858;18238.726419103725;19903.701444478345;20100.195992160443;20119.19523219055;20169.798302017087;8425.873611895826;8502.617382217815;8543.871841922377;8626;8913.598888050054;4758.381410416624;4805.399325084364;4866.46468888422;4874.634402419832;4919.237518184687;3479.565054368204;3539.292141571696;3558.5907620623443;3615.8553657853918;3618.656227658368;621.5897507645024;625.6183727925961;643.6266965160196;646.2987658390605;654.3979538824293;724.8260417499762;728.7522242437597;749.1571981520789;765.1201118713412;779.9688012479551;9120.498372589438;9265.166135047879;9340.953295233481;9484.620615175454;9523.619055237852;637.3053371824733;644.7421031587403;734.8897665350133;742.2688651678093;772.2702046566053;4466.173757854807;4688.253513704309;4691.812327506861;4705.294205869079;4818.132736107535;65549.6722516394;69894;69895.30104698888;69912.65043674748;70187;61068;61499;61858;61899.69050154721;62666.373336266966;55602.443975560534;55763.721181393834;55838.44161558414;56149.43850561524;56258.43741562532;9025;9066.456012639263;9154.359194856295;9169.35814492979;9234.26125909939;36133.27733445369;36551.26897462089;36748.63251367559;36821.63178368182;36928.630713693594;49400.75299623479;49522.25716614326;49866.75066624644;50407.747961261426;51136.96851510113;12544;12659.683507912376;12746.171498852545;12817.807732883828;13230.140040897311;13790.517331893336;14135.717285654435;14142.717145656823;14447.927760361132;14830.703385932437;13072.193573978655;13482.93258533701;13706.451741930212;13819;13881;12926;13186.868131318948;13437.395317210945;13461.663458413226;13507.797383039066;12853.357332133543;13225;13235.073544851768;13689.293939919186;13810.516631917835;10783.892161078602;10806.513706883366;10941.56233750641;11206.103511719206;11208.159388046091;10474.790504189721;10872;10926.47484455621;11059.447027648424;11142.220044597125 03:27:39 INFO - PROCESS | 11636 | __end_tp_report 03:27:39 INFO - PROCESS | 11636 | __start_cc_report 03:27:39 INFO - PROCESS | 11636 | _x_x_mozilla_cycle_collect,344 03:27:39 INFO - PROCESS | 11636 | __end_cc_report 03:27:39 INFO - PROCESS | 11636 | __startTimestamp1464776859947__endTimestamp 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | ------- Summary: start ------- 03:27:39 INFO - PROCESS | 11636 | Number of tests: 6 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#0] dojo.html Cycles:165 Average:5509.22 Median:5794.54 stddev:743.67 (12.8%) stddev-sans-first:722.34 03:27:39 INFO - PROCESS | 11636 | Values: 3139.3 3182.4 3197.8 3211.3 3212.3 5546.3 5563.9 5594.3 5603.7 5656.5 5437.7 5505.1 5513.7 5586.5 5624.7 4866.7 4906.2 5010.2 5046.3 5093.5 1007.8 4946.1 4967.4 5058.8 5095.6 5003.7 5020.0 5028.3 5047.1 5053.2 5069.6 5077.4 5079.3 5080.6 5083.4 4864.4 4966.8 4967.0 4981.8 5025.7 5410.9 5436.5 5445.2 5454.9 5479.6 5933.1 5949.4 5984.5 5990.4 6029.2 5933.2 5957.8 5964.6 6035.0 6057.1 5600.6 5612.8 5614.6 5614.9 5615.4 6007.2 6067.4 6156.7 6166.2 6168.5 5818.4 5848.0 5856.9 5912.6 5922.1 5977.9 5985.2 5986.2 5987.7 5992.7 5823.2 5926.2 5966.7 5977.3 5979.9 5822.8 5836.5 5848.7 5909.5 5935.5 4407.6 4452.4 4462.2 4490.3 4524.1 3925.1 3979.3 3984.8 4006.6 4033.0 5695.6 5711.4 5746.9 5774.4 5808.5 6057.1 6078.6 6085.5 6090.5 6092.4 5613.3 5653.2 5659.4 5751.8 5759.5 5154.8 5157.9 5165.1 5167.9 5192.5 6213.0 6217.8 6223.8 6224.3 6227.1 5883.0 5899.4 5934.8 5950.5 6022.4 6143.6 6147.8 6156.3 6167.2 6171.3 5811.8 5826.2 5868.5 5872.4 5875.6 5875.9 5994.9 6020.2 6100.9 6121.7 5896.5 5902.5 5904.5 5913.7 5929.5 5727.4 5916.7 5924.7 5931.0 5947.9 5646.1 5663.3 5666.7 5691.8 5695.5 5779.5 5830.3 5855.1 5872.5 5885.9 5671.1 5794.5 5805.1 5806.1 5809.8 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#1] ext.html Cycles:180 Average:54248.78 Median:39763.80 stddev:100791.14 (253.5%) stddev-sans-first:100993.35 03:27:39 INFO - PROCESS | 11636 | Values: 585.2 624.7 631.6 644.1 662.0 42951.6 43755.3 43791.8 43970.3 47345.5 43564.8 44112.8 44569.3 44572.6 44610.8 8729.6 8927.1 8928.9 8931.2 8970.3 8776.4 8870.4 8876.9 8897.1 8901.2 8827.6 8986.8 9014.8 9025.3 9034.3 8883.6 8886.5 8890.0 8919.4 8948.3 8788.2 8879.9 8902.4 8931.6 8943.6 41174.4 41547.2 41596.8 41744.6 41748.6 3514.5 3572.5 3593.1 3616.6 3690.7 32095.8 32206.4 32246.4 32831.8 33446.5 4069.7 4134.9 4137.7 4163.8 4212.7 336412.0 337718.0 337721.0 338498.0 341136.3 56786.4 56910.7 56920.0 56944.4 57062.0 35549.3 35848.8 35990.6 38233.0 38601.4 16871.8 17063.7 17067.1 17125.8 17138.5 12627.0 12831.0 12840.6 12854.1 12857.8 19331.5 19576.8 19610.5 19645.7 19778.2 7347.0 7348.5 7386.3 7532.0 7545.3 974.7 1051.6 1115.7 1183.8 1185.0 30939.2 30959.2 30968.4 31520.2 31524.0 1172.3 1211.5 1212.8 1215.9 1219.4 15919.0 16437.9 16520.2 16612.5 16717.1 433385.0 437828.0 438208.0 438712.0 440506.0 55038.2 56261.7 56292.4 56416.4 56537.0 1339.9 1359.2 1380.9 1391.1 1396.5 29284.0 30180.4 30363.5 30806.5 30835.0 48509.3 48654.5 48665.8 48718.5 49083.0 359084.0 364763.0 366665.0 367264.0 368213.0 26719.2 27197.9 27232.7 27249.9 27281.3 44796.0 45345.5 45566.8 46304.5 46808.0 39197.8 39586.6 39941.0 39993.0 40038.0 39102.2 39488.6 39516.0 40019.4 40074.8 38294.2 39274.2 42643.6 43263.0 43267.8 34978.7 36063.0 36881.8 37606.4 37917.0 27937.9 28671.4 28802.6 28854.6 28942.4 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#2] jquery.html Cycles:180 Average:29724.00 Median:2024.52 stddev:86068.41 (4251.3%) stddev-sans-first:86281.67 03:27:39 INFO - PROCESS | 11636 | Values: 391.2 394.2 398.9 400.0 409.5 18015.2 18793.6 19510.5 19547.1 19632.8 16899.5 17222.1 17239.4 17453.7 17495.1 5179.1 5443.5 5610.7 5794.4 5794.5 5377.2 5420.9 5430.8 5500.6 5508.2 5378.9 5619.4 5667.2 5702.1 5705.6 5520.2 5616.1 5846.8 5847.6 5852.5 5620.0 5655.0 5657.4 5716.3 5724.8 12697.4 13563.5 13695.4 13707.0 13754.5 2047.9 2191.6 2222.6 2312.2 2340.5 10103.5 10290.2 11977.7 12031.3 15002.5 1911.9 1913.6 1913.9 1944.0 1985.7 69267.3 82422.0 85743.6 85765.1 85837.0 10858.5 11090.8 11183.9 11290.0 11486.9 15745.8 15753.9 15760.5 15782.5 15850.5 8092.4 8341.7 8432.3 8588.7 8660.7 8114.6 8157.3 8293.4 8334.7 8342.4 4576.7 4648.5 4665.7 4831.7 4865.6 1947.6 1961.1 1972.4 1984.6 2001.1 951.9 1010.5 1057.3 1086.9 1088.5 18529.2 19611.2 19808.6 19815.3 19932.7 1003.6 1010.1 1036.2 1050.4 1064.0 10813.2 11206.4 11248.6 11301.4 11351.8 510581.0 524024.0 524295.0 526866.0 530730.0 67792.3 81942.0 83856.6 94145.5 96135.5 992.9 995.2 1015.0 1023.4 1030.6 17932.4 17966.8 18206.2 18342.0 18682.9 42805.8 43003.0 43326.4 43368.6 44116.8 60158.7 61263.4 61359.4 61843.0 62291.7 8336.8 8407.0 8494.4 8644.7 8731.0 9249.7 12583.9 13243.5 13702.8 14161.4 11928.9 12225.2 12375.5 12399.0 12537.7 11965.3 12130.9 12255.4 12265.7 12378.9 12390.9 12562.1 12605.1 12717.1 12729.6 8519.8 8587.2 8673.2 8712.9 8798.0 11674.9 11882.3 11961.6 12029.5 12135.8 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#3] mootools.html Cycles:180 Average:5910.24 Median:2515.64 stddev:3388.05 (134.7%) stddev-sans-first:3381.11 03:27:39 INFO - PROCESS | 11636 | Values: 1467.9 1494.4 1635.1 1782.4 1796.8 7939.3 8508.6 8605.1 9115.5 9119.5 8693.8 8924.0 8981.3 8984.1 8984.3 2346.7 2354.4 2361.0 2364.3 2366.2 2311.5 2357.1 2393.1 2403.4 2406.5 2331.2 2363.7 2370.0 2377.8 2385.3 2326.2 2335.4 2341.3 2342.6 2357.5 2304.9 2319.4 2328.5 2336.7 2341.7 8966.7 8978.9 9006.6 9024.7 9051.6 5290.5 5355.8 5395.9 5416.7 5429.6 3366.5 3388.5 3474.8 3478.7 3498.1 1132.5 1137.3 1154.0 1156.0 1171.1 12362.6 12388.8 12397.2 12414.6 12416.4 4583.4 4589.4 4689.1 4725.4 4770.8 10424.7 10448.7 10452.7 10461.0 10480.9 5379.8 5413.3 5413.6 5432.5 5459.3 4370.3 4867.0 5002.3 5013.5 5033.6 4104.7 4133.2 4139.3 4166.8 4205.3 1294.5 1330.4 1338.4 1344.4 1347.8 928.3 939.3 957.3 959.6 980.3 5803.8 5959.4 6000.2 6058.9 6182.3 434.3 447.9 1011.4 1097.5 1107.0 3702.4 3818.3 3887.8 3900.8 3904.5 10889.6 11247.0 11272.9 11286.8 11307.7 11136.8 11185.4 11190.3 11224.8 11247.8 8108.4 8332.7 8433.9 8487.7 8504.2 5729.8 5863.4 5884.1 5995.7 6029.2 10295.9 10404.6 10523.5 10539.1 10566.6 10451.9 10718.6 10752.6 10884.7 10899.2 7364.2 7830.6 7993.0 7996.0 8147.8 8902.6 8920.6 8923.1 8947.8 8977.4 7738.0 7932.3 8044.1 8075.0 8082.5 7543.2 7607.0 7672.1 7721.5 7770.8 7040.7 7166.2 7291.6 7296.7 7298.9 5020.2 5106.0 5118.0 5190.3 5198.2 5141.6 5228.0 5276.6 5302.8 5371.9 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#4] prototype.html Cycles:180 Average:4915.53 Median:5631.66 stddev:1474.74 (26.2%) stddev-sans-first:1438.17 03:27:39 INFO - PROCESS | 11636 | Values: 330.9 338.4 338.7 340.4 341.9 5436.3 5584.1 5585.5 5612.9 5620.7 5549.6 5565.4 5570.2 5578.5 5583.9 4112.8 4187.2 4304.8 4326.0 4345.2 4297.0 4312.4 4342.4 4343.3 4387.6 4306.1 4327.7 4335.7 4348.4 4354.3 3990.7 4170.0 4176.7 4194.7 4313.4 3627.7 3660.6 3673.2 3678.2 3693.4 5372.2 5401.8 5412.7 5415.2 5427.6 4607.0 4874.8 4885.3 4887.6 4896.8 5766.0 5776.3 5794.9 5796.5 5799.7 4121.5 4121.5 4135.7 4150.2 4151.8 5925.1 6049.8 6071.2 6101.3 6120.5 4149.3 4167.4 4182.9 4192.5 4194.6 4218.9 4241.3 4241.7 4273.8 4278.4 4711.2 4849.9 4871.9 4890.3 4930.2 5788.8 5801.7 5855.9 5864.4 5891.2 1450.9 1482.1 1483.4 1500.6 1501.5 928.4 947.1 954.4 972.4 1003.8 5555.7 5605.4 5642.6 5652.3 5653.3 5888.8 5941.2 5975.6 5976.5 5993.2 5380.0 5653.3 5772.9 5772.9 5810.3 3188.8 3208.8 3243.9 3248.0 3250.2 6124.1 6157.7 6218.5 6261.5 6265.9 6101.8 6178.4 6200.7 6207.0 6217.3 6137.5 6239.7 6245.4 6291.0 6303.7 6074.9 6109.7 6138.8 6147.0 6156.9 5982.9 6008.6 6033.4 6033.5 6039.3 5953.6 6205.0 6236.5 6249.8 6302.2 4182.5 4183.2 4224.0 4225.5 4284.8 6001.6 6075.2 6089.8 6091.7 6164.9 5868.7 5904.9 5913.7 5918.3 5927.6 5893.9 5900.6 5913.4 5914.4 5968.9 5292.8 5800.4 5804.2 5815.9 5817.8 5879.2 5887.2 5912.8 5913.0 5935.8 5556.6 5786.5 5807.9 5814.9 5815.6 03:27:39 INFO - PROCESS | 11636 | 03:27:39 INFO - PROCESS | 11636 | [#5] yui.html Cycles:180 Average:15856.47 Median:4811.77 stddev:18958.38 (394.0%) stddev-sans-first:18977.63 03:27:39 INFO - PROCESS | 11636 | Values: 752.8 758.0 804.0 807.2 863.1 14107.2 15281.4 15289.6 15291.8 15306.1 13309.9 13358.4 13359.5 13423.5 13831.2 663.4 806.3 811.7 811.9 817.7 766.5 811.6 815.5 820.1 821.8 849.0 853.4 857.7 859.4 860.7 851.3 853.4 854.2 856.7 858.5 620.8 622.5 624.2 625.6 626.2 13880.9 14015.1 14024.5 14044.6 14058.6 14228.9 14303.0 14342.4 14360.0 14575.0 11712.1 11755.4 11840.3 11889.5 11926.8 3740.2 3835.3 3853.6 3873.4 3964.2 58438.4 58484.7 58513.4 58679.4 58731.1 10066.3 10242.6 10363.5 10402.5 10428.6 18238.7 19903.7 20100.2 20119.2 20169.8 8425.9 8502.6 8543.9 8626.0 8913.6 4758.4 4805.4 4866.5 4874.6 4919.2 3479.6 3539.3 3558.6 3615.9 3618.7 621.6 625.6 643.6 646.3 654.4 724.8 728.8 749.2 765.1 780.0 9120.5 9265.2 9341.0 9484.6 9523.6 637.3 644.7 734.9 742.3 772.3 4466.2 4688.3 4691.8 4705.3 4818.1 65549.7 69894.0 69895.3 69912.7 70187.0 61068.0 61499.0 61858.0 61899.7 62666.4 55602.4 55763.7 55838.4 56149.4 56258.4 9025.0 9066.5 9154.4 9169.4 9234.3 36133.3 36551.3 36748.6 36821.6 36928.6 49400.8 49522.3 49866.8 50407.7 51137.0 12544.0 12659.7 12746.2 12817.8 13230.1 13790.5 14135.7 14142.7 14447.9 14830.7 13072.2 13482.9 13706.5 13819.0 13881.0 12926.0 13186.9 13437.4 13461.7 13507.8 12853.4 13225.0 13235.1 13689.3 13810.5 10783.9 10806.5 10941.6 11206.1 11208.2 10474.8 10872.0 10926.5 11059.4 11142.2 03:27:39 INFO - PROCESS | 11636 | -------- Summary: end -------- 03:27:39 INFO - PROCESS | 11636 | 03:27:40 INFO - TEST-INFO | 11636: exit 0 03:27:40 INFO - TEST-OK | dromaeo_css | took 1111250ms 03:27:40 INFO - TEST-START | kraken 03:27:40 INFO - operating with platform_type : linux_ 03:27:40 INFO - Initialising browser for kraken test... 03:27:40 INFO - TEST-INFO | started process 11875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmhKmm/profile http://localhost:51876/getInfo.html) 03:27:45 INFO - PROCESS | 11875 | __metrics Screen width/height:1600/1200 03:27:45 INFO - PROCESS | 11875 | colorDepth:24 03:27:45 INFO - PROCESS | 11875 | Browser inner width/height: 1024/697 03:27:45 INFO - PROCESS | 11875 | __metrics 03:27:46 ERROR - PROCESS | 11875 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:27:46 INFO - TEST-INFO | 11875: exit 0 03:27:46 INFO - Browser initialized. 03:27:46 INFO - Running cycle 1/1 for kraken test... 03:27:46 INFO - TEST-INFO | started process 11995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmhKmm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:58 INFO - PROCESS | 11995 | RSS: Main: 166739968 03:27:58 INFO - PROCESS | 11995 | 03:28:01 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:02 INFO - PROCESS | 11995 | RSS: Main: 172408832 03:28:02 INFO - PROCESS | 11995 | 03:28:04 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-dft) 03:28:05 INFO - PROCESS | 11995 | RSS: Main: 171655168 03:28:05 INFO - PROCESS | 11995 | 03:28:08 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-fft) 03:28:09 INFO - PROCESS | 11995 | RSS: Main: 166285312 03:28:09 INFO - PROCESS | 11995 | 03:28:11 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51876/tests/kraken/driver.html?testName=audio-oscillator) 03:28:11 INFO - PROCESS | 11995 | RSS: Main: 167174144 03:28:11 INFO - PROCESS | 11995 | 03:28:13 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:14 INFO - PROCESS | 11995 | RSS: Main: 167497728 03:28:14 INFO - PROCESS | 11995 | 03:28:17 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:18 INFO - PROCESS | 11995 | RSS: Main: 167337984 03:28:18 INFO - PROCESS | 11995 | 03:28:21 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51876/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:22 INFO - PROCESS | 11995 | RSS: Main: 165371904 03:28:22 INFO - PROCESS | 11995 | 03:28:25 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51876/tests/kraken/driver.html?testName=json-parse-financial) 03:28:25 INFO - PROCESS | 11995 | RSS: Main: 166899712 03:28:25 INFO - PROCESS | 11995 | 03:28:27 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:27 INFO - PROCESS | 11995 | RSS: Main: 166907904 03:28:27 INFO - PROCESS | 11995 | 03:28:29 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:30 INFO - PROCESS | 11995 | RSS: Main: 167358464 03:28:30 INFO - PROCESS | 11995 | 03:28:32 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:33 INFO - PROCESS | 11995 | RSS: Main: 167866368 03:28:33 INFO - PROCESS | 11995 | 03:28:35 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:36 INFO - PROCESS | 11995 | RSS: Main: 167702528 03:28:36 INFO - PROCESS | 11995 | 03:28:39 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:39 INFO - PROCESS | 11995 | RSS: Main: 167821312 03:28:39 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | Cycle 1(1): loaded http://localhost:51876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51876/tests/kraken/driver.html?testName=ai-astar) 03:28:41 INFO - PROCESS | 11995 | RSS: Main: 168620032 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | __start_tp_report 03:28:41 INFO - PROCESS | 11995 | _x_x_mozilla_page_load 03:28:41 INFO - PROCESS | 11995 | _x_x_mozilla_page_load_details 03:28:41 INFO - PROCESS | 11995 | |i|pagename|runs| 03:28:41 INFO - PROCESS | 11995 | |0;ai-astar;110;105;110;110;114;112;111;109;110;111 03:28:41 INFO - PROCESS | 11995 | |1;audio-beat-detection;150;130;151;173;126;161;153;125;181;126 03:28:41 INFO - PROCESS | 11995 | |2;audio-dft;160;165;161;163;161;165;164;163;163;163 03:28:41 INFO - PROCESS | 11995 | |3;audio-fft;75;74;75;152;74;74;76;77;176;76 03:28:41 INFO - PROCESS | 11995 | |4;audio-oscillator;83;83;154;82;83;82;137;82;82;146 03:28:41 INFO - PROCESS | 11995 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;122;119 03:28:41 INFO - PROCESS | 11995 | |6;imaging-darkroom;146;147;147;146;147;146;147;146;146;145 03:28:41 INFO - PROCESS | 11995 | |7;imaging-desaturate;95;96;96;95;95;96;95;95;95;95 03:28:41 INFO - PROCESS | 11995 | |8;json-parse-financial;55;56;57;55;56;55;58;56;54;55 03:28:41 INFO - PROCESS | 11995 | |9;json-stringify-tinderbox;61;65;61;61;60;60;69;60;60;61 03:28:41 INFO - PROCESS | 11995 | |10;stanford-crypto-aes;80;78;83;84;80;81;84;82;115;87 03:28:41 INFO - PROCESS | 11995 | |11;stanford-crypto-ccm;125;129;122;125;139;133;130;125;129;122 03:28:41 INFO - PROCESS | 11995 | |12;stanford-crypto-pbkdf2;165;164;160;164;160;168;159;160;161;160 03:28:41 INFO - PROCESS | 11995 | |13;stanford-crypto-sha256-iterative;62;65;65;63;62;67;61;67;62;62 03:28:41 INFO - PROCESS | 11995 | __end_tp_report 03:28:41 INFO - PROCESS | 11995 | __start_cc_report 03:28:41 INFO - PROCESS | 11995 | _x_x_mozilla_cycle_collect,866 03:28:41 INFO - PROCESS | 11995 | __end_cc_report 03:28:41 INFO - PROCESS | 11995 | __startTimestamp1464776921593__endTimestamp 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | ------- Summary: start ------- 03:28:41 INFO - PROCESS | 11995 | Number of tests: 14 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:2.30 (2.1%) stddev-sans-first:2.44 03:28:41 INFO - PROCESS | 11995 | Values: 110.0 105.0 110.0 110.0 114.0 112.0 111.0 109.0 110.0 111.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:20.39 (13.4%) stddev-sans-first:21.60 03:28:41 INFO - PROCESS | 11995 | Values: 150.0 130.0 151.0 173.0 126.0 161.0 153.0 125.0 181.0 126.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.69 (1.0%) stddev-sans-first:1.45 03:28:41 INFO - PROCESS | 11995 | Values: 160.0 165.0 161.0 163.0 161.0 165.0 164.0 163.0 163.0 163.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:37.91 (50.5%) stddev-sans-first:39.65 03:28:41 INFO - PROCESS | 11995 | Values: 75.0 74.0 75.0 152.0 74.0 74.0 76.0 77.0 176.0 76.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:82.00 stddev:30.81 (37.6%) stddev-sans-first:31.95 03:28:41 INFO - PROCESS | 11995 | Values: 83.0 83.0 154.0 82.0 83.0 82.0 137.0 82.0 82.0 146.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.62 (1.4%) stddev-sans-first:1.69 03:28:41 INFO - PROCESS | 11995 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 122.0 119.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:28:41 INFO - PROCESS | 11995 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 145.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:28:41 INFO - PROCESS | 11995 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 03:28:41 INFO - PROCESS | 11995 | Values: 55.0 56.0 57.0 55.0 56.0 55.0 58.0 56.0 54.0 55.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:2.94 (4.8%) stddev-sans-first:3.10 03:28:41 INFO - PROCESS | 11995 | Values: 61.0 65.0 61.0 61.0 60.0 60.0 69.0 60.0 60.0 61.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.50 stddev:10.71 (13.0%) stddev-sans-first:11.18 03:28:41 INFO - PROCESS | 11995 | Values: 80.0 78.0 83.0 84.0 80.0 81.0 84.0 82.0 115.0 87.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:5.28 (4.1%) stddev-sans-first:5.49 03:28:41 INFO - PROCESS | 11995 | Values: 125.0 129.0 122.0 125.0 139.0 133.0 130.0 125.0 129.0 122.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.50 stddev:2.96 (1.8%) stddev-sans-first:2.95 03:28:41 INFO - PROCESS | 11995 | Values: 165.0 164.0 160.0 164.0 160.0 168.0 159.0 160.0 161.0 160.0 03:28:41 INFO - PROCESS | 11995 | 03:28:41 INFO - PROCESS | 11995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:2.22 (3.5%) stddev-sans-first:2.28 03:28:41 INFO - PROCESS | 11995 | Values: 62.0 65.0 65.0 63.0 62.0 67.0 61.0 67.0 62.0 62.0 03:28:41 INFO - PROCESS | 11995 | -------- Summary: end -------- 03:28:41 INFO - PROCESS | 11995 | 03:28:42 INFO - TEST-INFO | 11995: exit 0 03:28:42 INFO - TEST-OK | kraken | took 61853ms 03:28:42 INFO - SUITE-END | took 1173s 03:28:42 INFO - Completed test suite (00:19:33) 03:28:42 INFO - javascript benchmark 03:28:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.14793652515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.293658926741, 3182.4430724623185, 3197.8401079946, 3211.3095684427844, 3212.2772376215353, 5546.334439867222, 5563.8887222255535, 5594.328680558334, 5603.719814009303, 5656.519195868346, 5437.728113594324, 5505.146702261156, 5513.724313784315, 5586.469285417878, 5624.746886390112, 4866.659333846632, 4906.215005599105, 5010.223415370623, 5046.268291097788, 5093.490650934914, 1007.8284625450543, 4946.060248552782, 4967.379077615298, 5058.7976480940715, 5095.6178286628465, 5003.699778013331, 5020.021095886304, 5028.296038554568, 5047.066292735855, 5053.191489361703, 5069.594432445396, 5077.441481437039, 5079.263506791494, 5080.644354895159, 5083.389993200803, 4864.391951006124, 4966.751662416865, 4967.0, 4981.750912454399, 5025.6733312334945, 5410.91883621746, 5436.456354364572, 5445.210444485567, 5454.91817622736, 5479.643823151482, 5933.050711886078, 5949.405059494059, 5984.521238300926, 5990.430909063675, 6029.21620189377, 5933.22868027158, 5957.791477298274, 5964.582479226456, 6035.0, 6057.091436284549, 5600.635958662674, 5612.831615051555, 5614.606977511576, 5614.859628509279, 5615.438456154393, 6007.189029480965, 6067.423594758491, 6156.6921653917125, 6166.229221347332, 6168.506519478431, 5818.44724751148, 5848.005839007379, 5856.8535786604825, 5912.645241285537, 5922.052471604523, 5977.910331345033, 5985.191999080155, 5986.191864098291, 5987.700614969234, 5992.730327135289, 5823.2429784128635, 5926.1999630049395, 5966.731497082642, 5977.252843394575, 5979.910301345483, 5822.82531524055, 5836.4747172753805, 5848.707564621752, 5909.468147866713, 5935.52515798735, 4407.603315701603, 4452.354408610733, 4462.241418958784, 4490.3040028795585, 4524.140413321458, 3925.0579860833764, 3979.303621866162, 3984.820683069269, 4006.59934006597, 4033.032072302626, 5695.629784064023, 5711.371749107595, 5746.885062298814, 5774.364819869811, 5808.535317174616, 6057.061155520902, 6078.574499784972, 6085.543584231112, 6090.512758979271, 6092.360302168208, 5613.298337707786, 5653.180288858092, 5659.405762394971, 5751.827445176651, 5759.539236861041, 5154.793808247703, 5157.948420515821, 5165.070287348313, 5167.896642067213, 5192.506711862443, 6212.968935155295, 6217.813465596039, 6223.751049958041, 6224.315325314303, 6227.1282020516255, 5883.0, 5899.380565040609, 5934.821955341346, 5950.464458198783, 6022.397760223943, 6143.631382117087, 6147.754089836357, 6156.26124865019, 6167.198264225622, 6171.290301615371, 5811.79658711943, 5826.213461182856, 5868.471837534642, 5872.354041055395, 5875.6474611523445, 5875.853103672443, 5994.850128746816, 6020.247469066367, 6100.938990610037, 6121.724522396592, 5896.469317761422, 5902.468777810018, 5904.498117660047, 5913.70431478433, 5929.466348028698, 5727.369989301257, 5916.733746981482, 5924.7037648118285, 5931.0, 5947.851303717442, 5646.096624540218, 5663.292088488939, 5666.688332141772, 5691.772329106955, 5695.487406133468, 5779.508741756998, 5830.300363956352, 5855.063189889597, 5872.471477567039, 5885.852853678693, 5671.120976248688, 5794.536437084938, 5805.10020946754, 5806.1000544915605, 5809.796657116981], "value": 5458.29173868738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.2041223935447, 624.6814124796354, 631.5736877607619, 644.0821828893825, 662.0367365483222, 42951.570484295145, 43755.34366984498, 43791.78104109479, 43970.34044489327, 47345.526544734545, 43564.78217608907, 44112.77943610286, 44569.33146002812, 44572.554274457325, 44610.77694611531, 8729.607167677454, 8927.107289271085, 8928.866067009, 8931.240844528224, 8970.282377409792, 8776.429532080427, 8870.42342247752, 8876.911230887705, 8897.110288971084, 8901.243394311492, 8827.646894124227, 8986.775330616754, 9014.774630634221, 9025.277977761763, 9034.32242581809, 8883.555822208897, 8886.4668119913, 8890.022097569263, 8919.42023768453, 8948.284137269035, 8788.165124313244, 8879.911200888038, 8902.42134261271, 8931.553422328923, 8943.5975381108, 41174.38238426426, 41547.169056619, 41596.79201604003, 41744.582554174376, 41748.58251417477, 3514.525539052246, 3572.464130380438, 3593.1376469647357, 3616.5840928293055, 3690.741648084635, 32095.83952080248, 32206.35587288241, 32246.355072898645, 32831.83584082088, 33446.498302525484, 4069.674426045909, 4134.91730165398, 4137.689673274486, 4163.83344666213, 4212.705110642256, 336412.0, 337718.0, 337721.0, 338498.0, 341136.2943185293, 56786.432135678115, 56910.7154464225, 56920.0, 56944.430555694744, 57062.00565960343, 35549.28901421957, 35848.82075589606, 35990.64009359925, 38233.0, 38601.42097868534, 16871.83128168727, 17063.744043839353, 17067.06131162773, 17125.828741712674, 17138.485845424657, 12627.0, 12831.0, 12840.55058072963, 12854.100212985188, 12857.807132893015, 19331.51671208231, 19576.8042319575, 19610.509737256398, 19645.705314420295, 19778.20887164526, 7347.044884165024, 7348.52234604749, 7386.261373862678, 7531.962340188264, 7545.320921117016, 974.7173319737196, 1051.6266725312557, 1115.7154925493946, 1183.7810005149074, 1184.9585264515702, 30939.226519336746, 30959.226019349695, 30968.380632387227, 31520.211994700316, 31524.0, 1172.302480024384, 1211.4669545399995, 1212.781699294118, 1215.9452824622913, 1219.432963671897, 15919.0, 16437.917810410872, 16520.173991300628, 16612.50162495127, 16717.080560569284, 433385.0, 437828.0, 438208.0, 438712.0, 440506.0, 55038.17442738362, 56261.718691406284, 56292.43707562954, 56416.43583564194, 56537.0, 1339.9397027133803, 1359.157322460081, 1380.9378577964017, 1391.067984450441, 1396.5112210726165, 29283.975060872766, 30180.396392071598, 30363.544546832258, 30806.537901931937, 30835.0, 48509.27236091532, 48654.513454864995, 48665.75667121642, 48718.51281487282, 49083.0, 359084.0, 364763.0, 366665.0, 367264.0, 368213.0, 26719.19448457884, 27197.86401067982, 27232.727672723813, 27249.86375068112, 27281.31796705098, 44796.0, 45345.54654453413, 45566.77216613896, 46304.53695463002, 46808.0, 39197.804010979766, 39586.604133958295, 39941.0, 39993.0, 40037.99905002398, 39102.217955641296, 39488.60511394849, 39516.0, 40019.3997090038, 40074.79962600285, 38294.2341153181, 39274.214515708954, 42643.5735642652, 43263.0, 43267.78366108149, 34978.65021349754, 36063.0, 36881.81559092188, 37606.43590346092, 37917.0, 27937.860310698317, 28671.42657146887, 28802.567961481014, 28854.567181491875, 28942.421151577273], "value": 19602.934052326844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1804769008927, 394.2450207851963, 398.9408121437583, 399.97600143991343, 409.4922296352522, 18015.18931648076, 18793.62412751744, 19510.512237194078, 19547.120379582935, 19632.803671963276, 16899.493015209533, 17222.13889305533, 17239.39662111823, 17453.650926981452, 17495.125243737824, 5179.067767801795, 5443.510084092431, 5610.747516361764, 5794.449527294901, 5794.536437085023, 5377.247185394048, 5420.891582168354, 5430.782768689248, 5500.642458240201, 5508.20131080995, 5378.865528361783, 5619.4099619539975, 5667.178259152421, 5702.1446782982675, 5705.57360659835, 5520.227168196456, 5616.129499927518, 5846.766129354842, 5847.619904706181, 5852.502537284336, 5620.0, 5654.9717251413895, 5657.434256574351, 5716.314042314907, 5724.799632012901, 12697.365131743469, 13563.457461701619, 13695.383707733175, 13707.040507164502, 13754.518591849237, 2047.9180832766672, 2191.594555007313, 2222.6205413156613, 2312.213847291912, 2340.461693810433, 10103.545340459623, 10290.176785857113, 11977.700557486045, 12031.338276394883, 15002.549923502313, 1911.9330823421253, 1913.6268427656612, 1913.9234430622757, 1944.0377013378468, 1985.662437385648, 69267.30732692659, 82422.0, 85743.5712821432, 85765.14234857634, 85837.0, 10858.511366988505, 11090.778184436265, 11183.888161118284, 11290.040346570633, 11486.851314868614, 15745.763813542806, 15753.921230393775, 15760.527184184493, 15782.526524204291, 15850.52448426549, 8092.3930705197345, 8341.708040218564, 8432.325413966868, 8588.699395521127, 8660.653573856975, 8114.594270286462, 8157.265846073882, 8293.419460637697, 8334.749957501284, 8342.37432192588, 4576.679632425765, 4648.535146485325, 4665.720056796603, 4831.710097394168, 4865.56209941107, 1947.6396866579728, 1961.1076959983172, 1972.447714639903, 1984.583237520108, 2001.129508663736, 951.8619800128943, 1010.4796030044533, 1057.281048886749, 1086.9076128529005, 1088.5261574927044, 18529.166187521594, 19611.21555137807, 19808.60382792336, 19815.306464273683, 19932.70100948487, 1003.5885287032281, 1010.141379827141, 1036.1658864613908, 1050.364529459681, 1064.0423618743193, 10813.18901082422, 11206.38364889939, 11248.550057997752, 11301.361302611076, 11351.772964540663, 510581.0, 524024.0, 524295.0, 526866.0, 530730.0, 67792.32207677959, 81942.0, 83856.58071709602, 94145.5292723532, 96135.51932240294, 992.8808542974889, 995.2137811129271, 1014.9949250253554, 1023.4319952426326, 1030.6289735695143, 17932.372366967094, 17966.820331796516, 18206.18072186781, 18342.0, 18682.906585466986, 42805.78597106995, 43003.0, 43326.35010474782, 43368.6147261891, 44116.77941610271, 60158.69920650369, 61263.38736612577, 61359.38640613537, 61843.0, 62291.688541557, 8336.791580210544, 8406.957965210135, 8494.447860889022, 8644.740657780276, 8730.956345218234, 9249.722508324761, 12583.93708031454, 13243.536476223286, 13702.794458082937, 14161.433542658178, 11928.940355298168, 12225.205361651464, 12375.453068366454, 12399.0, 12537.686557836127, 11965.282083075042, 12130.878691213327, 12255.387230638611, 12265.69335766613, 12378.876211238132, 12390.876091238972, 12562.120651554304, 12605.117641764988, 12717.10980231375, 12729.618111456672, 8519.787005324668, 8587.184217499327, 8673.219410252856, 8712.912870871463, 8798.0, 11674.94162529182, 11882.28706277626, 11961.64115076549, 12029.4586743595, 12135.817962730744], "value": 9203.252434676398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.9119252844828, 1494.3648949196588, 1635.149722144485, 1782.3939860447445, 1796.802351741309, 7939.325157361631, 8508.61711222995, 8605.053444121142, 9115.54422278886, 9119.498427586488, 8693.7826554336, 8924.0, 8981.326400519954, 8984.056674049229, 8984.2812574994, 2346.6597343385197, 2354.3996280948336, 2360.9527809443803, 2364.326167042393, 2366.160013195317, 2311.491471876193, 2357.127862690807, 2393.1384701507445, 2403.4472071423584, 2406.518696260755, 2331.2190416210506, 2363.6690863279155, 2369.9763002370014, 2377.7741114594173, 2385.33210701004, 2326.232343326698, 2335.381124002141, 2341.3093137524556, 2342.636891281854, 2357.5167090746354, 2304.8501847380035, 2319.4085508195303, 2328.4877326988035, 2336.719593648756, 2341.683872677184, 8966.686165984225, 8978.910210897873, 9006.59470323837, 9024.729258122266, 9051.592678329425, 5290.523852853224, 5355.839324820262, 5395.865103372447, 5416.702081385522, 5429.592780541475, 3366.4781958796425, 3388.491726241059, 3474.774139680938, 3478.721702263813, 3498.1079824644808, 1132.5243397772872, 1137.3346592243547, 1153.9942300288528, 1155.9711007224803, 1171.1275100050516, 12362.567310144103, 12388.81416778749, 12397.194182378207, 12414.565490207799, 12416.379181040911, 4583.381243532147, 4589.449266088091, 4689.109069276895, 4725.385699858996, 4770.833020844254, 10424.68725938223, 10448.738781530523, 10452.68641940743, 10461.0, 10480.947595261974, 5379.78480860769, 5413.323334583177, 5413.621046526784, 5432.538234250133, 5459.29029226206, 4370.322599997005, 4867.0, 5002.324686167393, 5013.473585273567, 5033.5721463676, 4104.748051844216, 4133.152703695735, 4139.275626765304, 4166.812458449327, 4205.2640787862, 1294.5469085819889, 1330.4146175682863, 1338.404410037524, 1344.4487760018346, 1347.8449978252431, 928.3037721708719, 939.272064150289, 957.2820384711466, 959.596969272907, 980.2843923935567, 5803.767849285981, 5959.374265702126, 6000.249968753906, 6058.8654729836235, 6182.28903676083, 434.32679347012004, 447.9014616784302, 1011.3729487717662, 1097.4896673047072, 1107.025817280804, 3702.389105797567, 3818.3127037133027, 3887.7667339959694, 3900.7659540427667, 3904.531456225271, 10889.564417423215, 11247.044001259821, 11272.887271127183, 11286.774264514828, 11307.717307067389, 11136.832947505633, 11185.440727963569, 11190.32858028521, 11224.775504489864, 11247.83128253077, 8108.351331893435, 8332.708355207538, 8433.873491897626, 8487.702930397407, 8504.192101750325, 5729.770809167587, 5863.442972917566, 5884.146798714248, 5995.6702381367695, 6029.216201893726, 10295.94852025765, 10404.635837745642, 10523.526441310007, 10539.104176145114, 10566.630167944086, 10451.895481045396, 10718.571257149626, 10752.569897204025, 10884.673459796219, 10899.182561307774, 7364.189939106801, 7830.647620856961, 7993.040835099825, 7995.960020199862, 8147.75556733299, 8902.59938302765, 8920.643174272956, 8923.063078376937, 8947.776305592151, 8977.371583989057, 7738.0, 7932.286094251314, 8044.074931382966, 8075.0432288179545, 8082.515049097073, 7543.245675432632, 7606.96196519036, 7672.117706463828, 7721.498102623312, 7770.844583108194, 7040.718371265297, 7166.211716711262, 7291.635418229173, 7296.671649775667, 7298.890516642361, 5020.221865610836, 5105.974470127626, 5118.0, 5190.299309593157, 5198.194279886472, 5141.562967147835, 5228.0, 5276.604254680991, 5302.840914772563, 5371.946280537301], "value": 4703.972509617787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.85277051711984, 338.4280565843724, 338.71040260577206, 340.36521886681345, 341.90255777103516, 5436.320459942507, 5584.129316678917, 5585.52523035542, 5612.915806262899, 5620.718964051791, 5549.6115271930985, 5565.387807341189, 5570.2480165177685, 5578.470045345696, 5583.944160558393, 4112.83548658054, 4187.1625674865, 4304.826062838262, 4326.005018845667, 4345.152695224432, 4296.97851510742, 4312.374705667677, 4342.435483387171, 4343.261645520269, 4387.561243875619, 4306.138772245547, 4327.740335579875, 4335.6965012449145, 4348.369486424466, 4354.346847972798, 3990.720649554547, 4169.958300416987, 4176.686748493875, 4194.706370554062, 4313.352997050436, 3627.6916462100753, 3660.633936606345, 3673.246984368198, 3678.2091850252054, 3693.372126738434, 5372.221027950925, 5401.78392864285, 5412.675239485643, 5415.214793854909, 5427.62006659534, 4606.976965115153, 4874.780634871404, 4885.316055752198, 4887.608991280689, 4896.81706890524, 5765.971170144165, 5776.33572139201, 5794.942795307647, 5796.50729687977, 5799.710014499258, 4121.505419349667, 4121.5466298707115, 4135.6898232632375, 4150.211459822624, 4151.833926642961, 5925.111233314994, 6049.848753781147, 6071.210742603477, 6101.267847858286, 6120.479759220471, 4149.25313443577, 4167.416561681367, 4182.9333519952215, 4192.517860446027, 4194.643455306272, 4218.8523401681405, 4241.27898257297, 4241.745495270294, 4273.786310684453, 4278.379634952915, 4711.199096153662, 4849.854504364875, 4871.878203044881, 4890.315355850184, 4930.235813448921, 5788.7684492620665, 5801.6519008859605, 5855.882882342329, 5864.354920958691, 5891.175235467038, 1450.9347079381453, 1482.1181397068726, 1483.3621542736728, 1500.579837645461, 1501.4744839306156, 928.3687092776977, 947.0718695678274, 954.4178051388648, 972.3922548407245, 1003.7942221844651, 5555.722093987607, 5605.383407825136, 5642.605017648807, 5652.321721393377, 5653.265075540154, 5888.823335299948, 5941.168236446901, 5975.611585246945, 5976.462118409364, 5993.220881285492, 5379.973100134474, 5653.293338332708, 5772.855678608068, 5772.884542309131, 5810.273715785527, 3188.756385009848, 3208.7806633479595, 3243.918902027421, 3248.0, 3250.154959710492, 6124.142620033199, 6157.692115394212, 6218.533609979269, 6261.467775239155, 6265.87214301421, 6101.786437474667, 6178.443940045418, 6200.720967556471, 6206.968965155145, 6217.253929528486, 6137.539684523768, 6239.656818875005, 6245.375462453719, 6291.0, 6303.747850085945, 6074.878502429839, 6109.686417420276, 6138.815835524942, 6146.969265153645, 6156.891759483336, 5982.88034239304, 6008.639481631116, 6033.42682445167, 6033.487153591994, 6039.275286965592, 5953.583249172516, 6205.0, 6236.501079913687, 6249.843753906189, 6302.180716506825, 4182.519010313853, 4183.163367326486, 4224.0, 4225.450691410097, 4284.757420348064, 6001.609895356788, 6075.207813694882, 6089.847753806013, 6091.695415229309, 6164.8767024658355, 5868.706564671835, 5904.940950590439, 5913.704314784158, 5918.260217472816, 5927.614705044159, 5893.911591326219, 5900.64596124234, 5913.438223368773, 5914.4381283777975, 5968.881047228171, 5292.761825717775, 5800.404888655485, 5804.24544809189, 5815.94184058154, 5817.825465236049, 5879.235699359056, 5887.234659494238, 5912.787878484814, 5913.02435098204, 5935.821925342247, 5556.583256255878, 5786.479216870333, 5807.883842323045, 5814.895169917702, 5815.563832712648], "value": 4440.9409693284215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.7704050264671, 758.0486489455732, 804.0070512916551, 807.1739952624561, 863.1368631368631, 14107.224102674349, 15281.388744450236, 15289.617759556017, 15291.847081529182, 15306.081635101873, 13309.866901330985, 13358.398872050757, 13359.53241636543, 13423.530176443826, 13831.170129792194, 663.4427081251747, 806.2864365036941, 811.6591031766673, 811.9391045671568, 817.7015389382863, 766.5209244222361, 811.5901469757764, 815.4658698552457, 820.1060843680388, 821.8274162425897, 848.9830203395928, 853.4324674091722, 857.7383897911135, 859.4241857955154, 860.6729442811722, 851.2551517422255, 853.3770347646191, 854.2141230068352, 856.7215654912147, 858.5363903492107, 620.8478922663932, 622.4740094620039, 624.1573875268397, 625.6183727925961, 626.2234828812285, 13880.861191388058, 14015.089019213821, 14024.509142179975, 14044.578662640137, 14058.648533786738, 14228.857711422857, 14303.0, 14342.426302947973, 14360.0, 14575.0, 11712.121590880633, 11755.35345555994, 11840.28958262507, 11889.524419023315, 11926.821097683542, 3740.214554943465, 3835.328817456934, 3853.6339047790416, 3873.4189871519216, 3964.207158568298, 58438.41561584415, 58484.70757646184, 58513.41486585122, 58679.41320586782, 58731.11903321411, 10066.345687530287, 10242.59029638821, 10363.49729289264, 10402.531886065146, 10428.5828566858, 18238.726419103725, 19903.701444478345, 20100.195992160443, 20119.19523219055, 20169.798302017087, 8425.873611895826, 8502.617382217815, 8543.871841922377, 8626.0, 8913.598888050054, 4758.381410416624, 4805.399325084364, 4866.46468888422, 4874.634402419832, 4919.237518184687, 3479.565054368204, 3539.292141571696, 3558.5907620623443, 3615.8553657853918, 3618.656227658368, 621.5897507645024, 625.6183727925961, 643.6266965160196, 646.2987658390605, 654.3979538824293, 724.8260417499762, 728.7522242437597, 749.1571981520789, 765.1201118713412, 779.9688012479551, 9120.498372589438, 9265.166135047879, 9340.953295233481, 9484.620615175454, 9523.619055237852, 637.3053371824733, 644.7421031587403, 734.8897665350133, 742.2688651678093, 772.2702046566053, 4466.173757854807, 4688.253513704309, 4691.812327506861, 4705.294205869079, 4818.132736107535, 65549.6722516394, 69894.0, 69895.30104698888, 69912.65043674748, 70187.0, 61068.0, 61499.0, 61858.0, 61899.69050154721, 62666.373336266966, 55602.443975560534, 55763.721181393834, 55838.44161558414, 56149.43850561524, 56258.43741562532, 9025.0, 9066.456012639263, 9154.359194856295, 9169.35814492979, 9234.26125909939, 36133.27733445369, 36551.26897462089, 36748.63251367559, 36821.63178368182, 36928.630713693594, 49400.75299623479, 49522.25716614326, 49866.75066624644, 50407.747961261426, 51136.96851510113, 12544.0, 12659.683507912376, 12746.171498852545, 12817.807732883828, 13230.140040897311, 13790.517331893336, 14135.717285654435, 14142.717145656823, 14447.927760361132, 14830.703385932437, 13072.193573978655, 13482.93258533701, 13706.451741930212, 13819.0, 13881.0, 12926.0, 13186.868131318948, 13437.395317210945, 13461.663458413226, 13507.797383039066, 12853.357332133543, 13225.0, 13235.073544851768, 13689.293939919186, 13810.516631917835, 10783.892161078602, 10806.513706883366, 10941.56233750641, 11206.103511719206, 11208.159388046091, 10474.790504189721, 10872.0, 10926.47484455621, 11059.447027648424, 11142.220044597125], "value": 6978.218119117719, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 114.0, 112.0, 111.0, 109.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 151.0, 173.0, 126.0, 161.0, 153.0, 125.0, 181.0, 126.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 161.0, 163.0, 161.0, 165.0, 164.0, 163.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 152.0, 74.0, 74.0, 76.0, 77.0, 176.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 154.0, 82.0, 83.0, 82.0, 137.0, 82.0, 82.0, 146.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 122.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 55.0, 56.0, 55.0, 58.0, 56.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 61.0, 61.0, 60.0, 60.0, 69.0, 60.0, 60.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 83.0, 84.0, 80.0, 81.0, 84.0, 82.0, 115.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 122.0, 125.0, 139.0, 133.0, 130.0, 125.0, 129.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 160.0, 164.0, 160.0, 168.0, 159.0, 160.0, 161.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 65.0, 63.0, 62.0, 67.0, 61.0, 67.0, 62.0, 62.0], "value": 63.6, "unit": "score"}]}]} 03:28:42 INFO - Return code: 0 03:28:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:28:42 ERROR - # TBPL SUCCESS # 03:28:42 INFO - Running post-action listener: _resource_record_post_action 03:28:42 INFO - ##### 03:28:42 INFO - ##### Finished run-tests step (success) 03:28:42 INFO - ##### 03:28:42 INFO - Running post-run listener: _resource_record_post_run 03:28:42 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 12288; Write bytes: 544780288; Read time: 484; Write time: 681432 03:28:42 INFO - TinderboxPrint: CPU usage
13.5% 03:28:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 484 03:28:42 INFO - TinderboxPrint: I/O write bytes / time
544,780,288 / 681,432 03:28:42 INFO - TinderboxPrint: CPU idle
8,218.7 (86.5%) 03:28:42 INFO - TinderboxPrint: CPU user
1,225.3 (12.9%) 03:28:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:28:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 254803968; Read time: 228; Write time: 329552 03:28:43 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289976320; Read time: 256; Write time: 351880 03:28:43 INFO - Running post-run listener: _upload_blobber_files 03:28:43 INFO - Blob upload gear active. 03:28:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:43 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 03:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:28:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:28:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:44 INFO - (blobuploader) - INFO - Done attempting. 03:28:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:28:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:45 INFO - (blobuploader) - INFO - Done attempting. 03:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:49 INFO - (blobuploader) - INFO - Done attempting. 03:28:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:49 INFO - Return code: 0 03:28:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd3839ab469c9f6a974eec46f863c4f89e9b5594142a1d9385f6697023e319802d06ae01895c42bfed24e1d8b769749ceef2134d4a607776ef88eb0810c829a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd0ae6f4bf3ea1dcc67d4ab8c5e1eba366c857bfeade9004e59c3344be5b43e8ea0f457d4a79b1179114b65a8fe4b9ffbb019476b749dc69ddf457980046584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8cdb57d9308776c356f22706b9f6d8f1eac1eaff7e3925861c9d222ce3d35459cac37933576172ec9b9a582ba63eac53b288c67f93a28a9b1c309925310097"} 03:28:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:49 INFO - Contents: 03:28:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd3839ab469c9f6a974eec46f863c4f89e9b5594142a1d9385f6697023e319802d06ae01895c42bfed24e1d8b769749ceef2134d4a607776ef88eb0810c829a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd0ae6f4bf3ea1dcc67d4ab8c5e1eba366c857bfeade9004e59c3344be5b43e8ea0f457d4a79b1179114b65a8fe4b9ffbb019476b749dc69ddf457980046584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8cdb57d9308776c356f22706b9f6d8f1eac1eaff7e3925861c9d222ce3d35459cac37933576172ec9b9a582ba63eac53b288c67f93a28a9b1c309925310097"} 03:28:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:49 INFO - Copying logs to upload dir... 03:28:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.361320 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-01 03:28:48.666641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 03:28:48.669930) ========= 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=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 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/Mozilla-Inbound/sha512/cd3839ab469c9f6a974eec46f863c4f89e9b5594142a1d9385f6697023e319802d06ae01895c42bfed24e1d8b769749ceef2134d4a607776ef88eb0810c829a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd0ae6f4bf3ea1dcc67d4ab8c5e1eba366c857bfeade9004e59c3344be5b43e8ea0f457d4a79b1179114b65a8fe4b9ffbb019476b749dc69ddf457980046584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8cdb57d9308776c356f22706b9f6d8f1eac1eaff7e3925861c9d222ce3d35459cac37933576172ec9b9a582ba63eac53b288c67f93a28a9b1c309925310097"} build_url:https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/ULxNMRFPRwCBNigiFjpwrg/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/Mozilla-Inbound/sha512/cd3839ab469c9f6a974eec46f863c4f89e9b5594142a1d9385f6697023e319802d06ae01895c42bfed24e1d8b769749ceef2134d4a607776ef88eb0810c829a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd0ae6f4bf3ea1dcc67d4ab8c5e1eba366c857bfeade9004e59c3344be5b43e8ea0f457d4a79b1179114b65a8fe4b9ffbb019476b749dc69ddf457980046584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8cdb57d9308776c356f22706b9f6d8f1eac1eaff7e3925861c9d222ce3d35459cac37933576172ec9b9a582ba63eac53b288c67f93a28a9b1c309925310097"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 03:28:48.695648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:28:48.696044) ========= 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=920470bf432669ad7e3a5387000001ca-1464775694.663654-149480709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:28:48.779677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 03:28:48.780007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 03:28:48.780337) ========= ========= Total master_lag: 0.16 =========