builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1464585017.95 results: success (0) buildid: 20160529193348 builduid: b00a09912229482e9e09c5bb41a26714 revision: 0f2f4ea1472c3ec67476ba55cba2ce1868284657 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:17.950783) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:17.951269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:17.951620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.058672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.059177) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 22:10:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.1M=0s 2016-05-29 22:10:18 (90.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175045 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.283445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.283840) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.338907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:18.339368) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0f2f4ea1472c3ec67476ba55cba2ce1868284657 --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 0f2f4ea1472c3ec67476ba55cba2ce1868284657 --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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 22:10:18,396 truncating revision to first 12 chars 2016-05-29 22:10:18,396 Setting DEBUG logging. 2016-05-29 22:10:18,396 attempt 1/10 2016-05-29 22:10:18,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0f2f4ea1472c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 22:10:18,701 unpacking tar archive at: mozilla-inbound-0f2f4ea1472c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:19.002347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:19.002733) ========= script_repo_revision: 0f2f4ea1472c3ec67476ba55cba2ce1868284657 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:19.003226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:19.003584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 22:10:19.014573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-29 22:10:19.014908) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:10:19 INFO - MultiFileLogger online at 20160529 22:10:19 in /builds/slave/test 22:10:19 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 22:10:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:10:19 INFO - {'append_to_log': False, 22:10:19 INFO - 'base_work_dir': '/builds/slave/test', 22:10:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:10:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:10:19 INFO - 'branch': 'Mozilla-Inbound', 22:10:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:10:19 INFO - 'config_files': ('talos/linux_config.py',), 22:10:19 INFO - 'default_actions': ('clobber', 22:10:19 INFO - 'read-buildbot-config', 22:10:19 INFO - 'download-and-extract', 22:10:19 INFO - 'populate-webroot', 22:10:19 INFO - 'create-virtualenv', 22:10:19 INFO - 'install', 22:10:19 INFO - 'run-tests'), 22:10:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:10:19 INFO - 'download_minidump_stackwalk': True, 22:10:19 INFO - 'download_symbols': 'ondemand', 22:10:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:10:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:10:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:10:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:10:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:10:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:10:19 INFO - 'installer_path': 'installer.exe', 22:10:19 INFO - 'log_level': 'info', 22:10:19 INFO - 'log_name': 'talos', 22:10:19 INFO - 'log_to_console': True, 22:10:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:10:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:10:19 INFO - 'opt_config_files': (), 22:10:19 INFO - 'pip_index': False, 22:10:19 INFO - 'sps_profile': False, 22:10:19 INFO - 'sps_profile_interval': 0, 22:10:19 INFO - 'suite': 'dromaeojs-e10s', 22:10:19 INFO - 'system_bits': '32', 22:10:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:10:19 INFO - 'title': 'talos-linux64-ix-022', 22:10:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:10:19 INFO - 'use_talos_json': True, 22:10:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:10:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:10:19 INFO - 'work_dir': 'build'} 22:10:19 INFO - ##### 22:10:19 INFO - ##### Running clobber step. 22:10:19 INFO - ##### 22:10:19 INFO - Running pre-action listener: _resource_record_pre_action 22:10:19 INFO - Running main action method: clobber 22:10:19 INFO - rmtree: /builds/slave/test/build 22:10:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:10:20 INFO - Running post-action listener: _resource_record_post_action 22:10:20 INFO - ##### 22:10:20 INFO - ##### Finished clobber step (success) 22:10:20 INFO - ##### 22:10:20 INFO - ##### 22:10:20 INFO - ##### Running read-buildbot-config step. 22:10:20 INFO - ##### 22:10:20 INFO - Running pre-action listener: _resource_record_pre_action 22:10:20 INFO - Running main action method: read_buildbot_config 22:10:20 INFO - Using buildbot properties: 22:10:20 INFO - { 22:10:20 INFO - "project": "", 22:10:20 INFO - "product": "firefox", 22:10:20 INFO - "script_repo_revision": "production", 22:10:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:10:20 INFO - "repository": "", 22:10:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:10:20 INFO - "buildid": "20160529193348", 22:10:20 INFO - "pgo_build": "True", 22:10:20 INFO - "basedir": "/builds/slave/test", 22:10:20 INFO - "buildnumber": 630, 22:10:20 INFO - "slavename": "talos-linux64-ix-022", 22:10:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:10:20 INFO - "platform": "ubuntu64_hw", 22:10:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:10:20 INFO - "branch": "mozilla-inbound", 22:10:20 INFO - "repo_path": "integration/mozilla-inbound", 22:10:20 INFO - "revision": "0f2f4ea1472c3ec67476ba55cba2ce1868284657", 22:10:20 INFO - "stage_platform": "linux64-pgo", 22:10:20 INFO - "builduid": "b00a09912229482e9e09c5bb41a26714", 22:10:20 INFO - "slavebuilddir": "test" 22:10:20 INFO - } 22:10:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:10:20 INFO - Running post-action listener: _resource_record_post_action 22:10:20 INFO - ##### 22:10:20 INFO - ##### Finished read-buildbot-config step (success) 22:10:20 INFO - ##### 22:10:20 INFO - ##### 22:10:20 INFO - ##### Running download-and-extract step. 22:10:20 INFO - ##### 22:10:20 INFO - Running pre-action listener: _resource_record_pre_action 22:10:20 INFO - Running main action method: download_and_extract 22:10:20 INFO - mkdir: /builds/slave/test/build/tests 22:10: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')]} 22:10:20 INFO - https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:10:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:36 INFO - Downloaded 1361 bytes. 22:10:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:36 INFO - Using the following test package requirements: 22:10:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:10:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:10:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'jsshell-linux-x86_64.zip'], 22:10:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:10:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:10:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:10:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:10:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:10:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:10:36 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')]} 22:10:36 INFO - https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:41 INFO - Downloaded 24409997 bytes. 22:10:41 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'] 22:10:41 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 22:10:42 INFO - Return code: 0 22:10:42 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 22:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:42 INFO - https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:52 INFO - Downloaded 24409997 bytes. 22:10:52 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'] 22:10:52 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 22:10:53 INFO - Return code: 0 22:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:53 INFO - https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:54 INFO - Downloaded 10834055 bytes. 22:10:54 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'] 22:10:54 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 22:10:54 INFO - Return code: 0 22:10:54 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')]} 22:10:54 INFO - https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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 22:10:56 INFO - Downloaded 58864411 bytes. 22:10:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:10:56 INFO - mkdir: /builds/slave/test/properties 22:10:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:10:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:10:56 INFO - Contents: 22:10:56 INFO - build_url:https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:10:56 INFO - Running post-action listener: _resource_record_post_action 22:10:56 INFO - Running post-action listener: set_extra_try_arguments 22:10:56 INFO - ##### 22:10:56 INFO - ##### Finished download-and-extract step (success) 22:10:56 INFO - ##### 22:10:56 INFO - ##### 22:10:56 INFO - ##### Running populate-webroot step. 22:10:56 INFO - ##### 22:10:56 INFO - Running pre-action listener: _resource_record_pre_action 22:10:56 INFO - Running main action method: populate_webroot 22:10:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:10:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:10:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:10:56 INFO - '--tppagecycles', 22:10:56 INFO - '7'], 22:10:56 INFO - 'tests': ['tsvgm']}}, 22:10:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:10:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:10:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:10:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:10:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['damp', 'tps']}, 22:10:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'tests': ['damp', 'tps']}, 22:10:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['dromaeo_dom']}, 22:10:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:10:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'other-e10s': {'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['a11yr', 22:10:56 INFO - 'ts_paint', 22:10:56 INFO - 'tpaint', 22:10:56 INFO - 'sessionrestore', 22:10:56 INFO - 'sessionrestore_no_auto_restore', 22:10:56 INFO - 'tabpaint']}, 22:10:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['tsvgx', 22:10:56 INFO - 'tsvgr_opacity', 22:10:56 INFO - 'tart', 22:10:56 INFO - 'tscrollx', 22:10:56 INFO - 'cart']}, 22:10:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:10:56 INFO - 'tsvgr_opacity', 22:10:56 INFO - 'tart', 22:10:56 INFO - 'tscrollx', 22:10:56 INFO - 'cart']}, 22:10:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'talos_options': ['--disable-e10s'], 22:10:56 INFO - 'tests': ['tp5o']}, 22:10:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'tests': ['tp5o']}, 22:10:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'talos_options': ['--disable-e10s', 22:10:56 INFO - '--xperf_path', 22:10:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:56 INFO - 'tests': ['tp5n']}, 22:10:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:56 INFO - 'talos_options': ['--xperf_path', 22:10:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:56 INFO - 'tests': ['tp5n']}}, 22:10:56 INFO - 'talos.zip': {'path': '', 22:10:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:10:56 INFO - Running post-action listener: _resource_record_post_action 22:10:56 INFO - ##### 22:10:56 INFO - ##### Finished populate-webroot step (success) 22:10:56 INFO - ##### 22:10:56 INFO - ##### 22:10:56 INFO - ##### Running create-virtualenv step. 22:10:56 INFO - ##### 22:10:56 INFO - Running pre-action listener: _resource_record_pre_action 22:10:56 INFO - Running main action method: create_virtualenv 22:10:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:10:56 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 22:10:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:10:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:10:57 INFO - Using real prefix '/usr' 22:10:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:10:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:10:59 INFO - Installing pip.................done. 22:10:59 INFO - Return code: 0 22:10:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:59 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:10:59 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 22:10:59 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 22:10:59 INFO - Using env: {'DISPLAY': ':0', 22:10:59 INFO - 'HOME': '/home/cltbld', 22:10:59 INFO - 'LANG': 'en_US.UTF-8', 22:10:59 INFO - 'LANGUAGE': 'en_US:en', 22:10:59 INFO - 'LOGNAME': 'cltbld', 22:10:59 INFO - 'MAIL': '/var/mail/cltbld', 22:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:59 INFO - 'MOZ_NO_REMOTE': '1', 22:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:59 INFO - 'NO_EM_RESTART': '1', 22:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:59 INFO - 'PWD': '/builds/slave/test', 22:10:59 INFO - 'SHELL': '/bin/bash', 22:10:59 INFO - 'SHLVL': '1', 22:10:59 INFO - 'TERM': 'linux', 22:10:59 INFO - 'TMOUT': '86400', 22:10:59 INFO - 'USER': 'cltbld', 22:10:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:59 INFO - '_': '/tools/buildbot/bin/python'} 22:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:00 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 22:11:00 INFO - Cleaning up... 22:11:00 INFO - Return code: 0 22:11:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:11:00 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')]} 22:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 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')]} 22:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:00 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:00 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 22:11:00 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 22:11:00 INFO - Using env: {'DISPLAY': ':0', 22:11:00 INFO - 'HOME': '/home/cltbld', 22:11:00 INFO - 'LANG': 'en_US.UTF-8', 22:11:00 INFO - 'LANGUAGE': 'en_US:en', 22:11:00 INFO - 'LOGNAME': 'cltbld', 22:11:00 INFO - 'MAIL': '/var/mail/cltbld', 22:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:00 INFO - 'MOZ_NO_REMOTE': '1', 22:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:00 INFO - 'NO_EM_RESTART': '1', 22:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:00 INFO - 'PWD': '/builds/slave/test', 22:11:00 INFO - 'SHELL': '/bin/bash', 22:11:00 INFO - 'SHLVL': '1', 22:11:00 INFO - 'TERM': 'linux', 22:11:00 INFO - 'TMOUT': '86400', 22:11:00 INFO - 'USER': 'cltbld', 22:11:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:00 INFO - '_': '/tools/buildbot/bin/python'} 22:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:00 INFO - Downloading/unpacking psutil>=3.1.1 22:11:00 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 22:11:00 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 22:11:00 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 22:11:00 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 22:11:00 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 22:11:00 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 22:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:02 INFO - Installing collected packages: psutil 22:11:02 INFO - Running setup.py install for psutil 22:11:02 INFO - building 'psutil._psutil_linux' extension 22:11:02 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 22:11:03 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 22:11:03 INFO - building 'psutil._psutil_posix' extension 22:11:03 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 22:11:04 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 22:11:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:04 INFO - Successfully installed psutil 22:11:04 INFO - Cleaning up... 22:11:04 INFO - Return code: 0 22:11:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:11:04 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')]} 22:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:04 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')]} 22:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:04 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:04 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 22:11:04 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 22:11:04 INFO - Using env: {'DISPLAY': ':0', 22:11:04 INFO - 'HOME': '/home/cltbld', 22:11:04 INFO - 'LANG': 'en_US.UTF-8', 22:11:04 INFO - 'LANGUAGE': 'en_US:en', 22:11:04 INFO - 'LOGNAME': 'cltbld', 22:11:04 INFO - 'MAIL': '/var/mail/cltbld', 22:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:04 INFO - 'MOZ_NO_REMOTE': '1', 22:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:04 INFO - 'NO_EM_RESTART': '1', 22:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:04 INFO - 'PWD': '/builds/slave/test', 22:11:04 INFO - 'SHELL': '/bin/bash', 22:11:04 INFO - 'SHLVL': '1', 22:11:04 INFO - 'TERM': 'linux', 22:11:04 INFO - 'TMOUT': '86400', 22:11:04 INFO - 'USER': 'cltbld', 22:11:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:04 INFO - '_': '/tools/buildbot/bin/python'} 22:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:11:06 INFO - Installing collected packages: mozsystemmonitor 22:11:06 INFO - Running setup.py install for mozsystemmonitor 22:11:06 INFO - Successfully installed mozsystemmonitor 22:11:06 INFO - Cleaning up... 22:11:06 INFO - Return code: 0 22:11:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:11:06 INFO - Using env: {'DISPLAY': ':0', 22:11:06 INFO - 'HOME': '/home/cltbld', 22:11:06 INFO - 'LANG': 'en_US.UTF-8', 22:11:06 INFO - 'LANGUAGE': 'en_US:en', 22:11:06 INFO - 'LOGNAME': 'cltbld', 22:11:06 INFO - 'MAIL': '/var/mail/cltbld', 22:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:06 INFO - 'MOZ_NO_REMOTE': '1', 22:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:06 INFO - 'NO_EM_RESTART': '1', 22:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:06 INFO - 'PWD': '/builds/slave/test', 22:11:06 INFO - 'SHELL': '/bin/bash', 22:11:06 INFO - 'SHLVL': '1', 22:11:06 INFO - 'TERM': 'linux', 22:11:06 INFO - 'TMOUT': '86400', 22:11:06 INFO - 'USER': 'cltbld', 22:11:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:06 INFO - '_': '/tools/buildbot/bin/python'} 22:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:07 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:09 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:11:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:09 INFO - Downloading docopt-0.6.1.tar.gz 22:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:09 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:09 INFO - Running setup.py install for blobuploader 22:11:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:11:09 INFO - Running setup.py install for requests 22:11:10 INFO - Running setup.py install for docopt 22:11:10 INFO - Successfully installed blobuploader requests docopt 22:11:10 INFO - Cleaning up... 22:11:10 INFO - Return code: 0 22:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:10 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:10 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 22:11:10 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 22:11:10 INFO - Using env: {'DISPLAY': ':0', 22:11:10 INFO - 'HOME': '/home/cltbld', 22:11:10 INFO - 'LANG': 'en_US.UTF-8', 22:11:10 INFO - 'LANGUAGE': 'en_US:en', 22:11:10 INFO - 'LOGNAME': 'cltbld', 22:11:10 INFO - 'MAIL': '/var/mail/cltbld', 22:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:10 INFO - 'MOZ_NO_REMOTE': '1', 22:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:10 INFO - 'NO_EM_RESTART': '1', 22:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:10 INFO - 'PWD': '/builds/slave/test', 22:11:10 INFO - 'SHELL': '/bin/bash', 22:11:10 INFO - 'SHLVL': '1', 22:11:10 INFO - 'TERM': 'linux', 22:11:10 INFO - 'TMOUT': '86400', 22:11:10 INFO - 'USER': 'cltbld', 22:11:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:10 INFO - '_': '/tools/buildbot/bin/python'} 22:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:10 INFO - Running setup.py (path:/tmp/pip-sr0Gdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:10 INFO - Running setup.py (path:/tmp/pip-4pMG78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:10 INFO - Running setup.py (path:/tmp/pip-tN6RQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:10 INFO - Running setup.py (path:/tmp/pip-kIXhC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:10 INFO - Running setup.py (path:/tmp/pip-I6nJBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:10 INFO - Running setup.py (path:/tmp/pip-LWdCUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:11 INFO - Running setup.py (path:/tmp/pip-Kjr3sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:11 INFO - Running setup.py (path:/tmp/pip-N7IVt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:11 INFO - Running setup.py (path:/tmp/pip-LCnAUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:11 INFO - Running setup.py (path:/tmp/pip-c8nVmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:11 INFO - Running setup.py (path:/tmp/pip-Ku9qbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:11 INFO - Running setup.py (path:/tmp/pip-3UA8DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:11 INFO - Running setup.py (path:/tmp/pip-BK2KkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:11 INFO - Running setup.py (path:/tmp/pip-Ni8EFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:11 INFO - Running setup.py (path:/tmp/pip-m7AdD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:11 INFO - Running setup.py (path:/tmp/pip-foFng6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:11 INFO - Running setup.py (path:/tmp/pip-CkeUI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:11 INFO - Running setup.py install for manifestparser 22:11:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:11:11 INFO - Running setup.py install for mozcrash 22:11:12 INFO - Running setup.py install for mozdebug 22:11:12 INFO - Running setup.py install for mozdevice 22:11:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for mozfile 22:11:12 INFO - Running setup.py install for mozhttpd 22:11:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for mozinfo 22:11:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for mozInstall 22:11:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for mozleak 22:11:12 INFO - Running setup.py install for mozlog 22:11:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for moznetwork 22:11:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:11:12 INFO - Running setup.py install for mozprocess 22:11:13 INFO - Running setup.py install for mozprofile 22:11:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:11:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:11:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:11:13 INFO - Running setup.py install for mozrunner 22:11:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:11:13 INFO - Running setup.py install for mozscreenshot 22:11:13 INFO - Running setup.py install for moztest 22:11:13 INFO - Running setup.py install for mozversion 22:11:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:11:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:13 INFO - Cleaning up... 22:11:13 INFO - Return code: 0 22:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:13 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:13 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 22:11:13 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 22:11:13 INFO - Using env: {'DISPLAY': ':0', 22:11:13 INFO - 'HOME': '/home/cltbld', 22:11:13 INFO - 'LANG': 'en_US.UTF-8', 22:11:13 INFO - 'LANGUAGE': 'en_US:en', 22:11:13 INFO - 'LOGNAME': 'cltbld', 22:11:13 INFO - 'MAIL': '/var/mail/cltbld', 22:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:13 INFO - 'MOZ_NO_REMOTE': '1', 22:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:13 INFO - 'NO_EM_RESTART': '1', 22:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:13 INFO - 'PWD': '/builds/slave/test', 22:11:13 INFO - 'SHELL': '/bin/bash', 22:11:13 INFO - 'SHLVL': '1', 22:11:13 INFO - 'TERM': 'linux', 22:11:13 INFO - 'TMOUT': '86400', 22:11:13 INFO - 'USER': 'cltbld', 22:11:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:13 INFO - '_': '/tools/buildbot/bin/python'} 22:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:13 INFO - Running setup.py (path:/tmp/pip-hkJIQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:13 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)) 22:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:13 INFO - Running setup.py (path:/tmp/pip-Cl9Imx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:14 INFO - Running setup.py (path:/tmp/pip-kOrAE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:14 INFO - Running setup.py (path:/tmp/pip-NcCwEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:14 INFO - Running setup.py (path:/tmp/pip-xte_Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:14 INFO - Running setup.py (path:/tmp/pip-OypzhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:14 INFO - Running setup.py (path:/tmp/pip-xht7SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:14 INFO - Running setup.py (path:/tmp/pip-UKmbyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:14 INFO - Running setup.py (path:/tmp/pip-SA2Kjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:14 INFO - Running setup.py (path:/tmp/pip-hNC9fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:14 INFO - Running setup.py (path:/tmp/pip-NkXTgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:14 INFO - Running setup.py (path:/tmp/pip-J3h9yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:14 INFO - Running setup.py (path:/tmp/pip-bpVmur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:14 INFO - Running setup.py (path:/tmp/pip-xbNLuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:14 INFO - Running setup.py (path:/tmp/pip-L3oge6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:14 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)) 22:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:14 INFO - Running setup.py (path:/tmp/pip-Y7Tc0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:15 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)) 22:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:15 INFO - Running setup.py (path:/tmp/pip-o3uPCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:15 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)) 22:11:15 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)) 22:11:15 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)) 22:11:15 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)) 22:11:15 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)) 22:11:15 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)) 22:11:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:11:15 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 22:11:15 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 22:11:15 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 22:11:15 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 22:11:15 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 22:11:15 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 22:11:16 INFO - Downloading blessings-1.6.tar.gz 22:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:17 INFO - Installing collected packages: blessings 22:11:17 INFO - Running setup.py install for blessings 22:11:17 INFO - Successfully installed blessings 22:11:17 INFO - Cleaning up... 22:11:17 INFO - Return code: 0 22:11:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:17 INFO - Reading from file tmpfile_stdout 22:11:17 INFO - Current package versions: 22:11:17 INFO - argparse == 1.2.1 22:11:17 INFO - blessings == 1.6 22:11:17 INFO - blobuploader == 1.2.4 22:11:17 INFO - docopt == 0.6.1 22:11:17 INFO - manifestparser == 1.1 22:11:17 INFO - mozInstall == 1.12 22:11:17 INFO - mozcrash == 0.17 22:11:17 INFO - mozdebug == 0.1 22:11:17 INFO - mozdevice == 0.48 22:11:17 INFO - mozfile == 1.2 22:11:17 INFO - mozhttpd == 0.7 22:11:17 INFO - mozinfo == 0.9 22:11:17 INFO - mozleak == 0.1 22:11:17 INFO - mozlog == 3.2 22:11:17 INFO - moznetwork == 0.27 22:11:17 INFO - mozprocess == 0.22 22:11:17 INFO - mozprofile == 0.28 22:11:17 INFO - mozrunner == 6.11 22:11:17 INFO - mozscreenshot == 0.1 22:11:17 INFO - mozsystemmonitor == 0.3 22:11:17 INFO - moztest == 0.7 22:11:17 INFO - mozversion == 1.4 22:11:17 INFO - psutil == 3.1.1 22:11:17 INFO - requests == 1.2.3 22:11:17 INFO - wsgiref == 0.1.2 22:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11: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')]} 22:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:17 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:17 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 22:11:17 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 22:11:17 INFO - Using env: {'DISPLAY': ':0', 22:11:17 INFO - 'HOME': '/home/cltbld', 22:11:17 INFO - 'LANG': 'en_US.UTF-8', 22:11:17 INFO - 'LANGUAGE': 'en_US:en', 22:11:17 INFO - 'LOGNAME': 'cltbld', 22:11:17 INFO - 'MAIL': '/var/mail/cltbld', 22:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:17 INFO - 'MOZ_NO_REMOTE': '1', 22:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:17 INFO - 'NO_EM_RESTART': '1', 22:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:17 INFO - 'PWD': '/builds/slave/test', 22:11:17 INFO - 'SHELL': '/bin/bash', 22:11:17 INFO - 'SHLVL': '1', 22:11:17 INFO - 'TERM': 'linux', 22:11:17 INFO - 'TMOUT': '86400', 22:11:17 INFO - 'USER': 'cltbld', 22:11:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:17 INFO - '_': '/tools/buildbot/bin/python'} 22:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 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)) 22:11:17 INFO - Cleaning up... 22:11:17 INFO - Return code: 0 22:11:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:11: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')]} 22:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:17 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:17 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 22:11:17 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 22:11:17 INFO - Using env: {'DISPLAY': ':0', 22:11:17 INFO - 'HOME': '/home/cltbld', 22:11:17 INFO - 'LANG': 'en_US.UTF-8', 22:11:17 INFO - 'LANGUAGE': 'en_US:en', 22:11:17 INFO - 'LOGNAME': 'cltbld', 22:11:17 INFO - 'MAIL': '/var/mail/cltbld', 22:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:17 INFO - 'MOZ_NO_REMOTE': '1', 22:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:17 INFO - 'NO_EM_RESTART': '1', 22:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:17 INFO - 'PWD': '/builds/slave/test', 22:11:17 INFO - 'SHELL': '/bin/bash', 22:11:17 INFO - 'SHLVL': '1', 22:11:17 INFO - 'TERM': 'linux', 22:11:17 INFO - 'TMOUT': '86400', 22:11:17 INFO - 'USER': 'cltbld', 22:11:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:17 INFO - '_': '/tools/buildbot/bin/python'} 22:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:17 INFO - Downloading/unpacking jsonschema 22:11:17 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 22:11:17 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 22:11:17 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 22:11:17 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 22:11:17 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 22:11:17 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 22:11:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:11:19 INFO - Downloading/unpacking functools32 (from jsonschema) 22:11:19 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 22:11:19 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 22:11:19 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 22:11:19 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 22:11:19 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 22:11:19 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 22:11:20 INFO - Downloading functools32-3.2.3-2.tar.gz 22:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:11:20 INFO - warning: no files found matching '*.txt' 22:11:20 INFO - no previously-included directories found matching 'build' 22:11:20 INFO - no previously-included directories found matching 'dist' 22:11:20 INFO - no previously-included directories found matching '.git*' 22:11:20 INFO - Installing collected packages: jsonschema, functools32 22:11:20 INFO - Running setup.py install for functools32 22:11:20 INFO - warning: no files found matching '*.txt' 22:11:20 INFO - no previously-included directories found matching 'build' 22:11:20 INFO - no previously-included directories found matching 'dist' 22:11:20 INFO - no previously-included directories found matching '.git*' 22:11:20 INFO - Successfully installed jsonschema functools32 22:11:20 INFO - Cleaning up... 22:11:20 INFO - Return code: 0 22:11:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:11: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')]} 22:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:20 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 0x7f99775bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1918770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', '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 22:11:20 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 22:11:20 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 22:11:20 INFO - Using env: {'DISPLAY': ':0', 22:11:20 INFO - 'HOME': '/home/cltbld', 22:11:20 INFO - 'LANG': 'en_US.UTF-8', 22:11:20 INFO - 'LANGUAGE': 'en_US:en', 22:11:20 INFO - 'LOGNAME': 'cltbld', 22:11:20 INFO - 'MAIL': '/var/mail/cltbld', 22:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:20 INFO - 'MOZ_NO_REMOTE': '1', 22:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:20 INFO - 'NO_EM_RESTART': '1', 22:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:20 INFO - 'PWD': '/builds/slave/test', 22:11:20 INFO - 'SHELL': '/bin/bash', 22:11:20 INFO - 'SHLVL': '1', 22:11:20 INFO - 'TERM': 'linux', 22:11:20 INFO - 'TMOUT': '86400', 22:11:20 INFO - 'USER': 'cltbld', 22:11:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:20 INFO - '_': '/tools/buildbot/bin/python'} 22:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:20 INFO - Downloading/unpacking flake8 22:11:20 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 22:11:20 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 22:11:20 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 22:11:20 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 22:11:20 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 22:11:20 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 22:11:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:11:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:11:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:23 INFO - no previously-included directories found matching 'docs/_build' 22:11:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:11:23 INFO - Running setup.py install for pep8 22:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:23 INFO - no previously-included directories found matching 'docs/_build' 22:11:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:11:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:11:23 INFO - Cleaning up... 22:11:23 INFO - Return code: 0 22:11:23 INFO - Running post-action listener: _resource_record_post_action 22:11:23 INFO - Running post-action listener: _start_resource_monitoring 22:11:23 INFO - Starting resource monitoring. 22:11:23 INFO - ##### 22:11:23 INFO - ##### Finished create-virtualenv step (success) 22:11:23 INFO - ##### 22:11:23 INFO - ##### 22:11:23 INFO - ##### Running install step. 22:11:23 INFO - ##### 22:11:23 INFO - Running pre-action listener: _resource_record_pre_action 22:11:23 INFO - Running main action method: install 22:11:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:11:23 INFO - Reading from file tmpfile_stdout 22:11:23 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:11:23 INFO - Reading from file tmpfile_stdout 22:11:23 INFO - Output received: 22:11:23 INFO - Usage: mozinstall [options] installer 22:11:23 INFO - Options: 22:11:23 INFO - -h, --help show this help message and exit 22:11:23 INFO - -d DEST, --destination=DEST 22:11:23 INFO - Directory to install application into. [default: 22:11:23 INFO - "/builds/slave/test"] 22:11:23 INFO - --app=APP Application being installed. [default: firefox] 22:11:23 INFO - mkdir: /builds/slave/test/build/application 22:11:23 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'] 22:11:23 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 22:11:40 INFO - Reading from file tmpfile_stdout 22:11:40 INFO - Output received: 22:11:40 INFO - /builds/slave/test/build/application/firefox/firefox 22:11:40 INFO - Running post-action listener: _resource_record_post_action 22:11:40 INFO - ##### 22:11:40 INFO - ##### Finished install step (success) 22:11:40 INFO - ##### 22:11:40 INFO - ##### 22:11:40 INFO - ##### Running run-tests step. 22:11:40 INFO - ##### 22:11:40 INFO - Running pre-action listener: _resource_record_pre_action 22:11:40 INFO - Running main action method: run_tests 22:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:11:40 INFO - Python 2.7.3 22:11:40 INFO - Return code: 0 22:11:40 INFO - grabbing minidump binary from tooltool 22:11:40 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')]} 22:11:40 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 0x19a79c0>, '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 0x19a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:11:40 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 22:11:40 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 22:11:40 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 22:11:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:11:40 INFO - Return code: 0 22:11:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:11:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:11:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:11:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:11:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:11:41 INFO - Return code: 0 22:11:41 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/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 22:11:41 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/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 22:11:41 INFO - Using env: {'DISPLAY': ':0', 22:11:41 INFO - 'HOME': '/home/cltbld', 22:11:41 INFO - 'LANG': 'en_US.UTF-8', 22:11:41 INFO - 'LANGUAGE': 'en_US:en', 22:11:41 INFO - 'LOGNAME': 'cltbld', 22:11:41 INFO - 'MAIL': '/var/mail/cltbld', 22:11:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:11:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:41 INFO - 'MOZ_NO_REMOTE': '1', 22:11:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:41 INFO - 'NO_EM_RESTART': '1', 22:11:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:41 INFO - 'PWD': '/builds/slave/test', 22:11:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:11:41 INFO - 'SHELL': '/bin/bash', 22:11:41 INFO - 'SHLVL': '1', 22:11:41 INFO - 'TERM': 'linux', 22:11:41 INFO - 'TMOUT': '86400', 22:11:41 INFO - 'USER': 'cltbld', 22:11:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825', 22:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:41 INFO - '_': '/tools/buildbot/bin/python'} 22:11:41 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/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 22:11:42 INFO - mozversion application_buildid: 20160529193348 22:11:42 INFO - mozversion application_changeset: 0f2f4ea1472c3ec67476ba55cba2ce1868284657 22:11:42 INFO - mozversion application_display_name: Nightly 22:11:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:11:42 INFO - mozversion application_name: Firefox 22:11:42 INFO - mozversion application_remotingname: firefox 22:11:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:11:42 INFO - mozversion application_vendor: Mozilla 22:11:42 INFO - mozversion application_version: 49.0a1 22:11:42 INFO - mozversion platform_buildid: 20160529193348 22:11:42 INFO - mozversion platform_changeset: 0f2f4ea1472c3ec67476ba55cba2ce1868284657 22:11:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:11:42 INFO - mozversion platform_version: 49.0a1 22:11:42 INFO - using testdate: 1464585102 22:11:42 INFO - actual date: 1464585102 22:11:42 INFO - starting webserver on 'localhost:44702' 22:11:42 INFO - SUITE-START | Running 2 tests 22:11:42 INFO - TEST-START | dromaeo_css 22:11:42 INFO - operating with platform_type : linux_ 22:11:42 INFO - Initialising browser for dromaeo_css test... 22:11:42 INFO - TEST-INFO | started process 3279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjtYIa/profile http://localhost:44702/getInfo.html) 22:11:49 INFO - PROCESS | 3279 | __metrics Screen width/height:1600/1200 22:11:49 INFO - PROCESS | 3279 | colorDepth:24 22:11:49 INFO - PROCESS | 3279 | Browser inner width/height: 1024/697 22:11:49 INFO - PROCESS | 3279 | __metrics 22:11:50 ERROR - PROCESS | 3279 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:11:50 INFO - TEST-INFO | 3279: exit 0 22:11:50 INFO - Browser initialized. 22:11:50 INFO - Running cycle 1/1 for dromaeo_css test... 22:11:50 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjtYIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:02 INFO - PROCESS | 3401 | RSS: Main: 166793216 22:12:02 INFO - PROCESS | 3401 | 22:12:52 INFO - PROCESS | 3401 | 1464585172381 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] 22:14:59 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44702/tests/dromaeo/cssquery-ext.html) 22:15:00 INFO - PROCESS | 3401 | RSS: Main: 171339776 22:15:00 INFO - PROCESS | 3401 | 22:18:02 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-ext.html (next: http://localhost:44702/tests/dromaeo/cssquery-jquery.html) 22:18:03 INFO - PROCESS | 3401 | RSS: Main: 169570304 22:18:03 INFO - PROCESS | 3401 | 22:21:05 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44702/tests/dromaeo/cssquery-mootools.html) 22:21:06 INFO - PROCESS | 3401 | RSS: Main: 170926080 22:21:06 INFO - PROCESS | 3401 | 22:24:07 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44702/tests/dromaeo/cssquery-prototype.html) 22:24:08 INFO - PROCESS | 3401 | RSS: Main: 167555072 22:24:08 INFO - PROCESS | 3401 | 22:27:10 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44702/tests/dromaeo/cssquery-yui.html) 22:27:11 INFO - PROCESS | 3401 | RSS: Main: 168849408 22:27:11 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:44702/tests/dromaeo/cssquery-yui.html (next: http://localhost:44702/tests/dromaeo/cssquery-dojo.html) 22:30:14 INFO - PROCESS | 3401 | RSS: Main: 170835968 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | __start_tp_report 22:30:14 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 22:30:14 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 22:30:14 INFO - PROCESS | 3401 | |i|pagename|runs| 22:30:14 INFO - PROCESS | 3401 | |0;dojo.html;3090;3145.5596216529675;3175.603049618797;3187.7927934684258;3196.34474932639;5331.7334133293325;5392.325959255093;5407.05376559102;5469.179623056543;5490.039243132446;5217.791288348461;5279.736013199344;5308.177232528955;5322.467753224676;5387.0841956867325;4840.491748366415;4890.266460031006;4985.127602669537;5028.7988480460735;5069.923951140736;736.405654899694;4849.709017458946;4864.294677271793;4878.48775878533;4960.60315174787;4906.165951788204;4936.407631084293;4951.653384263085;4976.751162441881;4989.052080104769;4929.975350123263;4963.081829861451;4970.6520543561965;4995.975020124876;5016.097102521545;4877.463479017305;4882.902341953177;4922.114019476493;4943.851684449436;4968.950310496921;5329.413764485904;5345.5990800689715;5353.197020446964;5393.352797664266;5413.404525502192;5622.3253209614695;5842.503387212092;5850.590458667895;5854.414558544154;5858.062709966428;5697.31632204134;5734.598578099534;5770.798022069207;5779;5796.449337312949;5374.381946076173;5381.0583147948955;5396.892062158735;5400.810971615974;5412.188171774265;5833.416658334133;5900.822975310747;5925;5925.762969481259;5939.168516407706;5643.435656434323;5729.341125770589;5730.140478928194;5734.2258795062135;5770.221020162308;5664.971675141598;5719.113537401709;5719.113537401709;5741.913871291934;5743.8851222976145;5596.4123767003875;5735.8852822944145;5761.452661997104;5777.104548794943;5780.364159942403;5690.345610254791;5701.087825947829;5704.971475142681;5707.800226992035;5709.65742055478;4360.258756011485;4378.737275763465;4379.912401751947;4393.890152746207;4419.469663640384;3913.5303763547986;3955.3473676843573;3979.1047014421524;3984.641382275609;3987.1029018470613;5472.808451704172;5522.199281104217;5550.111982082847;5583.357913839879;5583.748731307101;5760.193572899798;5863.501602363847;5886.793962211302;5890.352061273256;5893.204417403681;5445.591580631469;5600.159976003632;5633.774649013993;5647.1529270609735;5660.886782264414;5048.268001139814;5085.262636917701;5094.490550944876;5121.129408000649;5128.820491282787;6069.969650151721;6107.633541987495;6112.358202388774;6116.48009919153;6128.63228206309;5618.85952851182;5803.535717142703;5828.504577110823;5836.620619659709;5883.794067207627;6054.878902422015;6055.576109672457;6082.422169893853;6089.056196289582;6110;5746.712664366849;5749.338826035059;5752.942470575241;5765.855853603525;5767.048437007847;5653.321601407857;5773.884522309614;5778.27771528559;5826.417358264309;5868.413158684098;5623.100303951348;5627.8593035174445;5687.601867869375;5690.487856092972;5698.401667824819;5527.198556209408;5615.634983726045;5651.773929042793;5659.151127330933;5668.149777533403;5554.97222513901;5582.106862902078;5605.943940560543;5612.242347283064;5612.831615051555;5703.600747947604;5715.2855893013375;5745.741441635053;5762;5763.020286551213;5392.757325920422;5603.439656034364;5609.990201763721;5614.691191984317;5643 22:30:14 INFO - PROCESS | 3401 | |1;ext.html;573.3549756523911;618.2025187508115;627.952903532235;644.9516286278529;658.0359772932659;38333.42499862501;41946;42057.7897110514;42104.36843447351;42147.78926105365;43312;43742.56257437425;44024.779876100576;44030.55969440305;44052.33921491172;8660.350473714449;8896.243819275369;8913.68802091927;8930.55347232639;8930.687425940094;8755.95622021889;8878.689245876396;8883.73348799537;8891.244244239248;8902.643894244222;8889.244414224799;8923.776905577348;8929.285657147446;8938.374313798036;8984.685536006242;8818.338624603148;8857.734267971971;8877.245434138105;8890.866637000483;8925.107489251088;8812.955935220347;8858.689945851864;8980.146886045815;8987.146221108984;8994.370394072417;40426.79786601078;40546.39180412296;40646.39030414546;40798.184036319406;40827;3032.9848350758325;3487.8779242726637;3532.2229109595846;3569.321828852536;3629.8548058077645;30227;30553;30580.388392232253;30636.234094147603;31039;4134.627883490501;4148.284191403986;4156.501219853607;4275.657947364203;4372.846950356722;302655;305458;305808;306048;306328.9999999978;31309.217269567987;31402;31426;31466.213344666565;31478.527822082688;35458.645413545535;35488;35633;35760.46359304612;35893.46159807605;15102.39590416393;15443.768343474856;15451.150186739613;15580.065196088271;15602.453914113179;12950.67623309406;12955;13005.739885202433;13048.608541743763;13096.476140954446;8180.386471014698;8185.263326300662;8206.917930820615;8267.173282671685;8302.626381812834;2882.322654176267;3059.1434398368046;3146.134812926418;3171.8731250750175;3201.871925122969;1003.8945910679273;1060;1142.4973011874915;1152.7175841918615;1211.6546784166471;32885.342293154004;33187.50218746721;33314.33371332608;33314.500282495785;33627.495587566205;1142.9257098288585;1152.6772503698978;1164.3072371938683;1174.3599738142732;1188.5127097889824;16665.666686666198;17261.223244954006;17380.3047878086;17391.47825565235;17504.387346442814;549999;553991;554543;580963;588373;58350.41649583535;59121.40878591245;59305;59390;59455.40544594585;1327.794191900257;1364.9522266720617;1372.3755691160497;1385.6051025457496;1395.4627468424526;30891.536626950165;32036.6796332043;32249.251143775316;32270.677293226767;32673.18317042093;51549.7422512885;51564.48435515597;51700.22449663333;52232.73883630557;52331;428463;429356;431630;431755;431935;27957;28082.85958570194;28182.43635127327;28512.714872851837;28862.711372886002;48713;48835;49352.50647493623;49464.752676236385;49780.25329619986;41605.37591936063;41643;42058.57941420669;42688.573114269704;42888;40142.799286003385;40474;40984.385234220914;41373.586264138175;41459;40384.59615403808;41865.58134418617;41899.371509426775;41982.58017419909;42184;35315.64684353226;37591.43612845864;37962.24075518419;37994.62005379911;38708.6129138705;28474.57288140721;28590.857045714638;28806.711932880404;29043.564346534396;29116.417671646872 22:30:14 INFO - PROCESS | 3401 | |2;jquery.html;364.3441804751447;379.6165872468807;383.21058619244366;390.68549817396996;409.2694540245662;18023.279068837248;18425.63148737026;18958.810411895895;19415.223391064377;19449.805501944975;10912.23614346996;11508.884911150886;11532.538698452052;11600.825987610193;11618.883811161886;4933.383327084114;5052.191649336107;5057.898842023157;5085.338905942241;5130.871728206806;5358.2498450217;5407.783688652449;5407.864348486803;5449.891002179954;5480.04099282626;5425.538829199523;5602.859928501779;5809.419058094178;5852.882942341151;5869.50109240715;5707.6575405475805;5776.682282474483;5811.360750317462;5815.476607105338;5845.181674565564;5291;5294.92057619136;5378.435264297271;5390.0836857734275;5393.541548968343;12455.93772031143;12612.55856045034;12791;13097.607071787766;13116.081874268804;2133.9359819205447;2178.074318414683;2188.9014994325294;2354.5243850773895;2457.533068716938;9832.803343933081;9836.704898853046;9861.753456163582;10067.093961543424;10073.949630251875;1892.0634286028367;1927;1930.9242564243355;1942.766867975852;2001.2495314257153;81003.5949820253;84205.57897210536;84344.57827710884;84618.57690711568;85093.57453212756;10704.946475267574;10981.780364392667;11032.944835275772;11092.778144437067;11172.273802202832;15340;15461.458848940232;15464.922675386551;15494.30275637599;15498.5350439487;8270.545120018456;8290.958545207235;8356.415050946496;8382;8488.618012189467;7902.841943161219;8035.513430015466;8045.23570260836;8130.512169269863;8221.465604735673;4094.160697057096;4476.888077798081;4628.352030715702;4742.881427964259;4823.397075365579;1918.1489862282963;1934.951626209328;1955.3058664174298;1961.686130219158;1981.2768339556246;953.5994882149514;1001.7345403468087;1005.939643621385;1013.4476710192963;1057.878648632452;17075.231614577373;19263.903680481508;19463;19550;19623.90188049079;998.6305067125065;1004.3772860826189;1017.5014243021014;1031.0926384781344;1079.7084787107437;8539.316854651737;10472.685819425276;10800.783984320427;10864.130869530418;10872.130229581615;467367;471941;476692;477022;482026;96385.51807241059;97887.51056244673;99334.5033274829;99632;100809.49595251976;952.2619969523674;960.8846938367441;981.1464026297025;985.1822986920838;1001.2590682894605;16324.591885202964;17258.741118882976;17272.581838542363;17540;17753.822461775217;43710.56289437065;43716.34425483684;43978;45304.09391812211;45462.31806522971;56766.432335676116;59087;60065;60771.39228607834;62666.68666656638;7680.500767450098;8597.95701021516;8600.698975535826;8920.286377089687;8955.41789783662;10571.312864663772;13086.08397412172;13151.342432878126;13503.257320847448;13865.168089914638;11416.828747568627;11515.884841151481;11713;11751.529938802352;12216.877831221575;11680.883191167979;11776;11870.525178992744;12006.459709313276;12061.336626485627;11423.828642570534;12034.518619255132;12102.334371609646;12217.633470995885;12321.383930803604;8662.913370866463;8698.347623928104;8817.470951742916;8833.072527384533;8867.64529418816;8894.644214231359;10944.343339399662;12072.577459788865;12190.75618487643;12244.204126731735 22:30:14 INFO - PROCESS | 3401 | |3;mootools.html;1476.0627001853823;1510.0637604685096;1652.2729998800528;1767.79670337911;1791.5431564950927;7988.560629165394;8648.221660050594;8743.650253989848;9270.953645231773;9275.211607013413;8909.242714369286;9102.408343457688;9171.312151588625;9181.357304988653;9207.171354578086;2317.050009496107;2392.425817803732;2394.174009966559;2395.9760402395927;2398.0767404549288;2303.5968705476557;2329.755375685554;2342.7422983471806;2348.201611452106;2362.9291121266388;2309.503456756797;2311.237291693737;2319.8376113672048;2335.8598484090926;2358.445765245166;2238.7201599800023;2244.9887750561306;2288.233441797;2291.3698732848434;2305.7463678995296;2288.1762565476583;2319.791218790317;2323.3378487131254;2327.1389585853344;2331.7901388875084;8938.419002764864;9023.323250756219;9034.14175653312;9089.727308180765;9112.81774364509;5181.53366197044;5334.959682861843;5350.0904846176245;5355.812546560891;5365.141577347606;3216.2281052547455;3352.664733526652;3451.6893479586956;3490.2147016921244;3491.1970246843116;1136.3011747775142;1166.9474873630706;1172.6013155527075;1186.6380753870067;1223.718544734716;12782.360881955958;12783.488660453571;12795.360231988363;12805.167664101804;12855.678608034874;4672.94693703761;4746.59653929413;4769.9046019080115;4792.7124372537755;4859.562639362474;10646.520906559223;10677.305975111592;10685.732856678489;10690.946545267223;10703.83944240837;5278.683279003272;5288.5769138469595;5288.947110528922;5343.625946183807;5363.704996225245;4384.934225986613;4820.39745031871;4944.480829512921;4957.529034741766;4959.479254678279;4107.797226188477;4116.217918595517;4122.2579935611875;4195.601417865298;4201.747895126302;1177.1348059176498;1291.74083476807;1294.449858810002;1322.840920410407;1346.1653774659774;924.089771574998;985.1232403161192;1019.9545465897367;1022.8619136416637;1030.9587616495255;6053.303870055;6131.570790044743;6303.590266632654;6309.211348581427;6346;919.0946917286467;921.9354645174774;923.3674932671007;931.2224292715523;1039.4958445154093;4000.959990400117;4106.630403263721;4279.850205242801;4282.6359759420175;4351.97824010878;11234.55061797519;11541.596044138583;11585.304881707125;11587.942060289644;11596.88403115958;11301.434928253719;11342.319460832376;11383.260088094248;11431.085513158927;11448.141389395829;8220.013598368234;8306.916930830736;8438.704645337384;8468.534230617375;8478.872816907751;6017.939820601738;6100.511959043355;6108.205933228652;6229.190205273286;6235.282942461675;10537.367757934548;10608.416537090225;10636.149108071491;10672.786544269227;10747.408892510986;10482.37105773656;10675.786484270426;10829;10869.456527173768;10965.50655220533;7473.701051958078;7534.284242996907;7547.396208303432;7594.468387212842;7601.505902116345;8207.302379297827;8285.130061343472;8351.95824020876;8387.161283871565;8414.453060551044;7517.73687920942;7615.048118985127;7708.267714567107;7723.845523089394;7801.063872335356;7510.39916806665;7521.8871716923195;7524.360429363565;7692.230776922487;7715.189905060112;7079.39825114871;7141.392981596622;7173.928260717535;7186.281371862981;7216.7113315466795;5030.496950305087;5184.688918664892;5192.299039629602;5218.26944227816;5263.973525162556;5213.45258747826;5297.655652382583;5376.811811586732;5416.783328666967;5556.472135147154 22:30:14 INFO - PROCESS | 3401 | |4;prototype.html;323.0228558610204;328.2466738834375;328.52364072095463;330.4712460063897;332.49958811987955;5470.5623550116;5518.503334699882;5547.948628254464;5551.639143455673;5554.833354999351;5410.269613602162;5436;5456.836294911159;5457.808976685817;5462.808801691932;4075.4294398784195;4273.529911709709;4286.592773686511;4287.656987441005;4290.849820256291;4232.640225580829;4238.449001629784;4244.427002354689;4272.636825869805;4280.614744672979;4232.640225580829;4237.703360764748;4243.599612128006;4256.318754092132;4279.74321540707;4115.32097203961;4224.66202703783;4227.175700738358;4231.788410579474;4251.914961700749;3678.3562876496508;3684.9078773030888;3685.1892583631557;3689.409694448902;3695.815209239527;5190.482615931271;5223.947760522384;5233.21501774733;5294.708791016493;5323.281357016792;4713.505081966413;4791.233402655594;4799.808007679689;4817.735024573647;4820.566149046603;5697.5500534770035;5739.9381114493535;5741.45456181662;5744.770209191627;5763.567732420085;4046.109855831712;4062.5937406259136;4072.75563466193;4074.124063326369;4094.529129150156;5680.4319568043275;5719.827435375738;5889.8822023559715;5926.970365148147;5992.910106348409;4131.834726610902;4154.086101057763;4168.916621667549;4173.728707633994;4173.937390939138;4181.874543763692;4192.559781222928;4192.664586833046;4232.407462955189;4248.957510424856;4576.313552967015;4796.928046079312;4798.640101992295;4810.42274927011;4834.661573689878;5608.569814697307;5630.099184130601;5702.372738998707;5716.657000579979;5790.002449155035;1430.399232322427;1439.560933915145;1442.725882082401;1443.4947768281227;1454.6726986427968;900.3382513852313;933.8140561486873;939.6382392778829;942.58997336159;952.9571169297399;4962.578180854668;4977.950220497821;4995.850124496198;5010.69935803853;5019.548240658358;5107.897842043139;5174.068667639861;5228.627535239749;5231.581473482189;5236.847893463432;5028.522290382408;5031.22016087507;5044.697318160922;5127.000704587858;5609.775608975595;3096.4116817804547;3131.4833052546533;3161.65221825599;3174.1747145742274;3177.459831828595;6033.125196846433;6166.537509686791;6207.503399728011;6219.906701399483;6247;5905.232319798399;6028.125921741323;6081.452669259788;6083.6045657032155;6145;6193.566450348522;6196.605763703131;6238.970569856105;6240.846907816796;6256.843578910563;5868.2664666916635;5878.30286580983;5901.232839730807;5956.821295361146;6006.33930267679;5631.887362252814;5736.795272992718;5889.911651325147;5924.7926322578505;5941.435563621449;6131.96934015327;6138;6143.72353244114;6161.353057928853;6187.504999599932;4122.113745544602;4131.710780245354;4200.264953633163;4205.264078786139;4222.514410842792;5691.914621280767;5835.79574714883;5843.29880414336;5897.41025897424;6007.339192688888;5672.461116193955;5704.286964129484;5721.742521586455;5726.312842458931;5728.856778580569;5510;5711.771529138788;5715.371309155907;5755.971220143872;5770.798022069207;5586.245856809279;5623.69069701154;5657.660540367591;5663.518600918803;5720.971395142998;5716.485516303553;5811.215485909348;5813.273340832396;5818.44724751148;5871.882562348815;5379.924015196898;5654.293213348332;5661.603687741818;5740.827775166752;5751.980210389579 22:30:14 INFO - PROCESS | 3401 | |5;yui.html;797.4275246893915;826.6734639817272;838.3837879158818;855.5465603230286;866.33292364879;12128.757424851508;12639.620811375651;12695.492180312776;12763;12777;11735.237209581393;11756.588519401823;11840.76318473632;12710.809337859939;12731.936340318285;794.1026639896909;799.3804801278997;805.8630032894422;805.907320658126;806.9112397636255;794.3248238996864;795.7055889320959;796.55791035975;797.4139007829241;798.2616080125889;833.7165363776314;836.1805430677939;837.4975014991018;838.4047326398264;840.7435732101737;829.9626516806758;832.7793134819308;833.5832083958021;834.5284914023588;835.5696816139663;607.5261296188979;610.6519284008117;610.9725062372204;611.1932249430753;612.8988716861712;11951.342676152808;12146.210496317712;12166.57416990401;12184.086193535431;12528;12295.69260768479;12314.384280786015;12353.135280530367;12446.190997585129;12467.812982805266;11471.426428678617;11563.653090407217;11913.093904975163;11969.64091077269;12133.090018248668;4258.212230737293;4271.67962402821;4279.957200428018;4304.418903448026;4478.0596074824325;54528;55132.17301740477;58192.41807581912;60009.6999515004;60768;10013.949930250303;10048.145907597936;10202.33684810485;10203.642872499428;10386.42874641902;17987.1006449677;17988.64022719538;17993.910030449762;18005.909970450062;18030.188641511162;7467.514611550232;7491.213422590658;7958.243966823143;7988.041435027718;8081.232282933112;4458.398116254329;4462.732236065846;4474.6867719259335;4498.3252512123445;4537.77311134442;3218.951715724266;3325.833708314575;3328.5839270091237;3330.3672302262976;3349.1794510344635;649.555054787472;668.5921587831419;690.6374153569316;694.1046050594778;701.9227884932653;719.3957076056138;741.6143605325201;747.7532414303267;768.0859776865624;785.3010820369875;8813.735587932373;8919.197272245528;8970.86543701845;9009.684661036963;9023.142801433853;737.4690223039403;753.7098217186423;760.9309514609218;772.6059709548058;774.7017398301695;4271.722338048017;4470.173017991617;4484.820607175677;4528.615067719281;4584.312353147055;70350.29649703437;74588.25411745922;75759;76033.61983190049;78264;48845.26732099021;52562.73718631459;61830;66251;66622;53826;53913.1913021305;54076.18885716717;54097;54244.999999999214;9114.40756350835;9311.022342653923;9312.394694344846;9375.906240937777;9415.85876211871;35670.108247294025;36137;36180;36218.63781362153;37012.44481332836;44803.551964479935;47639;48428.75785621049;49166;49709.50290497193;11112.333260004425;11715.531378744754;12046.698832529257;12070.155089143676;12384.071194660257;12718.173318734252;12727;12880.935595321964;12890.935545322214;13000.349982500647;11950.257204215222;12041.277523348626;12137.757244854876;12413.379331033231;12622;11705.941470292593;12102;12143.271403715806;12211.145219834527;12479;11518.82721759191;11566.30602163873;11981.460834262654;12216.144869859025;12567.560135395217;9827.361221520578;10303.896961030294;10308.536115874653;10410.011048950337;10567.52446139941;10217;10366.585336586451;10410.843837342598;10466.110380617733;10630.362178269019 22:30:14 INFO - PROCESS | 3401 | __end_tp_report 22:30:14 INFO - PROCESS | 3401 | __start_cc_report 22:30:14 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,369 22:30:14 INFO - PROCESS | 3401 | __end_cc_report 22:30:14 INFO - PROCESS | 3401 | __startTimestamp1464586214299__endTimestamp 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | ------- Summary: start ------- 22:30:14 INFO - PROCESS | 3401 | Number of tests: 6 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:5363.66 Median:5615.63 stddev:709.76 (12.6%) stddev-sans-first:689.16 22:30:14 INFO - PROCESS | 3401 | Values: 3090.0 3145.6 3175.6 3187.8 3196.3 5331.7 5392.3 5407.1 5469.2 5490.0 5217.8 5279.7 5308.2 5322.5 5387.1 4840.5 4890.3 4985.1 5028.8 5069.9 736.4 4849.7 4864.3 4878.5 4960.6 4906.2 4936.4 4951.7 4976.8 4989.1 4930.0 4963.1 4970.7 4996.0 5016.1 4877.5 4882.9 4922.1 4943.9 4969.0 5329.4 5345.6 5353.2 5393.4 5413.4 5622.3 5842.5 5850.6 5854.4 5858.1 5697.3 5734.6 5770.8 5779.0 5796.4 5374.4 5381.1 5396.9 5400.8 5412.2 5833.4 5900.8 5925.0 5925.8 5939.2 5643.4 5729.3 5730.1 5734.2 5770.2 5665.0 5719.1 5719.1 5741.9 5743.9 5596.4 5735.9 5761.5 5777.1 5780.4 5690.3 5701.1 5705.0 5707.8 5709.7 4360.3 4378.7 4379.9 4393.9 4419.5 3913.5 3955.3 3979.1 3984.6 3987.1 5472.8 5522.2 5550.1 5583.4 5583.7 5760.2 5863.5 5886.8 5890.4 5893.2 5445.6 5600.2 5633.8 5647.2 5660.9 5048.3 5085.3 5094.5 5121.1 5128.8 6070.0 6107.6 6112.4 6116.5 6128.6 5618.9 5803.5 5828.5 5836.6 5883.8 6054.9 6055.6 6082.4 6089.1 6110.0 5746.7 5749.3 5752.9 5765.9 5767.0 5653.3 5773.9 5778.3 5826.4 5868.4 5623.1 5627.9 5687.6 5690.5 5698.4 5527.2 5615.6 5651.8 5659.2 5668.1 5555.0 5582.1 5605.9 5612.2 5612.8 5703.6 5715.3 5745.7 5762.0 5763.0 5392.8 5603.4 5610.0 5614.7 5643.0 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:57867.46 Median:40596.39 stddev:118988.10 (293.1%) stddev-sans-first:119244.14 22:30:14 INFO - PROCESS | 3401 | Values: 573.4 618.2 628.0 645.0 658.0 38333.4 41946.0 42057.8 42104.4 42147.8 43312.0 43742.6 44024.8 44030.6 44052.3 8660.4 8896.2 8913.7 8930.6 8930.7 8756.0 8878.7 8883.7 8891.2 8902.6 8889.2 8923.8 8929.3 8938.4 8984.7 8818.3 8857.7 8877.2 8890.9 8925.1 8813.0 8858.7 8980.1 8987.1 8994.4 40426.8 40546.4 40646.4 40798.2 40827.0 3033.0 3487.9 3532.2 3569.3 3629.9 30227.0 30553.0 30580.4 30636.2 31039.0 4134.6 4148.3 4156.5 4275.7 4372.8 302655.0 305458.0 305808.0 306048.0 306329.0 31309.2 31402.0 31426.0 31466.2 31478.5 35458.6 35488.0 35633.0 35760.5 35893.5 15102.4 15443.8 15451.2 15580.1 15602.5 12950.7 12955.0 13005.7 13048.6 13096.5 8180.4 8185.3 8206.9 8267.2 8302.6 2882.3 3059.1 3146.1 3171.9 3201.9 1003.9 1060.0 1142.5 1152.7 1211.7 32885.3 33187.5 33314.3 33314.5 33627.5 1142.9 1152.7 1164.3 1174.4 1188.5 16665.7 17261.2 17380.3 17391.5 17504.4 549999.0 553991.0 554543.0 580963.0 588373.0 58350.4 59121.4 59305.0 59390.0 59455.4 1327.8 1365.0 1372.4 1385.6 1395.5 30891.5 32036.7 32249.3 32270.7 32673.2 51549.7 51564.5 51700.2 52232.7 52331.0 428463.0 429356.0 431630.0 431755.0 431935.0 27957.0 28082.9 28182.4 28512.7 28862.7 48713.0 48835.0 49352.5 49464.8 49780.3 41605.4 41643.0 42058.6 42688.6 42888.0 40142.8 40474.0 40984.4 41373.6 41459.0 40384.6 41865.6 41899.4 41982.6 42184.0 35315.6 37591.4 37962.2 37994.6 38708.6 28474.6 28590.9 28806.7 29043.6 29116.4 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:28413.98 Median:371.98 stddev:78751.02 (21170.7%) stddev-sans-first:78943.77 22:30:14 INFO - PROCESS | 3401 | Values: 364.3 379.6 383.2 390.7 409.3 18023.3 18425.6 18958.8 19415.2 19449.8 10912.2 11508.9 11532.5 11600.8 11618.9 4933.4 5052.2 5057.9 5085.3 5130.9 5358.2 5407.8 5407.9 5449.9 5480.0 5425.5 5602.9 5809.4 5852.9 5869.5 5707.7 5776.7 5811.4 5815.5 5845.2 5291.0 5294.9 5378.4 5390.1 5393.5 12455.9 12612.6 12791.0 13097.6 13116.1 2133.9 2178.1 2188.9 2354.5 2457.5 9832.8 9836.7 9861.8 10067.1 10073.9 1892.1 1927.0 1930.9 1942.8 2001.2 81003.6 84205.6 84344.6 84618.6 85093.6 10704.9 10981.8 11032.9 11092.8 11172.3 15340.0 15461.5 15464.9 15494.3 15498.5 8270.5 8291.0 8356.4 8382.0 8488.6 7902.8 8035.5 8045.2 8130.5 8221.5 4094.2 4476.9 4628.4 4742.9 4823.4 1918.1 1935.0 1955.3 1961.7 1981.3 953.6 1001.7 1005.9 1013.4 1057.9 17075.2 19263.9 19463.0 19550.0 19623.9 998.6 1004.4 1017.5 1031.1 1079.7 8539.3 10472.7 10800.8 10864.1 10872.1 467367.0 471941.0 476692.0 477022.0 482026.0 96385.5 97887.5 99334.5 99632.0 100809.5 952.3 960.9 981.1 985.2 1001.3 16324.6 17258.7 17272.6 17540.0 17753.8 43710.6 43716.3 43978.0 45304.1 45462.3 56766.4 59087.0 60065.0 60771.4 62666.7 7680.5 8598.0 8600.7 8920.3 8955.4 10571.3 13086.1 13151.3 13503.3 13865.2 11416.8 11515.9 11713.0 11751.5 12216.9 11680.9 11776.0 11870.5 12006.5 12061.3 11423.8 12034.5 12102.3 12217.6 12321.4 8662.9 8698.3 8817.5 8833.1 8867.6 8894.6 10944.3 12072.6 12190.8 12244.2 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5943.69 Median:4709.77 stddev:3424.93 (72.7%) stddev-sans-first:3418.08 22:30:14 INFO - PROCESS | 3401 | Values: 1476.1 1510.1 1652.3 1767.8 1791.5 7988.6 8648.2 8743.7 9271.0 9275.2 8909.2 9102.4 9171.3 9181.4 9207.2 2317.1 2392.4 2394.2 2396.0 2398.1 2303.6 2329.8 2342.7 2348.2 2362.9 2309.5 2311.2 2319.8 2335.9 2358.4 2238.7 2245.0 2288.2 2291.4 2305.7 2288.2 2319.8 2323.3 2327.1 2331.8 8938.4 9023.3 9034.1 9089.7 9112.8 5181.5 5335.0 5350.1 5355.8 5365.1 3216.2 3352.7 3451.7 3490.2 3491.2 1136.3 1166.9 1172.6 1186.6 1223.7 12782.4 12783.5 12795.4 12805.2 12855.7 4672.9 4746.6 4769.9 4792.7 4859.6 10646.5 10677.3 10685.7 10690.9 10703.8 5278.7 5288.6 5288.9 5343.6 5363.7 4384.9 4820.4 4944.5 4957.5 4959.5 4107.8 4116.2 4122.3 4195.6 4201.7 1177.1 1291.7 1294.4 1322.8 1346.2 924.1 985.1 1020.0 1022.9 1031.0 6053.3 6131.6 6303.6 6309.2 6346.0 919.1 921.9 923.4 931.2 1039.5 4001.0 4106.6 4279.9 4282.6 4352.0 11234.6 11541.6 11585.3 11587.9 11596.9 11301.4 11342.3 11383.3 11431.1 11448.1 8220.0 8306.9 8438.7 8468.5 8478.9 6017.9 6100.5 6108.2 6229.2 6235.3 10537.4 10608.4 10636.1 10672.8 10747.4 10482.4 10675.8 10829.0 10869.5 10965.5 7473.7 7534.3 7547.4 7594.5 7601.5 8207.3 8285.1 8352.0 8387.2 8414.5 7517.7 7615.0 7708.3 7723.8 7801.1 7510.4 7521.9 7524.4 7692.2 7715.2 7079.4 7141.4 7173.9 7186.3 7216.7 5030.5 5184.7 5192.3 5218.3 5264.0 5213.5 5297.7 5376.8 5416.8 5556.5 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:4783.87 Median:5423.13 stddev:1421.33 (26.2%) stddev-sans-first:1385.32 22:30:14 INFO - PROCESS | 3401 | Values: 323.0 328.2 328.5 330.5 332.5 5470.6 5518.5 5547.9 5551.6 5554.8 5410.3 5436.0 5456.8 5457.8 5462.8 4075.4 4273.5 4286.6 4287.7 4290.8 4232.6 4238.4 4244.4 4272.6 4280.6 4232.6 4237.7 4243.6 4256.3 4279.7 4115.3 4224.7 4227.2 4231.8 4251.9 3678.4 3684.9 3685.2 3689.4 3695.8 5190.5 5223.9 5233.2 5294.7 5323.3 4713.5 4791.2 4799.8 4817.7 4820.6 5697.6 5739.9 5741.5 5744.8 5763.6 4046.1 4062.6 4072.8 4074.1 4094.5 5680.4 5719.8 5889.9 5927.0 5992.9 4131.8 4154.1 4168.9 4173.7 4173.9 4181.9 4192.6 4192.7 4232.4 4249.0 4576.3 4796.9 4798.6 4810.4 4834.7 5608.6 5630.1 5702.4 5716.7 5790.0 1430.4 1439.6 1442.7 1443.5 1454.7 900.3 933.8 939.6 942.6 953.0 4962.6 4978.0 4995.9 5010.7 5019.5 5107.9 5174.1 5228.6 5231.6 5236.8 5028.5 5031.2 5044.7 5127.0 5609.8 3096.4 3131.5 3161.7 3174.2 3177.5 6033.1 6166.5 6207.5 6219.9 6247.0 5905.2 6028.1 6081.5 6083.6 6145.0 6193.6 6196.6 6239.0 6240.8 6256.8 5868.3 5878.3 5901.2 5956.8 6006.3 5631.9 5736.8 5889.9 5924.8 5941.4 6132.0 6138.0 6143.7 6161.4 6187.5 4122.1 4131.7 4200.3 4205.3 4222.5 5691.9 5835.8 5843.3 5897.4 6007.3 5672.5 5704.3 5721.7 5726.3 5728.9 5510.0 5711.8 5715.4 5756.0 5770.8 5586.2 5623.7 5657.7 5663.5 5721.0 5716.5 5811.2 5813.3 5818.4 5871.9 5379.9 5654.3 5661.6 5740.8 5752.0 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:15299.08 Median:4491.57 stddev:19113.20 (425.5%) stddev-sans-first:19135.79 22:30:14 INFO - PROCESS | 3401 | Values: 797.4 826.7 838.4 855.5 866.3 12128.8 12639.6 12695.5 12763.0 12777.0 11735.2 11756.6 11840.8 12710.8 12731.9 794.1 799.4 805.9 805.9 806.9 794.3 795.7 796.6 797.4 798.3 833.7 836.2 837.5 838.4 840.7 830.0 832.8 833.6 834.5 835.6 607.5 610.7 611.0 611.2 612.9 11951.3 12146.2 12166.6 12184.1 12528.0 12295.7 12314.4 12353.1 12446.2 12467.8 11471.4 11563.7 11913.1 11969.6 12133.1 4258.2 4271.7 4280.0 4304.4 4478.1 54528.0 55132.2 58192.4 60009.7 60768.0 10013.9 10048.1 10202.3 10203.6 10386.4 17987.1 17988.6 17993.9 18005.9 18030.2 7467.5 7491.2 7958.2 7988.0 8081.2 4458.4 4462.7 4474.7 4498.3 4537.8 3219.0 3325.8 3328.6 3330.4 3349.2 649.6 668.6 690.6 694.1 701.9 719.4 741.6 747.8 768.1 785.3 8813.7 8919.2 8970.9 9009.7 9023.1 737.5 753.7 760.9 772.6 774.7 4271.7 4470.2 4484.8 4528.6 4584.3 70350.3 74588.3 75759.0 76033.6 78264.0 48845.3 52562.7 61830.0 66251.0 66622.0 53826.0 53913.2 54076.2 54097.0 54245.0 9114.4 9311.0 9312.4 9375.9 9415.9 35670.1 36137.0 36180.0 36218.6 37012.4 44803.6 47639.0 48428.8 49166.0 49709.5 11112.3 11715.5 12046.7 12070.2 12384.1 12718.2 12727.0 12880.9 12890.9 13000.3 11950.3 12041.3 12137.8 12413.4 12622.0 11705.9 12102.0 12143.3 12211.1 12479.0 11518.8 11566.3 11981.5 12216.1 12567.6 9827.4 10303.9 10308.5 10410.0 10567.5 10217.0 10366.6 10410.8 10466.1 10630.4 22:30:14 INFO - PROCESS | 3401 | -------- Summary: end -------- 22:30:14 INFO - PROCESS | 3401 | 22:30:14 INFO - TEST-INFO | 3401: exit 0 22:30:14 INFO - TEST-OK | dromaeo_css | took 1112870ms 22:30:14 INFO - TEST-START | kraken 22:30:14 INFO - operating with platform_type : linux_ 22:30:14 INFO - Initialising browser for kraken test... 22:30:14 INFO - TEST-INFO | started process 3635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptt_owb/profile http://localhost:44702/getInfo.html) 22:30:20 INFO - PROCESS | 3635 | __metrics Screen width/height:1600/1200 22:30:20 INFO - PROCESS | 3635 | colorDepth:24 22:30:20 INFO - PROCESS | 3635 | Browser inner width/height: 1024/697 22:30:20 INFO - PROCESS | 3635 | __metrics 22:30:20 ERROR - PROCESS | 3635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:30:21 INFO - TEST-INFO | 3635: exit 0 22:30:21 INFO - Browser initialized. 22:30:21 INFO - Running cycle 1/1 for kraken test... 22:30:21 INFO - TEST-INFO | started process 3756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptt_owb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:33 INFO - PROCESS | 3756 | RSS: Main: 166514688 22:30:33 INFO - PROCESS | 3756 | 22:30:36 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44702/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:36 INFO - PROCESS | 3756 | RSS: Main: 172085248 22:30:36 INFO - PROCESS | 3756 | 22:30:39 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44702/tests/kraken/driver.html?testName=audio-dft) 22:30:40 INFO - PROCESS | 3756 | RSS: Main: 171528192 22:30:40 INFO - PROCESS | 3756 | 22:30:43 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44702/tests/kraken/driver.html?testName=audio-fft) 22:30:43 INFO - PROCESS | 3756 | RSS: Main: 166297600 22:30:43 INFO - PROCESS | 3756 | 22:30:46 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44702/tests/kraken/driver.html?testName=audio-oscillator) 22:30:46 INFO - PROCESS | 3756 | RSS: Main: 167288832 22:30:46 INFO - PROCESS | 3756 | 22:30:48 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:30:49 INFO - PROCESS | 3756 | RSS: Main: 167768064 22:30:49 INFO - PROCESS | 3756 | 22:30:52 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44702/tests/kraken/driver.html?testName=imaging-darkroom) 22:30:53 INFO - PROCESS | 3756 | RSS: Main: 167751680 22:30:53 INFO - PROCESS | 3756 | 22:30:56 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44702/tests/kraken/driver.html?testName=imaging-desaturate) 22:30:57 INFO - PROCESS | 3756 | RSS: Main: 167948288 22:30:57 INFO - PROCESS | 3756 | 22:31:00 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44702/tests/kraken/driver.html?testName=json-parse-financial) 22:31:00 INFO - PROCESS | 3756 | RSS: Main: 168206336 22:31:00 INFO - PROCESS | 3756 | 22:31:02 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:02 INFO - PROCESS | 3756 | RSS: Main: 168361984 22:31:02 INFO - PROCESS | 3756 | 22:31:04 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:05 INFO - PROCESS | 3756 | RSS: Main: 168583168 22:31:05 INFO - PROCESS | 3756 | 22:31:07 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:08 INFO - PROCESS | 3756 | RSS: Main: 168460288 22:31:08 INFO - PROCESS | 3756 | 22:31:10 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:11 INFO - PROCESS | 3756 | RSS: Main: 168853504 22:31:11 INFO - PROCESS | 3756 | 22:31:14 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:14 INFO - PROCESS | 3756 | RSS: Main: 168796160 22:31:14 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | Cycle 1(1): loaded http://localhost:44702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44702/tests/kraken/driver.html?testName=ai-astar) 22:31:16 INFO - PROCESS | 3756 | RSS: Main: 169398272 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | __start_tp_report 22:31:16 INFO - PROCESS | 3756 | _x_x_mozilla_page_load 22:31:16 INFO - PROCESS | 3756 | _x_x_mozilla_page_load_details 22:31:16 INFO - PROCESS | 3756 | |i|pagename|runs| 22:31:16 INFO - PROCESS | 3756 | |0;ai-astar;114;106;111;112;112;114;114;113;112;111 22:31:16 INFO - PROCESS | 3756 | |1;audio-beat-detection;152;126;158;193;125;158;153;132;190;126 22:31:16 INFO - PROCESS | 3756 | |2;audio-dft;162;162;161;162;165;166;166;162;162;162 22:31:16 INFO - PROCESS | 3756 | |3;audio-fft;74;75;74;161;76;74;75;76;180;75 22:31:16 INFO - PROCESS | 3756 | |4;audio-oscillator;83;82;145;83;83;82;144;83;83;138 22:31:16 INFO - PROCESS | 3756 | |5;imaging-gaussian-blur;117;117;117;117;119;117;118;118;117;118 22:31:16 INFO - PROCESS | 3756 | |6;imaging-darkroom;147;147;146;147;147;147;146;147;149;147 22:31:16 INFO - PROCESS | 3756 | |7;imaging-desaturate;96;96;95;95;95;96;96;95;95;95 22:31:16 INFO - PROCESS | 3756 | |8;json-parse-financial;57;54;56;55;57;54;54;55;56;55 22:31:16 INFO - PROCESS | 3756 | |9;json-stringify-tinderbox;62;62;62;62;62;61;62;62;62;61 22:31:16 INFO - PROCESS | 3756 | |10;stanford-crypto-aes;81;79;80;80;81;80;80;81;105;79 22:31:16 INFO - PROCESS | 3756 | |11;stanford-crypto-ccm;133;122;129;128;131;122;132;128;145;132 22:31:16 INFO - PROCESS | 3756 | |12;stanford-crypto-pbkdf2;160;168;162;161;162;160;160;160;163;164 22:31:16 INFO - PROCESS | 3756 | |13;stanford-crypto-sha256-iterative;63;65;69;62;68;65;66;63;65;62 22:31:16 INFO - PROCESS | 3756 | __end_tp_report 22:31:16 INFO - PROCESS | 3756 | __start_cc_report 22:31:16 INFO - PROCESS | 3756 | _x_x_mozilla_cycle_collect,889 22:31:16 INFO - PROCESS | 3756 | __end_cc_report 22:31:16 INFO - PROCESS | 3756 | __startTimestamp1464586276551__endTimestamp 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | ------- Summary: start ------- 22:31:16 INFO - PROCESS | 3756 | Number of tests: 14 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.38 (2.1%) stddev-sans-first:2.40 22:31:16 INFO - PROCESS | 3756 | Values: 114.0 106.0 111.0 112.0 112.0 114.0 114.0 113.0 112.0 111.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:155.50 stddev:25.11 (16.1%) stddev-sans-first:26.63 22:31:16 INFO - PROCESS | 3756 | Values: 152.0 126.0 158.0 193.0 125.0 158.0 153.0 132.0 190.0 126.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:1.89 (1.2%) stddev-sans-first:1.96 22:31:16 INFO - PROCESS | 3756 | Values: 162.0 162.0 161.0 162.0 165.0 166.0 166.0 162.0 162.0 162.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:40.57 (54.1%) stddev-sans-first:42.38 22:31:16 INFO - PROCESS | 3756 | Values: 74.0 75.0 74.0 161.0 76.0 74.0 75.0 76.0 180.0 75.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.00 stddev:28.86 (34.8%) stddev-sans-first:29.90 22:31:16 INFO - PROCESS | 3756 | Values: 83.0 82.0 145.0 83.0 83.0 82.0 144.0 83.0 83.0 138.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 22:31:16 INFO - PROCESS | 3756 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 118.0 118.0 117.0 118.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:31:16 INFO - PROCESS | 3756 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 149.0 147.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:31:16 INFO - PROCESS | 3756 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.16 (2.1%) stddev-sans-first:1.05 22:31:16 INFO - PROCESS | 3756 | Values: 57.0 54.0 56.0 55.0 57.0 54.0 54.0 55.0 56.0 55.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 22:31:16 INFO - PROCESS | 3756 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:80.00 stddev:7.90 (9.9%) stddev-sans-first:8.36 22:31:16 INFO - PROCESS | 3756 | Values: 81.0 79.0 80.0 80.0 81.0 80.0 80.0 81.0 105.0 79.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:131.50 stddev:6.49 (4.9%) stddev-sans-first:6.81 22:31:16 INFO - PROCESS | 3756 | Values: 133.0 122.0 129.0 128.0 131.0 122.0 132.0 128.0 145.0 132.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:2.54 (1.6%) stddev-sans-first:2.59 22:31:16 INFO - PROCESS | 3756 | Values: 160.0 168.0 162.0 161.0 162.0 160.0 160.0 160.0 163.0 164.0 22:31:16 INFO - PROCESS | 3756 | 22:31:16 INFO - PROCESS | 3756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:2.39 (3.7%) stddev-sans-first:2.45 22:31:16 INFO - PROCESS | 3756 | Values: 63.0 65.0 69.0 62.0 68.0 65.0 66.0 63.0 65.0 62.0 22:31:16 INFO - PROCESS | 3756 | -------- Summary: end -------- 22:31:16 INFO - PROCESS | 3756 | 22:31:17 INFO - TEST-INFO | 3756: exit 0 22:31:17 INFO - TEST-OK | kraken | took 62584ms 22:31:17 INFO - SUITE-END | took 1175s 22:31:17 INFO - Completed test suite (00:19:35) 22:31:17 INFO - javascript benchmark 22:31:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7035.586945515982, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.0, 3145.5596216529675, 3175.603049618797, 3187.7927934684258, 3196.34474932639, 5331.7334133293325, 5392.325959255093, 5407.05376559102, 5469.179623056543, 5490.039243132446, 5217.791288348461, 5279.736013199344, 5308.177232528955, 5322.467753224676, 5387.0841956867325, 4840.491748366415, 4890.266460031006, 4985.127602669537, 5028.7988480460735, 5069.923951140736, 736.405654899694, 4849.709017458946, 4864.294677271793, 4878.48775878533, 4960.60315174787, 4906.165951788204, 4936.407631084293, 4951.653384263085, 4976.751162441881, 4989.052080104769, 4929.975350123263, 4963.081829861451, 4970.6520543561965, 4995.975020124876, 5016.097102521545, 4877.463479017305, 4882.902341953177, 4922.114019476493, 4943.851684449436, 4968.950310496921, 5329.413764485904, 5345.5990800689715, 5353.197020446964, 5393.352797664266, 5413.404525502192, 5622.3253209614695, 5842.503387212092, 5850.590458667895, 5854.414558544154, 5858.062709966428, 5697.31632204134, 5734.598578099534, 5770.798022069207, 5779.0, 5796.449337312949, 5374.381946076173, 5381.0583147948955, 5396.892062158735, 5400.810971615974, 5412.188171774265, 5833.416658334133, 5900.822975310747, 5925.0, 5925.762969481259, 5939.168516407706, 5643.435656434323, 5729.341125770589, 5730.140478928194, 5734.2258795062135, 5770.221020162308, 5664.971675141598, 5719.113537401709, 5719.113537401709, 5741.913871291934, 5743.8851222976145, 5596.4123767003875, 5735.8852822944145, 5761.452661997104, 5777.104548794943, 5780.364159942403, 5690.345610254791, 5701.087825947829, 5704.971475142681, 5707.800226992035, 5709.65742055478, 4360.258756011485, 4378.737275763465, 4379.912401751947, 4393.890152746207, 4419.469663640384, 3913.5303763547986, 3955.3473676843573, 3979.1047014421524, 3984.641382275609, 3987.1029018470613, 5472.808451704172, 5522.199281104217, 5550.111982082847, 5583.357913839879, 5583.748731307101, 5760.193572899798, 5863.501602363847, 5886.793962211302, 5890.352061273256, 5893.204417403681, 5445.591580631469, 5600.159976003632, 5633.774649013993, 5647.1529270609735, 5660.886782264414, 5048.268001139814, 5085.262636917701, 5094.490550944876, 5121.129408000649, 5128.820491282787, 6069.969650151721, 6107.633541987495, 6112.358202388774, 6116.48009919153, 6128.63228206309, 5618.85952851182, 5803.535717142703, 5828.504577110823, 5836.620619659709, 5883.794067207627, 6054.878902422015, 6055.576109672457, 6082.422169893853, 6089.056196289582, 6110.0, 5746.712664366849, 5749.338826035059, 5752.942470575241, 5765.855853603525, 5767.048437007847, 5653.321601407857, 5773.884522309614, 5778.27771528559, 5826.417358264309, 5868.413158684098, 5623.100303951348, 5627.8593035174445, 5687.601867869375, 5690.487856092972, 5698.401667824819, 5527.198556209408, 5615.634983726045, 5651.773929042793, 5659.151127330933, 5668.149777533403, 5554.97222513901, 5582.106862902078, 5605.943940560543, 5612.242347283064, 5612.831615051555, 5703.600747947604, 5715.2855893013375, 5745.741441635053, 5762.0, 5763.020286551213, 5392.757325920422, 5603.439656034364, 5609.990201763721, 5614.691191984317, 5643.0], "value": 5317.610505268268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3549756523911, 618.2025187508115, 627.952903532235, 644.9516286278529, 658.0359772932659, 38333.42499862501, 41946.0, 42057.7897110514, 42104.36843447351, 42147.78926105365, 43312.0, 43742.56257437425, 44024.779876100576, 44030.55969440305, 44052.33921491172, 8660.350473714449, 8896.243819275369, 8913.68802091927, 8930.55347232639, 8930.687425940094, 8755.95622021889, 8878.689245876396, 8883.73348799537, 8891.244244239248, 8902.643894244222, 8889.244414224799, 8923.776905577348, 8929.285657147446, 8938.374313798036, 8984.685536006242, 8818.338624603148, 8857.734267971971, 8877.245434138105, 8890.866637000483, 8925.107489251088, 8812.955935220347, 8858.689945851864, 8980.146886045815, 8987.146221108984, 8994.370394072417, 40426.79786601078, 40546.39180412296, 40646.39030414546, 40798.184036319406, 40827.0, 3032.9848350758325, 3487.8779242726637, 3532.2229109595846, 3569.321828852536, 3629.8548058077645, 30227.0, 30553.0, 30580.388392232253, 30636.234094147603, 31039.0, 4134.627883490501, 4148.284191403986, 4156.501219853607, 4275.657947364203, 4372.846950356722, 302655.0, 305458.0, 305808.0, 306048.0, 306328.9999999978, 31309.217269567987, 31402.0, 31426.0, 31466.213344666565, 31478.527822082688, 35458.645413545535, 35488.0, 35633.0, 35760.46359304612, 35893.46159807605, 15102.39590416393, 15443.768343474856, 15451.150186739613, 15580.065196088271, 15602.453914113179, 12950.67623309406, 12955.0, 13005.739885202433, 13048.608541743763, 13096.476140954446, 8180.386471014698, 8185.263326300662, 8206.917930820615, 8267.173282671685, 8302.626381812834, 2882.322654176267, 3059.1434398368046, 3146.134812926418, 3171.8731250750175, 3201.871925122969, 1003.8945910679273, 1060.0, 1142.4973011874915, 1152.7175841918615, 1211.6546784166471, 32885.342293154004, 33187.50218746721, 33314.33371332608, 33314.500282495785, 33627.495587566205, 1142.9257098288585, 1152.6772503698978, 1164.3072371938683, 1174.3599738142732, 1188.5127097889824, 16665.666686666198, 17261.223244954006, 17380.3047878086, 17391.47825565235, 17504.387346442814, 549999.0, 553991.0, 554543.0, 580963.0, 588373.0, 58350.41649583535, 59121.40878591245, 59305.0, 59390.0, 59455.40544594585, 1327.794191900257, 1364.9522266720617, 1372.3755691160497, 1385.6051025457496, 1395.4627468424526, 30891.536626950165, 32036.6796332043, 32249.251143775316, 32270.677293226767, 32673.18317042093, 51549.7422512885, 51564.48435515597, 51700.22449663333, 52232.73883630557, 52331.0, 428463.0, 429356.0, 431630.0, 431755.0, 431935.0, 27957.0, 28082.85958570194, 28182.43635127327, 28512.714872851837, 28862.711372886002, 48713.0, 48835.0, 49352.50647493623, 49464.752676236385, 49780.25329619986, 41605.37591936063, 41643.0, 42058.57941420669, 42688.573114269704, 42888.0, 40142.799286003385, 40474.0, 40984.385234220914, 41373.586264138175, 41459.0, 40384.59615403808, 41865.58134418617, 41899.371509426775, 41982.58017419909, 42184.0, 35315.64684353226, 37591.43612845864, 37962.24075518419, 37994.62005379911, 38708.6129138705, 28474.57288140721, 28590.857045714638, 28806.711932880404, 29043.564346534396, 29116.417671646872], "value": 18623.135621437752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.3441804751447, 379.6165872468807, 383.21058619244366, 390.68549817396996, 409.2694540245662, 18023.279068837248, 18425.63148737026, 18958.810411895895, 19415.223391064377, 19449.805501944975, 10912.23614346996, 11508.884911150886, 11532.538698452052, 11600.825987610193, 11618.883811161886, 4933.383327084114, 5052.191649336107, 5057.898842023157, 5085.338905942241, 5130.871728206806, 5358.2498450217, 5407.783688652449, 5407.864348486803, 5449.891002179954, 5480.04099282626, 5425.538829199523, 5602.859928501779, 5809.419058094178, 5852.882942341151, 5869.50109240715, 5707.6575405475805, 5776.682282474483, 5811.360750317462, 5815.476607105338, 5845.181674565564, 5291.0, 5294.92057619136, 5378.435264297271, 5390.0836857734275, 5393.541548968343, 12455.93772031143, 12612.55856045034, 12791.0, 13097.607071787766, 13116.081874268804, 2133.9359819205447, 2178.074318414683, 2188.9014994325294, 2354.5243850773895, 2457.533068716938, 9832.803343933081, 9836.704898853046, 9861.753456163582, 10067.093961543424, 10073.949630251875, 1892.0634286028367, 1927.0, 1930.9242564243355, 1942.766867975852, 2001.2495314257153, 81003.5949820253, 84205.57897210536, 84344.57827710884, 84618.57690711568, 85093.57453212756, 10704.946475267574, 10981.780364392667, 11032.944835275772, 11092.778144437067, 11172.273802202832, 15340.0, 15461.458848940232, 15464.922675386551, 15494.30275637599, 15498.5350439487, 8270.545120018456, 8290.958545207235, 8356.415050946496, 8382.0, 8488.618012189467, 7902.841943161219, 8035.513430015466, 8045.23570260836, 8130.512169269863, 8221.465604735673, 4094.160697057096, 4476.888077798081, 4628.352030715702, 4742.881427964259, 4823.397075365579, 1918.1489862282963, 1934.951626209328, 1955.3058664174298, 1961.686130219158, 1981.2768339556246, 953.5994882149514, 1001.7345403468087, 1005.939643621385, 1013.4476710192963, 1057.878648632452, 17075.231614577373, 19263.903680481508, 19463.0, 19550.0, 19623.90188049079, 998.6305067125065, 1004.3772860826189, 1017.5014243021014, 1031.0926384781344, 1079.7084787107437, 8539.316854651737, 10472.685819425276, 10800.783984320427, 10864.130869530418, 10872.130229581615, 467367.0, 471941.0, 476692.0, 477022.0, 482026.0, 96385.51807241059, 97887.51056244673, 99334.5033274829, 99632.0, 100809.49595251976, 952.2619969523674, 960.8846938367441, 981.1464026297025, 985.1822986920838, 1001.2590682894605, 16324.591885202964, 17258.741118882976, 17272.581838542363, 17540.0, 17753.822461775217, 43710.56289437065, 43716.34425483684, 43978.0, 45304.09391812211, 45462.31806522971, 56766.432335676116, 59087.0, 60065.0, 60771.39228607834, 62666.68666656638, 7680.500767450098, 8597.95701021516, 8600.698975535826, 8920.286377089687, 8955.41789783662, 10571.312864663772, 13086.08397412172, 13151.342432878126, 13503.257320847448, 13865.168089914638, 11416.828747568627, 11515.884841151481, 11713.0, 11751.529938802352, 12216.877831221575, 11680.883191167979, 11776.0, 11870.525178992744, 12006.459709313276, 12061.336626485627, 11423.828642570534, 12034.518619255132, 12102.334371609646, 12217.633470995885, 12321.383930803604, 8662.913370866463, 8698.347623928104, 8817.470951742916, 8833.072527384533, 8867.64529418816, 8894.644214231359, 10944.343339399662, 12072.577459788865, 12190.75618487643, 12244.204126731735], "value": 8897.139235854711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.0627001853823, 1510.0637604685096, 1652.2729998800528, 1767.79670337911, 1791.5431564950927, 7988.560629165394, 8648.221660050594, 8743.650253989848, 9270.953645231773, 9275.211607013413, 8909.242714369286, 9102.408343457688, 9171.312151588625, 9181.357304988653, 9207.171354578086, 2317.050009496107, 2392.425817803732, 2394.174009966559, 2395.9760402395927, 2398.0767404549288, 2303.5968705476557, 2329.755375685554, 2342.7422983471806, 2348.201611452106, 2362.9291121266388, 2309.503456756797, 2311.237291693737, 2319.8376113672048, 2335.8598484090926, 2358.445765245166, 2238.7201599800023, 2244.9887750561306, 2288.233441797, 2291.3698732848434, 2305.7463678995296, 2288.1762565476583, 2319.791218790317, 2323.3378487131254, 2327.1389585853344, 2331.7901388875084, 8938.419002764864, 9023.323250756219, 9034.14175653312, 9089.727308180765, 9112.81774364509, 5181.53366197044, 5334.959682861843, 5350.0904846176245, 5355.812546560891, 5365.141577347606, 3216.2281052547455, 3352.664733526652, 3451.6893479586956, 3490.2147016921244, 3491.1970246843116, 1136.3011747775142, 1166.9474873630706, 1172.6013155527075, 1186.6380753870067, 1223.718544734716, 12782.360881955958, 12783.488660453571, 12795.360231988363, 12805.167664101804, 12855.678608034874, 4672.94693703761, 4746.59653929413, 4769.9046019080115, 4792.7124372537755, 4859.562639362474, 10646.520906559223, 10677.305975111592, 10685.732856678489, 10690.946545267223, 10703.83944240837, 5278.683279003272, 5288.5769138469595, 5288.947110528922, 5343.625946183807, 5363.704996225245, 4384.934225986613, 4820.39745031871, 4944.480829512921, 4957.529034741766, 4959.479254678279, 4107.797226188477, 4116.217918595517, 4122.2579935611875, 4195.601417865298, 4201.747895126302, 1177.1348059176498, 1291.74083476807, 1294.449858810002, 1322.840920410407, 1346.1653774659774, 924.089771574998, 985.1232403161192, 1019.9545465897367, 1022.8619136416637, 1030.9587616495255, 6053.303870055, 6131.570790044743, 6303.590266632654, 6309.211348581427, 6346.0, 919.0946917286467, 921.9354645174774, 923.3674932671007, 931.2224292715523, 1039.4958445154093, 4000.959990400117, 4106.630403263721, 4279.850205242801, 4282.6359759420175, 4351.97824010878, 11234.55061797519, 11541.596044138583, 11585.304881707125, 11587.942060289644, 11596.88403115958, 11301.434928253719, 11342.319460832376, 11383.260088094248, 11431.085513158927, 11448.141389395829, 8220.013598368234, 8306.916930830736, 8438.704645337384, 8468.534230617375, 8478.872816907751, 6017.939820601738, 6100.511959043355, 6108.205933228652, 6229.190205273286, 6235.282942461675, 10537.367757934548, 10608.416537090225, 10636.149108071491, 10672.786544269227, 10747.408892510986, 10482.37105773656, 10675.786484270426, 10829.0, 10869.456527173768, 10965.50655220533, 7473.701051958078, 7534.284242996907, 7547.396208303432, 7594.468387212842, 7601.505902116345, 8207.302379297827, 8285.130061343472, 8351.95824020876, 8387.161283871565, 8414.453060551044, 7517.73687920942, 7615.048118985127, 7708.267714567107, 7723.845523089394, 7801.063872335356, 7510.39916806665, 7521.8871716923195, 7524.360429363565, 7692.230776922487, 7715.189905060112, 7079.39825114871, 7141.392981596622, 7173.928260717535, 7186.281371862981, 7216.7113315466795, 5030.496950305087, 5184.688918664892, 5192.299039629602, 5218.26944227816, 5263.973525162556, 5213.45258747826, 5297.655652382583, 5376.811811586732, 5416.783328666967, 5556.472135147154], "value": 4740.816161341648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.0228558610204, 328.2466738834375, 328.52364072095463, 330.4712460063897, 332.49958811987955, 5470.5623550116, 5518.503334699882, 5547.948628254464, 5551.639143455673, 5554.833354999351, 5410.269613602162, 5436.0, 5456.836294911159, 5457.808976685817, 5462.808801691932, 4075.4294398784195, 4273.529911709709, 4286.592773686511, 4287.656987441005, 4290.849820256291, 4232.640225580829, 4238.449001629784, 4244.427002354689, 4272.636825869805, 4280.614744672979, 4232.640225580829, 4237.703360764748, 4243.599612128006, 4256.318754092132, 4279.74321540707, 4115.32097203961, 4224.66202703783, 4227.175700738358, 4231.788410579474, 4251.914961700749, 3678.3562876496508, 3684.9078773030888, 3685.1892583631557, 3689.409694448902, 3695.815209239527, 5190.482615931271, 5223.947760522384, 5233.21501774733, 5294.708791016493, 5323.281357016792, 4713.505081966413, 4791.233402655594, 4799.808007679689, 4817.735024573647, 4820.566149046603, 5697.5500534770035, 5739.9381114493535, 5741.45456181662, 5744.770209191627, 5763.567732420085, 4046.109855831712, 4062.5937406259136, 4072.75563466193, 4074.124063326369, 4094.529129150156, 5680.4319568043275, 5719.827435375738, 5889.8822023559715, 5926.970365148147, 5992.910106348409, 4131.834726610902, 4154.086101057763, 4168.916621667549, 4173.728707633994, 4173.937390939138, 4181.874543763692, 4192.559781222928, 4192.664586833046, 4232.407462955189, 4248.957510424856, 4576.313552967015, 4796.928046079312, 4798.640101992295, 4810.42274927011, 4834.661573689878, 5608.569814697307, 5630.099184130601, 5702.372738998707, 5716.657000579979, 5790.002449155035, 1430.399232322427, 1439.560933915145, 1442.725882082401, 1443.4947768281227, 1454.6726986427968, 900.3382513852313, 933.8140561486873, 939.6382392778829, 942.58997336159, 952.9571169297399, 4962.578180854668, 4977.950220497821, 4995.850124496198, 5010.69935803853, 5019.548240658358, 5107.897842043139, 5174.068667639861, 5228.627535239749, 5231.581473482189, 5236.847893463432, 5028.522290382408, 5031.22016087507, 5044.697318160922, 5127.000704587858, 5609.775608975595, 3096.4116817804547, 3131.4833052546533, 3161.65221825599, 3174.1747145742274, 3177.459831828595, 6033.125196846433, 6166.537509686791, 6207.503399728011, 6219.906701399483, 6247.0, 5905.232319798399, 6028.125921741323, 6081.452669259788, 6083.6045657032155, 6145.0, 6193.566450348522, 6196.605763703131, 6238.970569856105, 6240.846907816796, 6256.843578910563, 5868.2664666916635, 5878.30286580983, 5901.232839730807, 5956.821295361146, 6006.33930267679, 5631.887362252814, 5736.795272992718, 5889.911651325147, 5924.7926322578505, 5941.435563621449, 6131.96934015327, 6138.0, 6143.72353244114, 6161.353057928853, 6187.504999599932, 4122.113745544602, 4131.710780245354, 4200.264953633163, 4205.264078786139, 4222.514410842792, 5691.914621280767, 5835.79574714883, 5843.29880414336, 5897.41025897424, 6007.339192688888, 5672.461116193955, 5704.286964129484, 5721.742521586455, 5726.312842458931, 5728.856778580569, 5510.0, 5711.771529138788, 5715.371309155907, 5755.971220143872, 5770.798022069207, 5586.245856809279, 5623.69069701154, 5657.660540367591, 5663.518600918803, 5720.971395142998, 5716.485516303553, 5811.215485909348, 5813.273340832396, 5818.44724751148, 5871.882562348815, 5379.924015196898, 5654.293213348332, 5661.603687741818, 5740.827775166752, 5751.980210389579], "value": 4326.152728519555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.4275246893915, 826.6734639817272, 838.3837879158818, 855.5465603230286, 866.33292364879, 12128.757424851508, 12639.620811375651, 12695.492180312776, 12763.0, 12777.0, 11735.237209581393, 11756.588519401823, 11840.76318473632, 12710.809337859939, 12731.936340318285, 794.1026639896909, 799.3804801278997, 805.8630032894422, 805.907320658126, 806.9112397636255, 794.3248238996864, 795.7055889320959, 796.55791035975, 797.4139007829241, 798.2616080125889, 833.7165363776314, 836.1805430677939, 837.4975014991018, 838.4047326398264, 840.7435732101737, 829.9626516806758, 832.7793134819308, 833.5832083958021, 834.5284914023588, 835.5696816139663, 607.5261296188979, 610.6519284008117, 610.9725062372204, 611.1932249430753, 612.8988716861712, 11951.342676152808, 12146.210496317712, 12166.57416990401, 12184.086193535431, 12528.0, 12295.69260768479, 12314.384280786015, 12353.135280530367, 12446.190997585129, 12467.812982805266, 11471.426428678617, 11563.653090407217, 11913.093904975163, 11969.64091077269, 12133.090018248668, 4258.212230737293, 4271.67962402821, 4279.957200428018, 4304.418903448026, 4478.0596074824325, 54528.0, 55132.17301740477, 58192.41807581912, 60009.6999515004, 60768.0, 10013.949930250303, 10048.145907597936, 10202.33684810485, 10203.642872499428, 10386.42874641902, 17987.1006449677, 17988.64022719538, 17993.910030449762, 18005.909970450062, 18030.188641511162, 7467.514611550232, 7491.213422590658, 7958.243966823143, 7988.041435027718, 8081.232282933112, 4458.398116254329, 4462.732236065846, 4474.6867719259335, 4498.3252512123445, 4537.77311134442, 3218.951715724266, 3325.833708314575, 3328.5839270091237, 3330.3672302262976, 3349.1794510344635, 649.555054787472, 668.5921587831419, 690.6374153569316, 694.1046050594778, 701.9227884932653, 719.3957076056138, 741.6143605325201, 747.7532414303267, 768.0859776865624, 785.3010820369875, 8813.735587932373, 8919.197272245528, 8970.86543701845, 9009.684661036963, 9023.142801433853, 737.4690223039403, 753.7098217186423, 760.9309514609218, 772.6059709548058, 774.7017398301695, 4271.722338048017, 4470.173017991617, 4484.820607175677, 4528.615067719281, 4584.312353147055, 70350.29649703437, 74588.25411745922, 75759.0, 76033.61983190049, 78264.0, 48845.26732099021, 52562.73718631459, 61830.0, 66251.0, 66622.0, 53826.0, 53913.1913021305, 54076.18885716717, 54097.0, 54244.999999999214, 9114.40756350835, 9311.022342653923, 9312.394694344846, 9375.906240937777, 9415.85876211871, 35670.108247294025, 36137.0, 36180.0, 36218.63781362153, 37012.44481332836, 44803.551964479935, 47639.0, 48428.75785621049, 49166.0, 49709.50290497193, 11112.333260004425, 11715.531378744754, 12046.698832529257, 12070.155089143676, 12384.071194660257, 12718.173318734252, 12727.0, 12880.935595321964, 12890.935545322214, 13000.349982500647, 11950.257204215222, 12041.277523348626, 12137.757244854876, 12413.379331033231, 12622.0, 11705.941470292593, 12102.0, 12143.271403715806, 12211.145219834527, 12479.0, 11518.82721759191, 11566.30602163873, 11981.460834262654, 12216.144869859025, 12567.560135395217, 9827.361221520578, 10303.896961030294, 10308.536115874653, 10410.011048950337, 10567.52446139941, 10217.0, 10366.585336586451, 10410.843837342598, 10466.110380617733, 10630.362178269019], "value": 6710.999311385209, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 111.0, 112.0, 112.0, 114.0, 114.0, 113.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 158.0, 193.0, 125.0, 158.0, 153.0, 132.0, 190.0, 126.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 165.0, 166.0, 166.0, 162.0, 162.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 161.0, 76.0, 74.0, 75.0, 76.0, 180.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 145.0, 83.0, 83.0, 82.0, 144.0, 83.0, 83.0, 138.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 149.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 55.0, 57.0, 54.0, 54.0, 55.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 80.0, 81.0, 80.0, 80.0, 81.0, 105.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 129.0, 128.0, 131.0, 122.0, 132.0, 128.0, 145.0, 132.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 168.0, 162.0, 161.0, 162.0, 160.0, 160.0, 160.0, 163.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 69.0, 62.0, 68.0, 65.0, 66.0, 63.0, 65.0, 62.0], "value": 64.8, "unit": "score"}]}]} 22:31:17 INFO - Return code: 0 22:31:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:31:17 ERROR - # TBPL SUCCESS # 22:31:17 INFO - Running post-action listener: _resource_record_post_action 22:31:17 INFO - ##### 22:31:17 INFO - ##### Finished run-tests step (success) 22:31:17 INFO - ##### 22:31:17 INFO - Running post-run listener: _resource_record_post_run 22:31:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7966720; Write bytes: 376881152; Read time: 2248; Write time: 395624 22:31:17 INFO - TinderboxPrint: CPU usage
13.5% 22:31:17 INFO - TinderboxPrint: I/O read bytes / time
7,966,720 / 2,248 22:31:17 INFO - TinderboxPrint: I/O write bytes / time
376,881,152 / 395,624 22:31:17 INFO - TinderboxPrint: CPU idle
8,242.8 (86.5%) 22:31:17 INFO - TinderboxPrint: CPU user
1,222.7 (12.8%) 22:31:17 INFO - TinderboxPrint: Swap in / out
0 / 0 22:31:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 2621440; Read time: 0; Write time: 4728 22:31:17 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 7966720; Write bytes: 374259712; Read time: 2248; Write time: 390896 22:31:18 INFO - Running post-run listener: _upload_blobber_files 22:31:18 INFO - Blob upload gear active. 22:31:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:31:18 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 22:31:18 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'] 22:31:18 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 22:31:18 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:19 INFO - (blobuploader) - INFO - Done attempting. 22:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:24 INFO - (blobuploader) - INFO - Done attempting. 22:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:25 INFO - (blobuploader) - INFO - Done attempting. 22:31:25 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:25 INFO - Return code: 0 22:31:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:31:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8d7420987b23b380f6f685c0c603edfc22846ace1ce4ae31d29fd0aef43ac9e3d4682fb690b2f9963f60797a052e36108535e317c7604a98e5a40a5cde1a5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63711604b74cc99fa141cc0fbd11aa30f85a7d441835c850ff45589d1dae00c533729ffd834838b263402cd25c8eb3b93f5e12104ecffd262ac1f5d1f105b32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bfc55d81d3f5deaf3f70b1f95533fea582cfe2c81bf5ee0a3488218f4d3adacad18b64631fb430ad7bc13fbaf4c0caecd44f2bbe9f1f796a62c68567c370bd9a"} 22:31:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:31:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:31:25 INFO - Contents: 22:31:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8d7420987b23b380f6f685c0c603edfc22846ace1ce4ae31d29fd0aef43ac9e3d4682fb690b2f9963f60797a052e36108535e317c7604a98e5a40a5cde1a5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63711604b74cc99fa141cc0fbd11aa30f85a7d441835c850ff45589d1dae00c533729ffd834838b263402cd25c8eb3b93f5e12104ecffd262ac1f5d1f105b32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bfc55d81d3f5deaf3f70b1f95533fea582cfe2c81bf5ee0a3488218f4d3adacad18b64631fb430ad7bc13fbaf4c0caecd44f2bbe9f1f796a62c68567c370bd9a"} 22:31:25 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:25 INFO - Copying logs to upload dir... 22:31:25 INFO - mkdir: /builds/slave/test/build/upload/logs 22:31:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.669412 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-29 22:31:25.702707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 22:31:25.706001) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 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/d8d7420987b23b380f6f685c0c603edfc22846ace1ce4ae31d29fd0aef43ac9e3d4682fb690b2f9963f60797a052e36108535e317c7604a98e5a40a5cde1a5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63711604b74cc99fa141cc0fbd11aa30f85a7d441835c850ff45589d1dae00c533729ffd834838b263402cd25c8eb3b93f5e12104ecffd262ac1f5d1f105b32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bfc55d81d3f5deaf3f70b1f95533fea582cfe2c81bf5ee0a3488218f4d3adacad18b64631fb430ad7bc13fbaf4c0caecd44f2bbe9f1f796a62c68567c370bd9a"} build_url:https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/B4QmiulkRPaU-Ig7fMHMjg/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/d8d7420987b23b380f6f685c0c603edfc22846ace1ce4ae31d29fd0aef43ac9e3d4682fb690b2f9963f60797a052e36108535e317c7604a98e5a40a5cde1a5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63711604b74cc99fa141cc0fbd11aa30f85a7d441835c850ff45589d1dae00c533729ffd834838b263402cd25c8eb3b93f5e12104ecffd262ac1f5d1f105b32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bfc55d81d3f5deaf3f70b1f95533fea582cfe2c81bf5ee0a3488218f4d3adacad18b64631fb430ad7bc13fbaf4c0caecd44f2bbe9f1f796a62c68567c370bd9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 22:31:25.738274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:31:25.738656) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464584868.772384-2144112825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:31:25.821401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 22:31:25.821760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 22:31:25.822092) ========= ========= Total master_lag: 0.22 =========