builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1464575416.09 results: success (0) buildid: 20160529163013 builduid: 96cbdde24957470fa55e47d0c2f5d90b revision: 0d7674be600defa53a0721874b75731d56c09fc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.091974) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.092690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.092998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.186889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.187343) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 19:30:16-- 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% 224M=0s 2016-05-29 19:30:16 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076885 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.289258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.289561) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017458 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:16.343014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 19:30:16.343894) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0d7674be600defa53a0721874b75731d56c09fc7 --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 0d7674be600defa53a0721874b75731d56c09fc7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 19:30:16,830 truncating revision to first 12 chars 2016-05-29 19:30:16,830 Setting DEBUG logging. 2016-05-29 19:30:16,830 attempt 1/10 2016-05-29 19:30:16,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0d7674be600d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 19:30:17,542 unpacking tar archive at: mozilla-inbound-0d7674be600d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.055256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 19:30:17.414294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:17.414628) ========= script_repo_revision: 0d7674be600defa53a0721874b75731d56c09fc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:17.415092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:17.415381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 19:30:17.424501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-29 19:30:17.424854) ========= /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=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:30:17 INFO - MultiFileLogger online at 20160529 19:30:17 in /builds/slave/test 19:30:17 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 19:30:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:30:17 INFO - {'append_to_log': False, 19:30:17 INFO - 'base_work_dir': '/builds/slave/test', 19:30:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:30:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:30:17 INFO - 'branch': 'Mozilla-Inbound', 19:30:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:30:17 INFO - 'config_files': ('talos/linux_config.py',), 19:30:17 INFO - 'default_actions': ('clobber', 19:30:17 INFO - 'read-buildbot-config', 19:30:17 INFO - 'download-and-extract', 19:30:17 INFO - 'populate-webroot', 19:30:17 INFO - 'create-virtualenv', 19:30:17 INFO - 'install', 19:30:17 INFO - 'run-tests'), 19:30:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:30:17 INFO - 'download_minidump_stackwalk': True, 19:30:17 INFO - 'download_symbols': 'ondemand', 19:30:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:30:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:30:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:30:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:30:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:30:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:30:17 INFO - 'installer_path': 'installer.exe', 19:30:17 INFO - 'log_level': 'info', 19:30:17 INFO - 'log_name': 'talos', 19:30:17 INFO - 'log_to_console': True, 19:30:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:30:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:30:17 INFO - 'opt_config_files': (), 19:30:17 INFO - 'pip_index': False, 19:30:17 INFO - 'sps_profile': False, 19:30:17 INFO - 'sps_profile_interval': 0, 19:30:17 INFO - 'suite': 'dromaeojs-e10s', 19:30:17 INFO - 'system_bits': '32', 19:30:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:30:18 INFO - 'title': 'talos-linux64-ix-008', 19:30:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:30:18 INFO - 'use_talos_json': True, 19:30:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:30:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:30:18 INFO - 'work_dir': 'build'} 19:30:18 INFO - ##### 19:30:18 INFO - ##### Running clobber step. 19:30:18 INFO - ##### 19:30:18 INFO - Running pre-action listener: _resource_record_pre_action 19:30:18 INFO - Running main action method: clobber 19:30:18 INFO - rmtree: /builds/slave/test/build 19:30:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:30:18 INFO - Running post-action listener: _resource_record_post_action 19:30:18 INFO - ##### 19:30:18 INFO - ##### Finished clobber step (success) 19:30:18 INFO - ##### 19:30:18 INFO - ##### 19:30:18 INFO - ##### Running read-buildbot-config step. 19:30:18 INFO - ##### 19:30:18 INFO - Running pre-action listener: _resource_record_pre_action 19:30:18 INFO - Running main action method: read_buildbot_config 19:30:18 INFO - Using buildbot properties: 19:30:18 INFO - { 19:30:18 INFO - "project": "", 19:30:18 INFO - "product": "firefox", 19:30:18 INFO - "script_repo_revision": "production", 19:30:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:30:18 INFO - "repository": "", 19:30:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:30:18 INFO - "buildid": "20160529163013", 19:30:18 INFO - "pgo_build": "True", 19:30:18 INFO - "basedir": "/builds/slave/test", 19:30:18 INFO - "buildnumber": 752, 19:30:18 INFO - "slavename": "talos-linux64-ix-008", 19:30:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:30:18 INFO - "platform": "ubuntu64_hw", 19:30:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:30:18 INFO - "branch": "mozilla-inbound", 19:30:18 INFO - "repo_path": "integration/mozilla-inbound", 19:30:18 INFO - "revision": "0d7674be600defa53a0721874b75731d56c09fc7", 19:30:18 INFO - "stage_platform": "linux64-pgo", 19:30:18 INFO - "builduid": "96cbdde24957470fa55e47d0c2f5d90b", 19:30:18 INFO - "slavebuilddir": "test" 19:30:18 INFO - } 19:30:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:30:18 INFO - Running post-action listener: _resource_record_post_action 19:30:18 INFO - ##### 19:30:18 INFO - ##### Finished read-buildbot-config step (success) 19:30:18 INFO - ##### 19:30:18 INFO - ##### 19:30:18 INFO - ##### Running download-and-extract step. 19:30:18 INFO - ##### 19:30:18 INFO - Running pre-action listener: _resource_record_pre_action 19:30:18 INFO - Running main action method: download_and_extract 19:30:18 INFO - mkdir: /builds/slave/test/build/tests 19:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:18 INFO - https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:27 INFO - Downloaded 1361 bytes. 19:30:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:30:27 INFO - Using the following test package requirements: 19:30:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:30:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:30:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'jsshell-linux-x86_64.zip'], 19:30:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:30:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:30:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:30:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:30:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:30:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:27 INFO - https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:28 INFO - Downloaded 24410047 bytes. 19:30:28 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'] 19:30:28 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 19:30:29 INFO - Return code: 0 19:30:29 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 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:29 INFO - https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:31 INFO - Downloaded 24410047 bytes. 19:30:31 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'] 19:30:31 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 19:30:33 INFO - Return code: 0 19:30:33 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')]} 19:30:33 INFO - https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:34 INFO - Downloaded 10834055 bytes. 19:30:34 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'] 19:30:34 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 19:30:34 INFO - Return code: 0 19:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:34 INFO - https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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 19:30:36 INFO - Downloaded 58801783 bytes. 19:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:30:36 INFO - mkdir: /builds/slave/test/properties 19:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:36 INFO - Contents: 19:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:30:37 INFO - Running post-action listener: _resource_record_post_action 19:30:37 INFO - Running post-action listener: set_extra_try_arguments 19:30:37 INFO - ##### 19:30:37 INFO - ##### Finished download-and-extract step (success) 19:30:37 INFO - ##### 19:30:37 INFO - ##### 19:30:37 INFO - ##### Running populate-webroot step. 19:30:37 INFO - ##### 19:30:37 INFO - Running pre-action listener: _resource_record_pre_action 19:30:37 INFO - Running main action method: populate_webroot 19:30:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:30:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:30:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:30:37 INFO - '--tppagecycles', 19:30:37 INFO - '7'], 19:30:37 INFO - 'tests': ['tsvgm']}}, 19:30:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:30:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:30:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['damp', 'tps']}, 19:30:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'tests': ['damp', 'tps']}, 19:30:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['dromaeo_dom']}, 19:30:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['a11yr', 19:30:37 INFO - 'ts_paint', 19:30:37 INFO - 'tpaint', 19:30:37 INFO - 'sessionrestore', 19:30:37 INFO - 'sessionrestore_no_auto_restore', 19:30:37 INFO - 'tabpaint']}, 19:30:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['tsvgx', 19:30:37 INFO - 'tsvgr_opacity', 19:30:37 INFO - 'tart', 19:30:37 INFO - 'tscrollx', 19:30:37 INFO - 'cart']}, 19:30:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:37 INFO - 'tsvgr_opacity', 19:30:37 INFO - 'tart', 19:30:37 INFO - 'tscrollx', 19:30:37 INFO - 'cart']}, 19:30:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'talos_options': ['--disable-e10s'], 19:30:37 INFO - 'tests': ['tp5o']}, 19:30:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'tests': ['tp5o']}, 19:30:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'talos_options': ['--disable-e10s', 19:30:37 INFO - '--xperf_path', 19:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:37 INFO - 'tests': ['tp5n']}, 19:30:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:37 INFO - 'talos_options': ['--xperf_path', 19:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:37 INFO - 'tests': ['tp5n']}}, 19:30:37 INFO - 'talos.zip': {'path': '', 19:30:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:30:37 INFO - Running post-action listener: _resource_record_post_action 19:30:37 INFO - ##### 19:30:37 INFO - ##### Finished populate-webroot step (success) 19:30:37 INFO - ##### 19:30:37 INFO - ##### 19:30:37 INFO - ##### Running create-virtualenv step. 19:30:37 INFO - ##### 19:30:37 INFO - Running pre-action listener: _resource_record_pre_action 19:30:37 INFO - Running main action method: create_virtualenv 19:30:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:37 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 19:30:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:30:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:37 INFO - Using real prefix '/usr' 19:30:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:39 INFO - Installing pip.................done. 19:30:39 INFO - Return code: 0 19:30:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:30:39 INFO - Using env: {'DISPLAY': ':0', 19:30:39 INFO - 'HOME': '/home/cltbld', 19:30:39 INFO - 'LANG': 'en_US.UTF-8', 19:30:39 INFO - 'LANGUAGE': 'en_US:en', 19:30:39 INFO - 'LOGNAME': 'cltbld', 19:30:39 INFO - 'MAIL': '/var/mail/cltbld', 19:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:39 INFO - 'MOZ_NO_REMOTE': '1', 19:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:39 INFO - 'NO_EM_RESTART': '1', 19:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:39 INFO - 'PWD': '/builds/slave/test', 19:30:39 INFO - 'SHELL': '/bin/bash', 19:30:39 INFO - 'SHLVL': '1', 19:30:39 INFO - 'TERM': 'linux', 19:30:39 INFO - 'TMOUT': '86400', 19:30:39 INFO - 'USER': 'cltbld', 19:30:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:39 INFO - '_': '/tools/buildbot/bin/python'} 19:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:40 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 19:30:40 INFO - Cleaning up... 19:30:40 INFO - Return code: 0 19:30:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30: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')]} 19:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:40 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:40 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 19:30:40 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 19:30:40 INFO - Using env: {'DISPLAY': ':0', 19:30:40 INFO - 'HOME': '/home/cltbld', 19:30:40 INFO - 'LANG': 'en_US.UTF-8', 19:30:40 INFO - 'LANGUAGE': 'en_US:en', 19:30:40 INFO - 'LOGNAME': 'cltbld', 19:30:40 INFO - 'MAIL': '/var/mail/cltbld', 19:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:40 INFO - 'MOZ_NO_REMOTE': '1', 19:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:40 INFO - 'NO_EM_RESTART': '1', 19:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:40 INFO - 'PWD': '/builds/slave/test', 19:30:40 INFO - 'SHELL': '/bin/bash', 19:30:40 INFO - 'SHLVL': '1', 19:30:40 INFO - 'TERM': 'linux', 19:30:40 INFO - 'TMOUT': '86400', 19:30:40 INFO - 'USER': 'cltbld', 19:30:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:40 INFO - '_': '/tools/buildbot/bin/python'} 19:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:40 INFO - Downloading/unpacking psutil>=3.1.1 19:30:40 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 19:30:40 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 19:30:40 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 19:30:40 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 19:30:40 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 19:30:40 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 19:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:42 INFO - Installing collected packages: psutil 19:30:42 INFO - Running setup.py install for psutil 19:30:42 INFO - building 'psutil._psutil_linux' extension 19:30:42 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 19:30:42 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 19:30:42 INFO - building 'psutil._psutil_posix' extension 19:30:42 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 19:30:42 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 19:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:42 INFO - Successfully installed psutil 19:30:42 INFO - Cleaning up... 19:30:42 INFO - Return code: 0 19:30:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:42 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:42 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 19:30:42 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 19:30:42 INFO - Using env: {'DISPLAY': ':0', 19:30:42 INFO - 'HOME': '/home/cltbld', 19:30:42 INFO - 'LANG': 'en_US.UTF-8', 19:30:42 INFO - 'LANGUAGE': 'en_US:en', 19:30:42 INFO - 'LOGNAME': 'cltbld', 19:30:42 INFO - 'MAIL': '/var/mail/cltbld', 19:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:42 INFO - 'MOZ_NO_REMOTE': '1', 19:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:42 INFO - 'NO_EM_RESTART': '1', 19:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:42 INFO - 'PWD': '/builds/slave/test', 19:30:42 INFO - 'SHELL': '/bin/bash', 19:30:42 INFO - 'SHLVL': '1', 19:30:42 INFO - 'TERM': 'linux', 19:30:42 INFO - 'TMOUT': '86400', 19:30:42 INFO - 'USER': 'cltbld', 19:30:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:42 INFO - '_': '/tools/buildbot/bin/python'} 19:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:30:43 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 19:30:43 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 19:30:43 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 19:30:43 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 19:30:43 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 19:30:43 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 19:30:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:30:44 INFO - Installing collected packages: mozsystemmonitor 19:30:44 INFO - Running setup.py install for mozsystemmonitor 19:30:45 INFO - Successfully installed mozsystemmonitor 19:30:45 INFO - Cleaning up... 19:30:45 INFO - Return code: 0 19:30:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:30:45 INFO - Using env: {'DISPLAY': ':0', 19:30:45 INFO - 'HOME': '/home/cltbld', 19:30:45 INFO - 'LANG': 'en_US.UTF-8', 19:30:45 INFO - 'LANGUAGE': 'en_US:en', 19:30:45 INFO - 'LOGNAME': 'cltbld', 19:30:45 INFO - 'MAIL': '/var/mail/cltbld', 19:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:45 INFO - 'MOZ_NO_REMOTE': '1', 19:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:45 INFO - 'NO_EM_RESTART': '1', 19:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:45 INFO - 'PWD': '/builds/slave/test', 19:30:45 INFO - 'SHELL': '/bin/bash', 19:30:45 INFO - 'SHLVL': '1', 19:30:45 INFO - 'TERM': 'linux', 19:30:45 INFO - 'TMOUT': '86400', 19:30:45 INFO - 'USER': 'cltbld', 19:30:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:45 INFO - '_': '/tools/buildbot/bin/python'} 19:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:30:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:47 INFO - Downloading docopt-0.6.1.tar.gz 19:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:30:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:30:48 INFO - Running setup.py install for blobuploader 19:30:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:30:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:30:48 INFO - Running setup.py install for requests 19:30:48 INFO - Running setup.py install for docopt 19:30:48 INFO - Successfully installed blobuploader requests docopt 19:30:48 INFO - Cleaning up... 19:30:48 INFO - Return code: 0 19:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:48 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 19:30:48 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 19:30:48 INFO - Using env: {'DISPLAY': ':0', 19:30:48 INFO - 'HOME': '/home/cltbld', 19:30:48 INFO - 'LANG': 'en_US.UTF-8', 19:30:48 INFO - 'LANGUAGE': 'en_US:en', 19:30:48 INFO - 'LOGNAME': 'cltbld', 19:30:48 INFO - 'MAIL': '/var/mail/cltbld', 19:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:48 INFO - 'MOZ_NO_REMOTE': '1', 19:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:48 INFO - 'NO_EM_RESTART': '1', 19:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:48 INFO - 'PWD': '/builds/slave/test', 19:30:48 INFO - 'SHELL': '/bin/bash', 19:30:48 INFO - 'SHLVL': '1', 19:30:48 INFO - 'TERM': 'linux', 19:30:48 INFO - 'TMOUT': '86400', 19:30:48 INFO - 'USER': 'cltbld', 19:30:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:48 INFO - '_': '/tools/buildbot/bin/python'} 19:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:48 INFO - Running setup.py (path:/tmp/pip-EAV85K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:48 INFO - Running setup.py (path:/tmp/pip-0132IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:48 INFO - Running setup.py (path:/tmp/pip-PdUsAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:49 INFO - Running setup.py (path:/tmp/pip-BXXD0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:49 INFO - Running setup.py (path:/tmp/pip-NgKWnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:49 INFO - Running setup.py (path:/tmp/pip-vzOmml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:49 INFO - Running setup.py (path:/tmp/pip-ZkIoCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:49 INFO - Running setup.py (path:/tmp/pip-77upiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:49 INFO - Running setup.py (path:/tmp/pip-babCe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:49 INFO - Running setup.py (path:/tmp/pip-zIJT_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:49 INFO - Running setup.py (path:/tmp/pip-wVOp8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:49 INFO - Running setup.py (path:/tmp/pip-D9e882-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:49 INFO - Running setup.py (path:/tmp/pip-FfBUjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:49 INFO - Running setup.py (path:/tmp/pip-JBTtWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:49 INFO - Running setup.py (path:/tmp/pip-LO1CYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:49 INFO - Running setup.py (path:/tmp/pip-MjXoY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:49 INFO - Running setup.py (path:/tmp/pip-4U71Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:30:50 INFO - Running setup.py install for manifestparser 19:30:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Running setup.py install for mozcrash 19:30:50 INFO - Running setup.py install for mozdebug 19:30:50 INFO - Running setup.py install for mozdevice 19:30:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Running setup.py install for mozfile 19:30:50 INFO - Running setup.py install for mozhttpd 19:30:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Running setup.py install for mozinfo 19:30:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Running setup.py install for mozInstall 19:30:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:30:50 INFO - Running setup.py install for mozleak 19:30:50 INFO - Running setup.py install for mozlog 19:30:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Running setup.py install for moznetwork 19:30:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Running setup.py install for mozprocess 19:30:51 INFO - Running setup.py install for mozprofile 19:30:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Running setup.py install for mozrunner 19:30:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Running setup.py install for mozscreenshot 19:30:51 INFO - Running setup.py install for moztest 19:30:51 INFO - Running setup.py install for mozversion 19:30:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:30:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:30:51 INFO - Cleaning up... 19:30:51 INFO - Return code: 0 19:30:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:51 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:51 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 19:30:51 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 19:30:51 INFO - Using env: {'DISPLAY': ':0', 19:30:51 INFO - 'HOME': '/home/cltbld', 19:30:51 INFO - 'LANG': 'en_US.UTF-8', 19:30:51 INFO - 'LANGUAGE': 'en_US:en', 19:30:51 INFO - 'LOGNAME': 'cltbld', 19:30:51 INFO - 'MAIL': '/var/mail/cltbld', 19:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:51 INFO - 'MOZ_NO_REMOTE': '1', 19:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:51 INFO - 'NO_EM_RESTART': '1', 19:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:51 INFO - 'PWD': '/builds/slave/test', 19:30:51 INFO - 'SHELL': '/bin/bash', 19:30:51 INFO - 'SHLVL': '1', 19:30:51 INFO - 'TERM': 'linux', 19:30:51 INFO - 'TMOUT': '86400', 19:30:51 INFO - 'USER': 'cltbld', 19:30:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:51 INFO - '_': '/tools/buildbot/bin/python'} 19:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:52 INFO - Running setup.py (path:/tmp/pip-V7Z8l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:52 INFO - Running setup.py (path:/tmp/pip-ggiGsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:52 INFO - Running setup.py (path:/tmp/pip-O8qNLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:52 INFO - Running setup.py (path:/tmp/pip-EdSA9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:52 INFO - Running setup.py (path:/tmp/pip-VnIOBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:52 INFO - Running setup.py (path:/tmp/pip-USDi6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:52 INFO - Running setup.py (path:/tmp/pip-9e17ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:52 INFO - Running setup.py (path:/tmp/pip-h28dxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:52 INFO - Running setup.py (path:/tmp/pip-7xWgAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:52 INFO - Running setup.py (path:/tmp/pip-NxWbr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:52 INFO - Running setup.py (path:/tmp/pip-j8uHjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:52 INFO - Running setup.py (path:/tmp/pip-Gms5MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:52 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)) 19:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:52 INFO - Running setup.py (path:/tmp/pip-dRb0Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:53 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)) 19:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:53 INFO - Running setup.py (path:/tmp/pip-4SZikH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:53 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)) 19:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:53 INFO - Running setup.py (path:/tmp/pip-axxhD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:53 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)) 19:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:53 INFO - Running setup.py (path:/tmp/pip-Mz2Rhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:53 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)) 19:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:53 INFO - Running setup.py (path:/tmp/pip-y6OP6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:53 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)) 19:30:53 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)) 19:30:53 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)) 19:30:53 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)) 19:30:53 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)) 19:30:53 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)) 19:30:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:55 INFO - Downloading blessings-1.6.tar.gz 19:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:30:55 INFO - Installing collected packages: blessings 19:30:55 INFO - Running setup.py install for blessings 19:30:55 INFO - Successfully installed blessings 19:30:55 INFO - Cleaning up... 19:30:55 INFO - Return code: 0 19:30:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:30:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:55 INFO - Reading from file tmpfile_stdout 19:30:55 INFO - Current package versions: 19:30:55 INFO - argparse == 1.2.1 19:30:55 INFO - blessings == 1.6 19:30:55 INFO - blobuploader == 1.2.4 19:30:55 INFO - docopt == 0.6.1 19:30:55 INFO - manifestparser == 1.1 19:30:55 INFO - mozInstall == 1.12 19:30:55 INFO - mozcrash == 0.17 19:30:55 INFO - mozdebug == 0.1 19:30:55 INFO - mozdevice == 0.48 19:30:55 INFO - mozfile == 1.2 19:30:55 INFO - mozhttpd == 0.7 19:30:55 INFO - mozinfo == 0.9 19:30:55 INFO - mozleak == 0.1 19:30:55 INFO - mozlog == 3.2 19:30:55 INFO - moznetwork == 0.27 19:30:55 INFO - mozprocess == 0.22 19:30:55 INFO - mozprofile == 0.28 19:30:55 INFO - mozrunner == 6.11 19:30:55 INFO - mozscreenshot == 0.1 19:30:55 INFO - mozsystemmonitor == 0.3 19:30:55 INFO - moztest == 0.7 19:30:55 INFO - mozversion == 1.4 19:30:55 INFO - psutil == 3.1.1 19:30:55 INFO - requests == 1.2.3 19:30:55 INFO - wsgiref == 0.1.2 19:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:55 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')]} 19:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:55 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')]} 19:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:55 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:55 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 19:30:55 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 19:30:55 INFO - Using env: {'DISPLAY': ':0', 19:30:55 INFO - 'HOME': '/home/cltbld', 19:30:55 INFO - 'LANG': 'en_US.UTF-8', 19:30:55 INFO - 'LANGUAGE': 'en_US:en', 19:30:55 INFO - 'LOGNAME': 'cltbld', 19:30:55 INFO - 'MAIL': '/var/mail/cltbld', 19:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:55 INFO - 'MOZ_NO_REMOTE': '1', 19:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:55 INFO - 'NO_EM_RESTART': '1', 19:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:55 INFO - 'PWD': '/builds/slave/test', 19:30:55 INFO - 'SHELL': '/bin/bash', 19:30:55 INFO - 'SHLVL': '1', 19:30:55 INFO - 'TERM': 'linux', 19:30:55 INFO - 'TMOUT': '86400', 19:30:55 INFO - 'USER': 'cltbld', 19:30:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:55 INFO - '_': '/tools/buildbot/bin/python'} 19:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 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)) 19:30:55 INFO - Cleaning up... 19:30:55 INFO - Return code: 0 19:30:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:30:55 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')]} 19:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:55 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')]} 19:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:55 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:55 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 19:30:55 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 19:30:55 INFO - Using env: {'DISPLAY': ':0', 19:30:55 INFO - 'HOME': '/home/cltbld', 19:30:55 INFO - 'LANG': 'en_US.UTF-8', 19:30:55 INFO - 'LANGUAGE': 'en_US:en', 19:30:55 INFO - 'LOGNAME': 'cltbld', 19:30:55 INFO - 'MAIL': '/var/mail/cltbld', 19:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:55 INFO - 'MOZ_NO_REMOTE': '1', 19:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:55 INFO - 'NO_EM_RESTART': '1', 19:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:55 INFO - 'PWD': '/builds/slave/test', 19:30:55 INFO - 'SHELL': '/bin/bash', 19:30:55 INFO - 'SHLVL': '1', 19:30:55 INFO - 'TERM': 'linux', 19:30:55 INFO - 'TMOUT': '86400', 19:30:55 INFO - 'USER': 'cltbld', 19:30:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:55 INFO - '_': '/tools/buildbot/bin/python'} 19:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:56 INFO - Downloading/unpacking jsonschema 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:57 INFO - Downloading/unpacking functools32 (from jsonschema) 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:58 INFO - warning: no files found matching '*.txt' 19:30:58 INFO - no previously-included directories found matching 'build' 19:30:58 INFO - no previously-included directories found matching 'dist' 19:30:58 INFO - no previously-included directories found matching '.git*' 19:30:58 INFO - Installing collected packages: jsonschema, functools32 19:30:58 INFO - Running setup.py install for functools32 19:30:58 INFO - warning: no files found matching '*.txt' 19:30:58 INFO - no previously-included directories found matching 'build' 19:30:58 INFO - no previously-included directories found matching 'dist' 19:30:58 INFO - no previously-included directories found matching '.git*' 19:30:58 INFO - Successfully installed jsonschema functools32 19:30:58 INFO - Cleaning up... 19:30:58 INFO - Return code: 0 19:30:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:30:58 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')]} 19:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:58 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')]} 19:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:58 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 0x7effc9a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', '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 19:30:58 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 19:30:58 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 19:30:58 INFO - Using env: {'DISPLAY': ':0', 19:30:58 INFO - 'HOME': '/home/cltbld', 19:30:58 INFO - 'LANG': 'en_US.UTF-8', 19:30:58 INFO - 'LANGUAGE': 'en_US:en', 19:30:58 INFO - 'LOGNAME': 'cltbld', 19:30:58 INFO - 'MAIL': '/var/mail/cltbld', 19:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:58 INFO - 'MOZ_NO_REMOTE': '1', 19:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:58 INFO - 'NO_EM_RESTART': '1', 19:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:58 INFO - 'PWD': '/builds/slave/test', 19:30:58 INFO - 'SHELL': '/bin/bash', 19:30:58 INFO - 'SHLVL': '1', 19:30:58 INFO - 'TERM': 'linux', 19:30:58 INFO - 'TMOUT': '86400', 19:30:58 INFO - 'USER': 'cltbld', 19:30:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:58 INFO - '_': '/tools/buildbot/bin/python'} 19:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:58 INFO - Downloading/unpacking flake8 19:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:31:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:31:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:31:01 INFO - no previously-included directories found matching 'docs/_build' 19:31:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:31:01 INFO - Running setup.py install for pep8 19:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:31:01 INFO - no previously-included directories found matching 'docs/_build' 19:31:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:31:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:31:01 INFO - Cleaning up... 19:31:01 INFO - Return code: 0 19:31:01 INFO - Running post-action listener: _resource_record_post_action 19:31:01 INFO - Running post-action listener: _start_resource_monitoring 19:31:01 INFO - Starting resource monitoring. 19:31:01 INFO - ##### 19:31:01 INFO - ##### Finished create-virtualenv step (success) 19:31:01 INFO - ##### 19:31:01 INFO - ##### 19:31:01 INFO - ##### Running install step. 19:31:01 INFO - ##### 19:31:01 INFO - Running pre-action listener: _resource_record_pre_action 19:31:01 INFO - Running main action method: install 19:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:31:01 INFO - Reading from file tmpfile_stdout 19:31:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:31:01 INFO - Reading from file tmpfile_stdout 19:31:01 INFO - Output received: 19:31:01 INFO - Usage: mozinstall [options] installer 19:31:01 INFO - Options: 19:31:01 INFO - -h, --help show this help message and exit 19:31:01 INFO - -d DEST, --destination=DEST 19:31:01 INFO - Directory to install application into. [default: 19:31:01 INFO - "/builds/slave/test"] 19:31:01 INFO - --app=APP Application being installed. [default: firefox] 19:31:01 INFO - mkdir: /builds/slave/test/build/application 19:31:01 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'] 19:31:01 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 19:31:18 INFO - Reading from file tmpfile_stdout 19:31:18 INFO - Output received: 19:31:18 INFO - /builds/slave/test/build/application/firefox/firefox 19:31:18 INFO - Running post-action listener: _resource_record_post_action 19:31:18 INFO - ##### 19:31:18 INFO - ##### Finished install step (success) 19:31:18 INFO - ##### 19:31:18 INFO - ##### 19:31:18 INFO - ##### Running run-tests step. 19:31:18 INFO - ##### 19:31:18 INFO - Running pre-action listener: _resource_record_pre_action 19:31:18 INFO - Running main action method: run_tests 19:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:31:18 INFO - Python 2.7.3 19:31:18 INFO - Return code: 0 19:31:18 INFO - grabbing minidump binary from tooltool 19:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:31:18 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 0xe609c0>, '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 0xe618c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe61d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:31:18 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 19:31:18 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 19:31:18 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 19:31:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:18 INFO - Return code: 0 19:31:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:31:19 INFO - Return code: 0 19:31:19 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/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:31:19 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/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:31:19 INFO - Using env: {'DISPLAY': ':0', 19:31:19 INFO - 'HOME': '/home/cltbld', 19:31:19 INFO - 'LANG': 'en_US.UTF-8', 19:31:19 INFO - 'LANGUAGE': 'en_US:en', 19:31:19 INFO - 'LOGNAME': 'cltbld', 19:31:19 INFO - 'MAIL': '/var/mail/cltbld', 19:31:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:19 INFO - 'MOZ_NO_REMOTE': '1', 19:31:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:19 INFO - 'NO_EM_RESTART': '1', 19:31:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:19 INFO - 'PWD': '/builds/slave/test', 19:31:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:19 INFO - 'SHELL': '/bin/bash', 19:31:19 INFO - 'SHLVL': '1', 19:31:19 INFO - 'TERM': 'linux', 19:31:19 INFO - 'TMOUT': '86400', 19:31:19 INFO - 'USER': 'cltbld', 19:31:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747', 19:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:19 INFO - '_': '/tools/buildbot/bin/python'} 19:31:19 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/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:31:19 INFO - mozversion application_buildid: 20160529163013 19:31:19 INFO - mozversion application_changeset: 0d7674be600defa53a0721874b75731d56c09fc7 19:31:19 INFO - mozversion application_display_name: Nightly 19:31:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:19 INFO - mozversion application_name: Firefox 19:31:19 INFO - mozversion application_remotingname: firefox 19:31:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:31:19 INFO - mozversion application_vendor: Mozilla 19:31:19 INFO - mozversion application_version: 49.0a1 19:31:19 INFO - mozversion platform_buildid: 20160529163013 19:31:19 INFO - mozversion platform_changeset: 0d7674be600defa53a0721874b75731d56c09fc7 19:31:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:31:19 INFO - mozversion platform_version: 49.0a1 19:31:19 INFO - using testdate: 1464575479 19:31:19 INFO - actual date: 1464575479 19:31:19 INFO - starting webserver on 'localhost:41980' 19:31:19 INFO - SUITE-START | Running 2 tests 19:31:19 INFO - TEST-START | dromaeo_css 19:31:19 INFO - operating with platform_type : linux_ 19:31:19 INFO - Initialising browser for dromaeo_css test... 19:31:19 INFO - TEST-INFO | started process 31173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDBom92/profile http://localhost:41980/getInfo.html) 19:31:24 INFO - PROCESS | 31173 | __metrics Screen width/height:1600/1200 19:31:24 INFO - PROCESS | 31173 | colorDepth:24 19:31:24 INFO - PROCESS | 31173 | Browser inner width/height: 1024/697 19:31:24 INFO - PROCESS | 31173 | __metrics 19:31:24 ERROR - PROCESS | 31173 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:31:25 INFO - TEST-INFO | 31173: exit 0 19:31:25 INFO - Browser initialized. 19:31:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:25 INFO - TEST-INFO | started process 31292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDBom92/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:37 INFO - PROCESS | 31292 | RSS: Main: 167411712 19:31:37 INFO - PROCESS | 31292 | 19:32:26 INFO - PROCESS | 31292 | 1464575546966 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] 19:34:34 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41980/tests/dromaeo/cssquery-ext.html) 19:34:35 INFO - PROCESS | 31292 | RSS: Main: 172617728 19:34:35 INFO - PROCESS | 31292 | 19:37:37 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-ext.html (next: http://localhost:41980/tests/dromaeo/cssquery-jquery.html) 19:37:38 INFO - PROCESS | 31292 | RSS: Main: 170119168 19:37:38 INFO - PROCESS | 31292 | 19:40:40 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41980/tests/dromaeo/cssquery-mootools.html) 19:40:41 INFO - PROCESS | 31292 | RSS: Main: 170430464 19:40:41 INFO - PROCESS | 31292 | 19:43:42 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41980/tests/dromaeo/cssquery-prototype.html) 19:43:43 INFO - PROCESS | 31292 | RSS: Main: 168931328 19:43:43 INFO - PROCESS | 31292 | 19:46:46 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41980/tests/dromaeo/cssquery-yui.html) 19:46:46 INFO - PROCESS | 31292 | RSS: Main: 170627072 19:46:46 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | Cycle 1(1): loaded http://localhost:41980/tests/dromaeo/cssquery-yui.html (next: http://localhost:41980/tests/dromaeo/cssquery-dojo.html) 19:49:49 INFO - PROCESS | 31292 | RSS: Main: 171630592 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | __start_tp_report 19:49:49 INFO - PROCESS | 31292 | _x_x_mozilla_page_load 19:49:49 INFO - PROCESS | 31292 | _x_x_mozilla_page_load_details 19:49:49 INFO - PROCESS | 31292 | |i|pagename|runs| 19:49:49 INFO - PROCESS | 31292 | |0;dojo.html;3141.6701246369125;3184.3312904290096;3203.8077715337076;3215.9517607235894;3218.758593105518;5494.642848214863;5525.972370138149;5585.497305242528;5590.972045139769;5606.383297837245;5402.864928376793;5522.475364840334;5529;5554.1946417769395;5604.467575580324;4974.05492956338;5009.148444764399;5096.872578185538;5140.126178549637;5192.065428222918;849.8232335229427;4932.950670493303;4943.1102401567705;5037.622178336621;5075.7715902784275;4954.5540901319055;4958.380202474691;4976.0794253063295;4979.078870408968;4997.325361076263;4999.175136102575;5010.498950104997;5014.949850501521;5025.447200807908;5031.698098114125;4883;4995.475475075137;5012.649114561982;5070.340855688773;5074.137396642543;5478.835634930919;5494.862628434281;5517.062099443105;5523.226748255248;5534.806281780158;5714.914276285859;5965.22452081231;5968.224130863004;5978.2228310319815;5982.4017598239825;5851.268591426072;5883.676397798119;5917.822465326047;5920.1711760353155;6006.249218847644;5486.725663716798;5502.9174562381595;5537.947789919902;5547.889042219133;5550.333959924795;5919.378465261172;6039.516838652898;6108.144859719643;6118.296395914438;6144.78493252734;5822;5865.061590145556;5886.8822623547285;5896.262967129109;5946;5959.344472108065;5967.1347654589845;5972.074328479092;5972.58191926561;5974.671393073423;5595.160725891067;5777.959967205943;5825.883482330414;5926.1999630049395;5950.67271300074;5855.824325270249;5869;5915.940840591539;5930.2883653960935;5976.701164941735;4404.163208990346;4479.59683628475;4481.2381895077915;4489.842855500042;4514.932276015797;3907.081835768592;3925.9607403926166;3948.190620922704;3976.5824588418377;4031.1534577738416;5564.721763911788;5632.3804381518;5694.259746233046;5698.943010569924;5761.423857614289;5989.341172471025;5989.670568118795;6007.549433792396;6017.458428741346;6025.548083893638;5577.163425486128;5651.152327150878;5695.658260504383;5751.884962300731;5757.280339957505;5079.619028572872;5092.6180536459915;5097.1844504879045;5098.1842905135;5153.484651534816;6157.322694503601;6205.844853878599;6206.658633775095;6209.813705588839;6216.285127210429;5877.382874798255;5907.645541267538;5955.553333499918;5963.850903727354;5964.821055368346;6201.930044627938;6218.844528886633;6235.469985051322;6246.781362652286;6259.311475737574;5826.571706310719;5893.6463812171405;5917.852053698692;5924.407559244041;5961.344252132349;5767.250257466502;5820.330661973927;5821.09772985188;5895.64626122434;5907.320658124198;5747;5793.768249270151;5794.304683437846;5809.070548712186;5829.15477255787;5755.251817263897;5769.624974376652;5783.913241301299;5809.448102430262;5825;5549.750261238335;5605.803796867253;5711.114777209539;5718.885622287614;5721.599488035798;5795.478406943395;5829.329627092939;5847.152162936265;5855.9121613176685;5924.407559244041;5659.151127330933;5686.175504551734;5689.630174038674;5701.800436984686;5705.144228365612 19:49:49 INFO - PROCESS | 31292 | |1;ext.html;591.8254115036063;644.8935925572281;655.3675702946657;659.8416380068785;674.3762020131379;41655.79172104139;43609;43892.12215755687;43929.12141757167;47939.0412191756;45767.542324576745;46129;46327;46328;46368.30447543281;8760.8685869712;8880.822383552326;8934.419262747933;8941.061188575204;8966.462012279251;8808.559572021373;8985.14641109097;8989.910100898973;8990.955045224764;8999.775005624879;8989.280857531381;9037.95481022594;9060.411073280216;9071.41035832672;9094.818103637923;8883.111688831097;8966.37235393526;8990.595423205972;9005.459672419644;9009.189172974398;8732.345074119467;8833.823323533557;8840.955795221047;8879.644814207424;8892.3330750194;42320.365194522106;42707.57292427067;42826.57173428257;42856.78571607153;42863.35704964428;3563.394222982099;3645.9453108203397;3664.9816750916075;3666.5966743658178;3772.9622703772884;31829.204269893205;32071.839640801645;32085.51871721926;32268.354632907445;33443.16392090193;4328.826846926119;4339.739615623042;4361.389405483234;4385.7149285296355;4445.9110817783785;328642;329192.35403823067;330331;330343;332957;56694.716526417105;56865.71567142138;57172;57316.42683573111;57484.425155748744;59943.400565994656;60044.399556004755;60314.39685603176;60387.39612603906;60614.696926515964;16769.496915092568;17051.91474042622;17127.400540981005;17131.31474741021;17217.483475495756;12132.878671213175;12140.878591213976;12218.633440996784;12221.266723996589;12264.080193985486;14485.855141448661;15830.445934392472;15890.68218635644;15908.522744317688;15936.442224522087;5071.416787069535;5343.305370301836;5917.437843404869;5924.318703349084;6109.2974307955155;990.5245482168599;1062.2882668612049;1132.371533798733;1137.2323681514945;1220.6887243752785;31584.684153158632;31774.841125794224;31781.841090794398;32004.67995320017;32656.183595410304;1125.983110253347;1134;1137.5279259107378;1162.0703437250165;1278.603632873812;16216.837831621533;16224.188790560425;16587.502374928772;16601.833981660027;16844.66310673804;529326;538836;546919;547626;548857;58345.416545834;58797;58948.7052564743;59084.11373829396;59169.11246331308;1327.3296985022696;1378.4555100735154;1383.840858301288;1385.9514916977857;1390.165900459716;29993.700062999964;31232.843835780677;31410.371792563565;31486;31566.84216578994;49990;50034.749826250634;50380.74809625928;50464.74767626285;50477.242841358144;341224;349760;457422;457958;460385;26850.194494165207;28066;28152.85923570369;40915.59084409118;41030.58969410268;46852.29721554111;48468.5153148464;48863.5113648859;51876;53230.2015469776;39335;40858.182836342516;41030.38454423127;43804.34293485664;45370.77314613406;41090.38364424596;41403.58596413997;41514.792426037675;41891.581084188765;42156.78921605372;39960.80019599883;41245.793771030956;41251.793741031106;41572.58427415687;41629.79185104055;34623.65376346204;36532.81733591315;36578.45132323071;37127.44308835315;37277.81361093177;28248.576271356356;28586.571201432413;28606.713932860406;28765.28086797847;28818.567721483774 19:49:49 INFO - PROCESS | 31292 | |2;jquery.html;399.1637519396863;400.8977710683776;402.18356735826245;406.8087998640639;418.07605192524517;13492.66268343292;18143.818561814376;18575.4427367179;19128.713069303954;19251.133698983544;18276.17757200926;18545.258189672397;19004.90497547514;19136.23455061796;19292.131854066567;5411.323584551931;5448.782048718056;5643.774249030034;5685;5733.598648094635;5691.288588926384;5731.083026715726;5750.626209296403;5851.912221316684;6549.705263263165;6466.224053113633;6495.317991610884;6506;6511.3488651134985;6537.117489138953;5807.767689292445;5812.767489300423;5837.620554663933;5846.590738648275;6480.222373315209;5420.295361603005;5618.213450116987;5646.26598542191;5649.6327738696855;5674.092145256739;13696.52062177819;13960.232187229698;14015.929920350434;14028.71942561143;15407.614809629737;2207.404000919759;2210.204326442479;2247.5617254635354;2426.645282436201;2461.483088551406;9832.90167098327;9833.557489912899;10008.699739007769;10151;10192.59229630814;1887.113056863272;1960.8529360297891;1966.0661185936708;1971.044043638834;1975.2395327798902;80255.59872200602;84749;84996.57501712452;85009.14990850074;85324;10720.571177152826;10775.407352595683;10814.297070690538;10879.891201088047;11213.943930280297;11967.281963082243;12640.683982900317;15403.614909627126;15571.688566228839;15589.610259743371;7450.217727138573;7546.396288296923;7779;7909.09045459768;7962.482438641469;7631.885521717179;7706.961465192639;7786.065672119382;7942.682292708227;7986.201379861967;3939.5666476687543;3972.920541589152;3989.6209860063245;4072.6945479089186;4088.7751173685733;1934.3809980806288;1951.268274397101;1954.9218031278874;2008.648486514854;2030.9385973237177;806.7136166660869;865.1435079271475;879.7096958003843;917.5183028909876;928.0116675740315;14906.627334316512;15364.078155310717;15677.686446271238;15755.369785208693;15872.761908571381;909.2180724576858;914.2320450821342;919.2094798473307;961.2118063188259;990.5542505872386;8079;8482.151784821468;8578.313734901192;8675.913240867636;8695.782605434788;504366;517335;518625;520532;524593;71898;92644;95003.52498237464;95246;96460;987.5506644476745;987.7036888933292;1004.9447280399502;1006.8288390973552;1016.8830584482731;13657;13870.4451821926;13951.58145255644;14074.718505630035;14185.290735463392;41163.7941810301;41192.588074118874;41214.175716486105;41532.79233603933;41597.79201103975;57990.710046449494;58110;59865.10202346881;61183;63492.682536587025;5469.507744303032;6040.697965101639;7787.377009839312;8342.749717508485;8543.579405236442;11998.880011199777;12859.614211573667;13167;13362.265075420944;13373.063885528309;11117.388543630179;11154.49804758804;11319.207655464039;11354.602588909349;11612.419379031184;11163.162762792661;11179.66461006171;11233.831492527455;11754;11921;11414.885851141382;11779.587714429954;11889.702757431134;11921.582744603897;12220.388980551115;8285.58572071382;8445.366597505335;8497.277731392654;8527.275181609633;8744.91255087441;11307.038901693448;11758.176927614984;11824.940875295568;11834.171607987359;11853.5851245206 19:49:49 INFO - PROCESS | 31292 | |3;mootools.html;1498.5579254120034;1529.5411376587022;1712.854407375373;1842.5393651587103;1850.4078694817663;8147.551884646342;8643.827123457535;8657.826843463143;9175.81648367033;9181.586828592712;8733.86899196511;8936;9028.36801423899;9081.818363632723;9099.954500227506;2302.7582103879104;2335.9065637374483;2340.8010319122895;2342.8594284342994;2344.566255242777;2268.534950335177;2279.350385140235;2341.063574570177;2394.449276666368;2399.4241382068353;2347.600907845662;2358.174638876397;2361.102780943239;2387.6299173628117;2390.557746816836;2303.3550605830396;2322.3613506285737;2329.9999999999914;2338.029717667166;2356.375560476475;2273.9090436382526;2279.282026161754;2294.070901284982;2299.7470278269375;2303.8502497337786;9054.094590540959;9164.633414663405;9178.770530736718;9188.816223675489;9209;5148.150555158394;5281.181416880389;5374.838754837361;5386.8922621547745;5391.24522566837;3236.1942515364663;3329.4839299908554;3408;3408.744344174172;3409.6760807723226;1181.4565299962028;1189.108168873345;1206.9396530173544;1227.7648396475263;2197.230969160781;12837.807432888514;12885.67785805353;12888.742225155538;12900.548480803127;12925.806112908314;4643.303504474356;4652.581267685857;4703.623710103184;4867.5132486751045;4910.312556242129;10009.049140331657;10013.649522266685;10024.699259022242;10025.799484010426;10034.548445319979;5382.111951527954;5401.648892821954;5402.91895621566;5411.350637923474;5416.729163541807;4432;4871.537203965618;4969.82605608802;4982.825601104017;5047.621428392812;3757.7181711371754;3842.1547259602844;3864.439656249828;3930.449737036817;3966.0679740261016;1084.203110713625;1159.750653609461;1197.4072833947253;1210.1287073307205;1211.0795795195538;949.9145076943108;995.2485873165858;995.4574756757585;1026.4559783314855;1053.146950969717;6390.360963903572;6413.198350206224;6426.4537514311805;6461.25695545009;6496.155499784998;480.8533397313783;483.3450674336294;495.00998003992015;507.69538277033485;677.9593224406551;4057.269691455507;4084.9183016339507;4112.321466957918;4184.476940382452;4195.706300558993;10643.733906652396;10913.945430272957;11059.834102488468;11115.999560039636;11147.442627868737;10515.684529464128;10815.134789216843;10843.67468975932;10890.183236257313;10962.671119866416;8186.590670466572;8282.751517454606;8383.371247156487;8385.454945428528;8410.78973025667;6178.845528861814;6472.838179045373;6479.611223326616;6499.3175716549085;6499.3175716549085;10318.226133039901;10360.171186305228;10481.213908956706;10487.52806123711;10527.263091583516;10478.842817357898;10629.309094908805;10653.57385704563;10660.307080039773;10663.360198388122;8238.50568965864;8314.62584183701;8329.916700833157;8341.16588341161;8364.163583641588;8556.229939305493;8929.285657147542;8941.239994600532;9232.399894006869;9236.122568355995;7756.495827771177;8026.7591972240925;8273.048599411144;8337.291330236998;8372.246497815226;7651.693932242648;7880.802979925318;7965.800854978672;7996.840063198587;8189.590520474072;7096.112985876765;7097.574145551283;7178.5692858428665;7185.389241914496;7186.820329491805;5170.922436163536;5218.295530103539;5263.36839579253;5271.736413179249;5409.810656626999;5394.002109609734;5411.918821217763;5536.667799932017;5563.248961390161;5684.545236381162 19:49:49 INFO - PROCESS | 31292 | |4;prototype.html;330.9044232843485;338.4888817884994;345.1302717152775;346.18818869750424;347.64713815477313;5458.6724796512135;5476.712972451471;5571.665700057994;5597.412271711468;5667.489925906668;5578.86052848679;5600.85997850054;5603.7478313475885;5606.383297837245;5607.551395888329;4370.147821174872;4375.628071613916;4384.649228061763;4391;4391.516933137353;4069.7354671946227;4356.738595684254;4364.738115713051;4398;4438;4215.515215750197;4265.573442655741;4268.637165840907;4295.78521073945;4299.742015479065;4306.978465107686;4325.9351109733225;4328.63206627437;4360.629346505519;4365.2142614329405;3604.2611264690677;3784.280986612562;3828.2343531293855;3834.635709607611;3850.2299540092095;5391.919121213185;5395.217693434469;5406.135018397077;5414.539764120015;5421.756020979065;4870.196417591093;4908.680935739201;4927.334809800703;4936.333594964705;4948.307236986825;5472.480114389126;5819.73811178498;5822.9417705822825;5836.431969933215;5844.240248767633;4110.753354798721;4154.833806647731;4164.666826653891;4193.370994350841;4195.727277726938;6185.536084793658;6194.4425001749605;6208.068789681539;6210.782622608187;6221.5333849961435;4207.410962465257;4236.322188449833;4246.40550322955;4249.618873865944;4266.552012038754;4303.82784688609;4307.203167413976;4313.856827940598;4316.395704601358;4328.199283132631;4754.595859351924;4908.901821963541;4913.108453245526;4925.482824303396;4978.253262010655;5609.607327487037;5866.7653293868625;5870.911936320958;5892.204552385373;5899.528037756969;1480.5188313797844;1487.4570781664615;1490.9776353354707;1500.8424115467938;1507.8944473886722;925.22281283722;935.0415823780544;943.3396622364372;957.9462591149819;976.3068221562628;4967.801287948441;5002.699838009731;5033.446320904697;5078.984203159383;5081.8475445736685;5288.286081379041;5355.0896347621;5357.0357335679955;5394.541463975527;5430.56555475561;4909.2881532177635;5036.622253331015;5061.974690126526;5094.700851282899;5114.846554603368;2859.8846449884563;2870.8995185168837;2880.1215629233284;2883.5818806272973;2928.68209305809;5442.319710036246;5499.9375234287145;5550.528205102531;5576.581756368289;5590.524805391506;5168.821174977362;5375.489328513785;5394.352677678625;5421.539169170585;5438.483344082306;5431.755570999315;5453.481919217668;5463.852590955864;5478.890422191534;5500.477454641803;4934.988327392947;5221.008008478377;5272.604554658339;5329.493698098674;5367.302250707539;5151.330327057459;5182.0308282852275;5240.877444634929;5241.659292145999;5321.5476684482255;5449.972750136224;5477.561795056306;5503.926734286776;5516.924199781165;5571.192177134212;3753.2493501299305;3833.233353329401;3908.9609103908597;3920.9019774505864;3926.5680775114142;5219.921701174561;5221.321228240305;5356.491133342326;5682.573806964411;5853.619514731528;5839.474447299764;5842.269716285465;5876.147958545901;5877.500412464989;5879.94120058811;5804.158397032491;5819.37057623866;5831.212786273799;5868.413158684098;5896.734646940812;5509.862253443696;5715.8856822864145;5754.625949313281;5765.250517432874;5768.278965129359;5887.911681324869;5902.881942361215;5909.134069976144;5929.85175370602;5964.433378829004;5492.725363731877;5743.4543718346695;5754.251947246831;5777.255803493307;5786.855328616818 19:49:49 INFO - PROCESS | 31292 | |5;yui.html;693.6947742993079;695.6695569604439;727.7671145233527;736.3446532585998;856.1566856646205;14486.855131448696;15512.767308490353;15524.223788810543;15532.145731984736;15586.454474093394;14482;14547.199904005276;14547.636309092251;14580.05229660074;14595.635109122277;804.8148925747067;815.5229190923317;815.64927081355;815.6981916690833;818.6725309876067;812.1350761439078;815.6003558256441;816.1634324817051;817.0848649512554;818.8935438393;864.8918885139358;869.6260607938584;869.7347309070731;869.9739007829744;872.1932212703256;842.465034702965;857.4169564696004;858.952757598335;862.06465984407;862.9568521573896;617.3116974573319;617.6386813713983;617.9907301390438;622.5673157155778;622.9719662615194;14802.185879776607;14822.40710371584;14895.255237238203;14900.254987250593;14958.401663933539;13677.589672309847;13739.313034348243;13796.655083622989;13800.447982080705;13807.928810678479;10820.350778953289;10859.619913302997;11181;11186.216964812467;11215.271007384576;3677.669009789105;3680.3191409589313;3755.8497660093562;3760.4735337052834;3874.0314921269683;45890;46730.299045514344;53528.73235633836;54174.99999999961;61110.38889611136;10774.676759697222;10870.782584348268;10913.508892099875;10988.505517251742;11197.66407007791;17403.912980435016;18482.722759158623;18712.53218669517;18768.53078673044;18805.341813036477;8090.190980901981;8091;8213.425060245725;8294.58527073644;8472.19514146155;4514.841980530666;4573.565511276423;4711.8350857719815;4868.488808675109;4876.292937524039;3415.3852306585054;3483.9477407838904;3488.89533314001;3494.353544594258;3499;616.1097214525058;623.9188905442263;625.3465128940178;632.1087266953665;642.3480167629859;680.9353111454404;720.8053825467094;722.1226210154688;743.5427212264418;746.3767753925533;9272.666822153904;9606.615735370508;9616.663416780379;9644.251388354425;9692.612295508101;727.1020289941918;732.9816754581071;745.8396444764402;761.9428542859308;785.9842803143905;4321.719088259253;4391.956080439155;4577.771111444415;4667.407366810951;4677.204875171229;61405;70110.29889701038;70493.64753176304;71877.28122718706;72119;55520.444795552336;63262.68368658219;65061.349386506474;65189.348106519275;65320.67339663366;52004.47995520072;59112.40887591155;60354.396456035756;60653.39346606566;62528;9667.129958303787;9876.950615246878;9914.851277230702;9937.65218217359;9980.650677226262;35739.46390804192;37421.25157496889;37997.24005519929;38004.29483228225;38058.0485487865;45670.08659826851;48394;52236.477635224684;52403.21395178999;53117.468825311254;12259.816102758288;12332.19840710351;12377.876221238033;12458.750824983268;12554.309512976508;13697.452101915811;14014.649633759238;14030.29848507591;14054.508092216724;14118.364673589918;12652.30412327294;12860.485580577046;12977.740445191232;13139.14595551286;13563.796543051665;13048.41282142287;13242.602721918358;13400.128991615515;13434.596962091153;13741.793873091712;12681.619551413472;12844.93744638449;12849.357532123544;13255.53605623837;13259.469621215429;10183.643572474928;10415.047721521607;10482.52828622729;10730.141588673043;10836.566537338418;10171.440570768678;10549.314294570828;10593.865456619551;10932.125429965425;10982.286151400453 19:49:49 INFO - PROCESS | 31292 | __end_tp_report 19:49:49 INFO - PROCESS | 31292 | __start_cc_report 19:49:49 INFO - PROCESS | 31292 | _x_x_mozilla_cycle_collect,356 19:49:49 INFO - PROCESS | 31292 | __end_cc_report 19:49:49 INFO - PROCESS | 31292 | __startTimestamp1464576589622__endTimestamp 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | ------- Summary: start ------- 19:49:49 INFO - PROCESS | 31292 | Number of tests: 6 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#0] dojo.html Cycles:165 Average:5479.81 Median:5721.60 stddev:739.21 (12.9%) stddev-sans-first:718.36 19:49:49 INFO - PROCESS | 31292 | Values: 3141.7 3184.3 3203.8 3216.0 3218.8 5494.6 5526.0 5585.5 5591.0 5606.4 5402.9 5522.5 5529.0 5554.2 5604.5 4974.1 5009.1 5096.9 5140.1 5192.1 849.8 4933.0 4943.1 5037.6 5075.8 4954.6 4958.4 4976.1 4979.1 4997.3 4999.2 5010.5 5014.9 5025.4 5031.7 4883.0 4995.5 5012.6 5070.3 5074.1 5478.8 5494.9 5517.1 5523.2 5534.8 5714.9 5965.2 5968.2 5978.2 5982.4 5851.3 5883.7 5917.8 5920.2 6006.2 5486.7 5502.9 5537.9 5547.9 5550.3 5919.4 6039.5 6108.1 6118.3 6144.8 5822.0 5865.1 5886.9 5896.3 5946.0 5959.3 5967.1 5972.1 5972.6 5974.7 5595.2 5778.0 5825.9 5926.2 5950.7 5855.8 5869.0 5915.9 5930.3 5976.7 4404.2 4479.6 4481.2 4489.8 4514.9 3907.1 3926.0 3948.2 3976.6 4031.2 5564.7 5632.4 5694.3 5698.9 5761.4 5989.3 5989.7 6007.5 6017.5 6025.5 5577.2 5651.2 5695.7 5751.9 5757.3 5079.6 5092.6 5097.2 5098.2 5153.5 6157.3 6205.8 6206.7 6209.8 6216.3 5877.4 5907.6 5955.6 5963.9 5964.8 6201.9 6218.8 6235.5 6246.8 6259.3 5826.6 5893.6 5917.9 5924.4 5961.3 5767.3 5820.3 5821.1 5895.6 5907.3 5747.0 5793.8 5794.3 5809.1 5829.2 5755.3 5769.6 5783.9 5809.4 5825.0 5549.8 5605.8 5711.1 5718.9 5721.6 5795.5 5829.3 5847.2 5855.9 5924.4 5659.2 5686.2 5689.6 5701.8 5705.1 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#1] ext.html Cycles:180 Average:59383.16 Median:42513.97 stddev:116330.51 (273.6%) stddev-sans-first:116573.11 19:49:49 INFO - PROCESS | 31292 | Values: 591.8 644.9 655.4 659.8 674.4 41655.8 43609.0 43892.1 43929.1 47939.0 45767.5 46129.0 46327.0 46328.0 46368.3 8760.9 8880.8 8934.4 8941.1 8966.5 8808.6 8985.1 8989.9 8991.0 8999.8 8989.3 9038.0 9060.4 9071.4 9094.8 8883.1 8966.4 8990.6 9005.5 9009.2 8732.3 8833.8 8841.0 8879.6 8892.3 42320.4 42707.6 42826.6 42856.8 42863.4 3563.4 3645.9 3665.0 3666.6 3773.0 31829.2 32071.8 32085.5 32268.4 33443.2 4328.8 4339.7 4361.4 4385.7 4445.9 328642.0 329192.4 330331.0 330343.0 332957.0 56694.7 56865.7 57172.0 57316.4 57484.4 59943.4 60044.4 60314.4 60387.4 60614.7 16769.5 17051.9 17127.4 17131.3 17217.5 12132.9 12140.9 12218.6 12221.3 12264.1 14485.9 15830.4 15890.7 15908.5 15936.4 5071.4 5343.3 5917.4 5924.3 6109.3 990.5 1062.3 1132.4 1137.2 1220.7 31584.7 31774.8 31781.8 32004.7 32656.2 1126.0 1134.0 1137.5 1162.1 1278.6 16216.8 16224.2 16587.5 16601.8 16844.7 529326.0 538836.0 546919.0 547626.0 548857.0 58345.4 58797.0 58948.7 59084.1 59169.1 1327.3 1378.5 1383.8 1386.0 1390.2 29993.7 31232.8 31410.4 31486.0 31566.8 49990.0 50034.7 50380.7 50464.7 50477.2 341224.0 349760.0 457422.0 457958.0 460385.0 26850.2 28066.0 28152.9 40915.6 41030.6 46852.3 48468.5 48863.5 51876.0 53230.2 39335.0 40858.2 41030.4 43804.3 45370.8 41090.4 41403.6 41514.8 41891.6 42156.8 39960.8 41245.8 41251.8 41572.6 41629.8 34623.7 36532.8 36578.5 37127.4 37277.8 28248.6 28586.6 28606.7 28765.3 28818.6 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#2] jquery.html Cycles:180 Average:29176.13 Median:41178.19 stddev:85283.27 (207.1%) stddev-sans-first:85495.14 19:49:49 INFO - PROCESS | 31292 | Values: 399.2 400.9 402.2 406.8 418.1 13492.7 18143.8 18575.4 19128.7 19251.1 18276.2 18545.3 19004.9 19136.2 19292.1 5411.3 5448.8 5643.8 5685.0 5733.6 5691.3 5731.1 5750.6 5851.9 6549.7 6466.2 6495.3 6506.0 6511.3 6537.1 5807.8 5812.8 5837.6 5846.6 6480.2 5420.3 5618.2 5646.3 5649.6 5674.1 13696.5 13960.2 14015.9 14028.7 15407.6 2207.4 2210.2 2247.6 2426.6 2461.5 9832.9 9833.6 10008.7 10151.0 10192.6 1887.1 1960.9 1966.1 1971.0 1975.2 80255.6 84749.0 84996.6 85009.1 85324.0 10720.6 10775.4 10814.3 10879.9 11213.9 11967.3 12640.7 15403.6 15571.7 15589.6 7450.2 7546.4 7779.0 7909.1 7962.5 7631.9 7707.0 7786.1 7942.7 7986.2 3939.6 3972.9 3989.6 4072.7 4088.8 1934.4 1951.3 1954.9 2008.6 2030.9 806.7 865.1 879.7 917.5 928.0 14906.6 15364.1 15677.7 15755.4 15872.8 909.2 914.2 919.2 961.2 990.6 8079.0 8482.2 8578.3 8675.9 8695.8 504366.0 517335.0 518625.0 520532.0 524593.0 71898.0 92644.0 95003.5 95246.0 96460.0 987.6 987.7 1004.9 1006.8 1016.9 13657.0 13870.4 13951.6 14074.7 14185.3 41163.8 41192.6 41214.2 41532.8 41597.8 57990.7 58110.0 59865.1 61183.0 63492.7 5469.5 6040.7 7787.4 8342.7 8543.6 11998.9 12859.6 13167.0 13362.3 13373.1 11117.4 11154.5 11319.2 11354.6 11612.4 11163.2 11179.7 11233.8 11754.0 11921.0 11414.9 11779.6 11889.7 11921.6 12220.4 8285.6 8445.4 8497.3 8527.3 8744.9 11307.0 11758.2 11824.9 11834.2 11853.6 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#3] mootools.html Cycles:180 Average:5952.73 Median:2592.24 stddev:3400.59 (131.2%) stddev-sans-first:3393.65 19:49:49 INFO - PROCESS | 31292 | Values: 1498.6 1529.5 1712.9 1842.5 1850.4 8147.6 8643.8 8657.8 9175.8 9181.6 8733.9 8936.0 9028.4 9081.8 9100.0 2302.8 2335.9 2340.8 2342.9 2344.6 2268.5 2279.4 2341.1 2394.4 2399.4 2347.6 2358.2 2361.1 2387.6 2390.6 2303.4 2322.4 2330.0 2338.0 2356.4 2273.9 2279.3 2294.1 2299.7 2303.9 9054.1 9164.6 9178.8 9188.8 9209.0 5148.2 5281.2 5374.8 5386.9 5391.2 3236.2 3329.5 3408.0 3408.7 3409.7 1181.5 1189.1 1206.9 1227.8 2197.2 12837.8 12885.7 12888.7 12900.5 12925.8 4643.3 4652.6 4703.6 4867.5 4910.3 10009.0 10013.6 10024.7 10025.8 10034.5 5382.1 5401.6 5402.9 5411.4 5416.7 4432.0 4871.5 4969.8 4982.8 5047.6 3757.7 3842.2 3864.4 3930.4 3966.1 1084.2 1159.8 1197.4 1210.1 1211.1 949.9 995.2 995.5 1026.5 1053.1 6390.4 6413.2 6426.5 6461.3 6496.2 480.9 483.3 495.0 507.7 678.0 4057.3 4084.9 4112.3 4184.5 4195.7 10643.7 10913.9 11059.8 11116.0 11147.4 10515.7 10815.1 10843.7 10890.2 10962.7 8186.6 8282.8 8383.4 8385.5 8410.8 6178.8 6472.8 6479.6 6499.3 6499.3 10318.2 10360.2 10481.2 10487.5 10527.3 10478.8 10629.3 10653.6 10660.3 10663.4 8238.5 8314.6 8329.9 8341.2 8364.2 8556.2 8929.3 8941.2 9232.4 9236.1 7756.5 8026.8 8273.0 8337.3 8372.2 7651.7 7880.8 7965.8 7996.8 8189.6 7096.1 7097.6 7178.6 7185.4 7186.8 5170.9 5218.3 5263.4 5271.7 5409.8 5394.0 5411.9 5536.7 5563.2 5684.5 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#4] prototype.html Cycles:180 Average:4716.02 Median:5304.92 stddev:1365.30 (25.7%) stddev-sans-first:1328.87 19:49:49 INFO - PROCESS | 31292 | Values: 330.9 338.5 345.1 346.2 347.6 5458.7 5476.7 5571.7 5597.4 5667.5 5578.9 5600.9 5603.7 5606.4 5607.6 4370.1 4375.6 4384.6 4391.0 4391.5 4069.7 4356.7 4364.7 4398.0 4438.0 4215.5 4265.6 4268.6 4295.8 4299.7 4307.0 4325.9 4328.6 4360.6 4365.2 3604.3 3784.3 3828.2 3834.6 3850.2 5391.9 5395.2 5406.1 5414.5 5421.8 4870.2 4908.7 4927.3 4936.3 4948.3 5472.5 5819.7 5822.9 5836.4 5844.2 4110.8 4154.8 4164.7 4193.4 4195.7 6185.5 6194.4 6208.1 6210.8 6221.5 4207.4 4236.3 4246.4 4249.6 4266.6 4303.8 4307.2 4313.9 4316.4 4328.2 4754.6 4908.9 4913.1 4925.5 4978.3 5609.6 5866.8 5870.9 5892.2 5899.5 1480.5 1487.5 1491.0 1500.8 1507.9 925.2 935.0 943.3 957.9 976.3 4967.8 5002.7 5033.4 5079.0 5081.8 5288.3 5355.1 5357.0 5394.5 5430.6 4909.3 5036.6 5062.0 5094.7 5114.8 2859.9 2870.9 2880.1 2883.6 2928.7 5442.3 5499.9 5550.5 5576.6 5590.5 5168.8 5375.5 5394.4 5421.5 5438.5 5431.8 5453.5 5463.9 5478.9 5500.5 4935.0 5221.0 5272.6 5329.5 5367.3 5151.3 5182.0 5240.9 5241.7 5321.5 5450.0 5477.6 5503.9 5516.9 5571.2 3753.2 3833.2 3909.0 3920.9 3926.6 5219.9 5221.3 5356.5 5682.6 5853.6 5839.5 5842.3 5876.1 5877.5 5879.9 5804.2 5819.4 5831.2 5868.4 5896.7 5509.9 5715.9 5754.6 5765.3 5768.3 5887.9 5902.9 5909.1 5929.9 5964.4 5492.7 5743.5 5754.3 5777.3 5786.9 19:49:49 INFO - PROCESS | 31292 | 19:49:49 INFO - PROCESS | 31292 | [#5] yui.html Cycles:180 Average:15776.50 Median:25233.89 stddev:18961.46 (75.1%) stddev-sans-first:18980.82 19:49:49 INFO - PROCESS | 31292 | Values: 693.7 695.7 727.8 736.3 856.2 14486.9 15512.8 15524.2 15532.1 15586.5 14482.0 14547.2 14547.6 14580.1 14595.6 804.8 815.5 815.6 815.7 818.7 812.1 815.6 816.2 817.1 818.9 864.9 869.6 869.7 870.0 872.2 842.5 857.4 859.0 862.1 863.0 617.3 617.6 618.0 622.6 623.0 14802.2 14822.4 14895.3 14900.3 14958.4 13677.6 13739.3 13796.7 13800.4 13807.9 10820.4 10859.6 11181.0 11186.2 11215.3 3677.7 3680.3 3755.8 3760.5 3874.0 45890.0 46730.3 53528.7 54175.0 61110.4 10774.7 10870.8 10913.5 10988.5 11197.7 17403.9 18482.7 18712.5 18768.5 18805.3 8090.2 8091.0 8213.4 8294.6 8472.2 4514.8 4573.6 4711.8 4868.5 4876.3 3415.4 3483.9 3488.9 3494.4 3499.0 616.1 623.9 625.3 632.1 642.3 680.9 720.8 722.1 743.5 746.4 9272.7 9606.6 9616.7 9644.3 9692.6 727.1 733.0 745.8 761.9 786.0 4321.7 4392.0 4577.8 4667.4 4677.2 61405.0 70110.3 70493.6 71877.3 72119.0 55520.4 63262.7 65061.3 65189.3 65320.7 52004.5 59112.4 60354.4 60653.4 62528.0 9667.1 9877.0 9914.9 9937.7 9980.7 35739.5 37421.3 37997.2 38004.3 38058.0 45670.1 48394.0 52236.5 52403.2 53117.5 12259.8 12332.2 12377.9 12458.8 12554.3 13697.5 14014.6 14030.3 14054.5 14118.4 12652.3 12860.5 12977.7 13139.1 13563.8 13048.4 13242.6 13400.1 13434.6 13741.8 12681.6 12844.9 12849.4 13255.5 13259.5 10183.6 10415.0 10482.5 10730.1 10836.6 10171.4 10549.3 10593.9 10932.1 10982.3 19:49:49 INFO - PROCESS | 31292 | -------- Summary: end -------- 19:49:49 INFO - PROCESS | 31292 | 19:49:50 INFO - TEST-INFO | 31292: exit 0 19:49:50 INFO - TEST-OK | dromaeo_css | took 1110603ms 19:49:50 INFO - TEST-START | kraken 19:49:50 INFO - operating with platform_type : linux_ 19:49:50 INFO - Initialising browser for kraken test... 19:49:50 INFO - TEST-INFO | started process 31521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUGWhu/profile http://localhost:41980/getInfo.html) 19:49:54 INFO - PROCESS | 31521 | __metrics Screen width/height:1600/1200 19:49:54 INFO - PROCESS | 31521 | colorDepth:24 19:49:54 INFO - PROCESS | 31521 | Browser inner width/height: 1024/697 19:49:54 INFO - PROCESS | 31521 | __metrics 19:49:55 ERROR - PROCESS | 31521 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:49:56 INFO - TEST-INFO | 31521: exit 0 19:49:56 INFO - Browser initialized. 19:49:56 INFO - Running cycle 1/1 for kraken test... 19:49:56 INFO - TEST-INFO | started process 31640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUGWhu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:07 INFO - PROCESS | 31640 | RSS: Main: 166137856 19:50:07 INFO - PROCESS | 31640 | 19:50:10 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41980/tests/kraken/driver.html?testName=audio-beat-detection) 19:50:11 INFO - PROCESS | 31640 | RSS: Main: 171704320 19:50:11 INFO - PROCESS | 31640 | 19:50:14 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41980/tests/kraken/driver.html?testName=audio-dft) 19:50:14 INFO - PROCESS | 31640 | RSS: Main: 171368448 19:50:14 INFO - PROCESS | 31640 | 19:50:17 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41980/tests/kraken/driver.html?testName=audio-fft) 19:50:18 INFO - PROCESS | 31640 | RSS: Main: 166375424 19:50:18 INFO - PROCESS | 31640 | 19:50:20 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41980/tests/kraken/driver.html?testName=audio-oscillator) 19:50:21 INFO - PROCESS | 31640 | RSS: Main: 166969344 19:50:21 INFO - PROCESS | 31640 | 19:50:23 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:23 INFO - PROCESS | 31640 | RSS: Main: 166969344 19:50:23 INFO - PROCESS | 31640 | 19:50:27 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41980/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:27 INFO - PROCESS | 31640 | RSS: Main: 167661568 19:50:27 INFO - PROCESS | 31640 | 19:50:31 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41980/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:31 INFO - PROCESS | 31640 | RSS: Main: 165122048 19:50:31 INFO - PROCESS | 31640 | 19:50:34 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41980/tests/kraken/driver.html?testName=json-parse-financial) 19:50:35 INFO - PROCESS | 31640 | RSS: Main: 166756352 19:50:35 INFO - PROCESS | 31640 | 19:50:36 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:37 INFO - PROCESS | 31640 | RSS: Main: 166944768 19:50:37 INFO - PROCESS | 31640 | 19:50:39 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:39 INFO - PROCESS | 31640 | RSS: Main: 167096320 19:50:39 INFO - PROCESS | 31640 | 19:50:41 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:50:42 INFO - PROCESS | 31640 | RSS: Main: 167428096 19:50:42 INFO - PROCESS | 31640 | 19:50:45 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:50:45 INFO - PROCESS | 31640 | RSS: Main: 167669760 19:50:45 INFO - PROCESS | 31640 | 19:50:48 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:50:49 INFO - PROCESS | 31640 | RSS: Main: 167661568 19:50:49 INFO - PROCESS | 31640 | 19:50:50 INFO - PROCESS | 31640 | Cycle 1(1): loaded http://localhost:41980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41980/tests/kraken/driver.html?testName=ai-astar) 19:50:51 INFO - PROCESS | 31640 | RSS: Main: 168439808 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | __start_tp_report 19:50:51 INFO - PROCESS | 31640 | _x_x_mozilla_page_load 19:50:51 INFO - PROCESS | 31640 | _x_x_mozilla_page_load_details 19:50:51 INFO - PROCESS | 31640 | |i|pagename|runs| 19:50:51 INFO - PROCESS | 31640 | |0;ai-astar;111;104;114;111;112;114;111;110;111;111 19:50:51 INFO - PROCESS | 31640 | |1;audio-beat-detection;156;128;150;173;126;154;146;131;186;126 19:50:51 INFO - PROCESS | 31640 | |2;audio-dft;163;162;161;163;162;164;172;163;160;162 19:50:51 INFO - PROCESS | 31640 | |3;audio-fft;74;75;74;170;75;75;73;75;160;78 19:50:51 INFO - PROCESS | 31640 | |4;audio-oscillator;87;84;159;84;83;82;135;83;84;140 19:50:51 INFO - PROCESS | 31640 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;118;118 19:50:51 INFO - PROCESS | 31640 | |6;imaging-darkroom;147;147;147;149;147;147;147;146;147;146 19:50:51 INFO - PROCESS | 31640 | |7;imaging-desaturate;96;95;95;95;95;96;96;96;95;95 19:50:51 INFO - PROCESS | 31640 | |8;json-parse-financial;53;57;54;53;54;54;55;54;53;54 19:50:51 INFO - PROCESS | 31640 | |9;json-stringify-tinderbox;61;62;62;62;62;61;62;61;62;68 19:50:51 INFO - PROCESS | 31640 | |10;stanford-crypto-aes;80;78;86;79;80;86;81;79;114;87 19:50:51 INFO - PROCESS | 31640 | |11;stanford-crypto-ccm;123;136;141;119;125;128;130;129;133;125 19:50:51 INFO - PROCESS | 31640 | |12;stanford-crypto-pbkdf2;163;163;162;163;158;158;160;161;161;165 19:50:51 INFO - PROCESS | 31640 | |13;stanford-crypto-sha256-iterative;63;64;62;64;63;63;64;62;63;62 19:50:51 INFO - PROCESS | 31640 | __end_tp_report 19:50:51 INFO - PROCESS | 31640 | __start_cc_report 19:50:51 INFO - PROCESS | 31640 | _x_x_mozilla_cycle_collect,889 19:50:51 INFO - PROCESS | 31640 | __end_cc_report 19:50:51 INFO - PROCESS | 31640 | __startTimestamp1464576650997__endTimestamp 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | ------- Summary: start ------- 19:50:51 INFO - PROCESS | 31640 | Number of tests: 14 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.77 (2.5%) stddev-sans-first:2.93 19:50:51 INFO - PROCESS | 31640 | Values: 111.0 104.0 114.0 111.0 112.0 114.0 111.0 110.0 111.0 111.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:20.64 (13.6%) stddev-sans-first:21.66 19:50:51 INFO - PROCESS | 31640 | Values: 156.0 128.0 150.0 173.0 126.0 154.0 146.0 131.0 186.0 126.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:3.29 (2.0%) stddev-sans-first:3.49 19:50:51 INFO - PROCESS | 31640 | Values: 163.0 162.0 161.0 163.0 162.0 164.0 172.0 163.0 160.0 162.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:38.09 (50.8%) stddev-sans-first:39.79 19:50:51 INFO - PROCESS | 31640 | Values: 74.0 75.0 74.0 170.0 75.0 75.0 73.0 75.0 160.0 78.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.50 stddev:30.00 (35.9%) stddev-sans-first:31.32 19:50:51 INFO - PROCESS | 31640 | Values: 87.0 84.0 159.0 84.0 83.0 82.0 135.0 83.0 84.0 140.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:50:51 INFO - PROCESS | 31640 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 19:50:51 INFO - PROCESS | 31640 | Values: 147.0 147.0 147.0 149.0 147.0 147.0 147.0 146.0 147.0 146.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:50:51 INFO - PROCESS | 31640 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.20 (2.2%) stddev-sans-first:1.20 19:50:51 INFO - PROCESS | 31640 | Values: 53.0 57.0 54.0 53.0 54.0 54.0 55.0 54.0 53.0 54.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:2.06 (3.3%) stddev-sans-first:2.13 19:50:51 INFO - PROCESS | 31640 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 62.0 61.0 62.0 68.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:80.50 stddev:10.72 (13.3%) stddev-sans-first:11.22 19:50:51 INFO - PROCESS | 31640 | Values: 80.0 78.0 86.0 79.0 80.0 86.0 81.0 79.0 114.0 87.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.50 stddev:6.49 (5.0%) stddev-sans-first:6.52 19:50:51 INFO - PROCESS | 31640 | Values: 123.0 136.0 141.0 119.0 125.0 128.0 130.0 129.0 133.0 125.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.50 stddev:2.27 (1.4%) stddev-sans-first:2.33 19:50:51 INFO - PROCESS | 31640 | Values: 163.0 163.0 162.0 163.0 158.0 158.0 160.0 161.0 161.0 165.0 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - PROCESS | 31640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:50:51 INFO - PROCESS | 31640 | Values: 63.0 64.0 62.0 64.0 63.0 63.0 64.0 62.0 63.0 62.0 19:50:51 INFO - PROCESS | 31640 | -------- Summary: end -------- 19:50:51 INFO - PROCESS | 31640 | 19:50:51 INFO - TEST-INFO | 31640: exit 0 19:50:51 INFO - TEST-OK | kraken | took 61639ms 19:50:51 INFO - SUITE-END | took 1172s 19:50:52 INFO - Completed test suite (00:19:32) 19:50:52 INFO - javascript benchmark 19:50:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7153.92613080372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.6701246369125, 3184.3312904290096, 3203.8077715337076, 3215.9517607235894, 3218.758593105518, 5494.642848214863, 5525.972370138149, 5585.497305242528, 5590.972045139769, 5606.383297837245, 5402.864928376793, 5522.475364840334, 5529.0, 5554.1946417769395, 5604.467575580324, 4974.05492956338, 5009.148444764399, 5096.872578185538, 5140.126178549637, 5192.065428222918, 849.8232335229427, 4932.950670493303, 4943.1102401567705, 5037.622178336621, 5075.7715902784275, 4954.5540901319055, 4958.380202474691, 4976.0794253063295, 4979.078870408968, 4997.325361076263, 4999.175136102575, 5010.498950104997, 5014.949850501521, 5025.447200807908, 5031.698098114125, 4883.0, 4995.475475075137, 5012.649114561982, 5070.340855688773, 5074.137396642543, 5478.835634930919, 5494.862628434281, 5517.062099443105, 5523.226748255248, 5534.806281780158, 5714.914276285859, 5965.22452081231, 5968.224130863004, 5978.2228310319815, 5982.4017598239825, 5851.268591426072, 5883.676397798119, 5917.822465326047, 5920.1711760353155, 6006.249218847644, 5486.725663716798, 5502.9174562381595, 5537.947789919902, 5547.889042219133, 5550.333959924795, 5919.378465261172, 6039.516838652898, 6108.144859719643, 6118.296395914438, 6144.78493252734, 5822.0, 5865.061590145556, 5886.8822623547285, 5896.262967129109, 5946.0, 5959.344472108065, 5967.1347654589845, 5972.074328479092, 5972.58191926561, 5974.671393073423, 5595.160725891067, 5777.959967205943, 5825.883482330414, 5926.1999630049395, 5950.67271300074, 5855.824325270249, 5869.0, 5915.940840591539, 5930.2883653960935, 5976.701164941735, 4404.163208990346, 4479.59683628475, 4481.2381895077915, 4489.842855500042, 4514.932276015797, 3907.081835768592, 3925.9607403926166, 3948.190620922704, 3976.5824588418377, 4031.1534577738416, 5564.721763911788, 5632.3804381518, 5694.259746233046, 5698.943010569924, 5761.423857614289, 5989.341172471025, 5989.670568118795, 6007.549433792396, 6017.458428741346, 6025.548083893638, 5577.163425486128, 5651.152327150878, 5695.658260504383, 5751.884962300731, 5757.280339957505, 5079.619028572872, 5092.6180536459915, 5097.1844504879045, 5098.1842905135, 5153.484651534816, 6157.322694503601, 6205.844853878599, 6206.658633775095, 6209.813705588839, 6216.285127210429, 5877.382874798255, 5907.645541267538, 5955.553333499918, 5963.850903727354, 5964.821055368346, 6201.930044627938, 6218.844528886633, 6235.469985051322, 6246.781362652286, 6259.311475737574, 5826.571706310719, 5893.6463812171405, 5917.852053698692, 5924.407559244041, 5961.344252132349, 5767.250257466502, 5820.330661973927, 5821.09772985188, 5895.64626122434, 5907.320658124198, 5747.0, 5793.768249270151, 5794.304683437846, 5809.070548712186, 5829.15477255787, 5755.251817263897, 5769.624974376652, 5783.913241301299, 5809.448102430262, 5825.0, 5549.750261238335, 5605.803796867253, 5711.114777209539, 5718.885622287614, 5721.599488035798, 5795.478406943395, 5829.329627092939, 5847.152162936265, 5855.9121613176685, 5924.407559244041, 5659.151127330933, 5686.175504551734, 5689.630174038674, 5701.800436984686, 5705.144228365612], "value": 5430.048217435124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8254115036063, 644.8935925572281, 655.3675702946657, 659.8416380068785, 674.3762020131379, 41655.79172104139, 43609.0, 43892.12215755687, 43929.12141757167, 47939.0412191756, 45767.542324576745, 46129.0, 46327.0, 46328.0, 46368.30447543281, 8760.8685869712, 8880.822383552326, 8934.419262747933, 8941.061188575204, 8966.462012279251, 8808.559572021373, 8985.14641109097, 8989.910100898973, 8990.955045224764, 8999.775005624879, 8989.280857531381, 9037.95481022594, 9060.411073280216, 9071.41035832672, 9094.818103637923, 8883.111688831097, 8966.37235393526, 8990.595423205972, 9005.459672419644, 9009.189172974398, 8732.345074119467, 8833.823323533557, 8840.955795221047, 8879.644814207424, 8892.3330750194, 42320.365194522106, 42707.57292427067, 42826.57173428257, 42856.78571607153, 42863.35704964428, 3563.394222982099, 3645.9453108203397, 3664.9816750916075, 3666.5966743658178, 3772.9622703772884, 31829.204269893205, 32071.839640801645, 32085.51871721926, 32268.354632907445, 33443.16392090193, 4328.826846926119, 4339.739615623042, 4361.389405483234, 4385.7149285296355, 4445.9110817783785, 328642.0, 329192.35403823067, 330331.0, 330343.0, 332957.0, 56694.716526417105, 56865.71567142138, 57172.0, 57316.42683573111, 57484.425155748744, 59943.400565994656, 60044.399556004755, 60314.39685603176, 60387.39612603906, 60614.696926515964, 16769.496915092568, 17051.91474042622, 17127.400540981005, 17131.31474741021, 17217.483475495756, 12132.878671213175, 12140.878591213976, 12218.633440996784, 12221.266723996589, 12264.080193985486, 14485.855141448661, 15830.445934392472, 15890.68218635644, 15908.522744317688, 15936.442224522087, 5071.416787069535, 5343.305370301836, 5917.437843404869, 5924.318703349084, 6109.2974307955155, 990.5245482168599, 1062.2882668612049, 1132.371533798733, 1137.2323681514945, 1220.6887243752785, 31584.684153158632, 31774.841125794224, 31781.841090794398, 32004.67995320017, 32656.183595410304, 1125.983110253347, 1134.0, 1137.5279259107378, 1162.0703437250165, 1278.603632873812, 16216.837831621533, 16224.188790560425, 16587.502374928772, 16601.833981660027, 16844.66310673804, 529326.0, 538836.0, 546919.0, 547626.0, 548857.0, 58345.416545834, 58797.0, 58948.7052564743, 59084.11373829396, 59169.11246331308, 1327.3296985022696, 1378.4555100735154, 1383.840858301288, 1385.9514916977857, 1390.165900459716, 29993.700062999964, 31232.843835780677, 31410.371792563565, 31486.0, 31566.84216578994, 49990.0, 50034.749826250634, 50380.74809625928, 50464.74767626285, 50477.242841358144, 341224.0, 349760.0, 457422.0, 457958.0, 460385.0, 26850.194494165207, 28066.0, 28152.85923570369, 40915.59084409118, 41030.58969410268, 46852.29721554111, 48468.5153148464, 48863.5113648859, 51876.0, 53230.2015469776, 39335.0, 40858.182836342516, 41030.38454423127, 43804.34293485664, 45370.77314613406, 41090.38364424596, 41403.58596413997, 41514.792426037675, 41891.581084188765, 42156.78921605372, 39960.80019599883, 41245.793771030956, 41251.793741031106, 41572.58427415687, 41629.79185104055, 34623.65376346204, 36532.81733591315, 36578.45132323071, 37127.44308835315, 37277.81361093177, 28248.576271356356, 28586.571201432413, 28606.713932860406, 28765.28086797847, 28818.567721483774], "value": 20110.075542470044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.1637519396863, 400.8977710683776, 402.18356735826245, 406.8087998640639, 418.07605192524517, 13492.66268343292, 18143.818561814376, 18575.4427367179, 19128.713069303954, 19251.133698983544, 18276.17757200926, 18545.258189672397, 19004.90497547514, 19136.23455061796, 19292.131854066567, 5411.323584551931, 5448.782048718056, 5643.774249030034, 5685.0, 5733.598648094635, 5691.288588926384, 5731.083026715726, 5750.626209296403, 5851.912221316684, 6549.705263263165, 6466.224053113633, 6495.317991610884, 6506.0, 6511.3488651134985, 6537.117489138953, 5807.767689292445, 5812.767489300423, 5837.620554663933, 5846.590738648275, 6480.222373315209, 5420.295361603005, 5618.213450116987, 5646.26598542191, 5649.6327738696855, 5674.092145256739, 13696.52062177819, 13960.232187229698, 14015.929920350434, 14028.71942561143, 15407.614809629737, 2207.404000919759, 2210.204326442479, 2247.5617254635354, 2426.645282436201, 2461.483088551406, 9832.90167098327, 9833.557489912899, 10008.699739007769, 10151.0, 10192.59229630814, 1887.113056863272, 1960.8529360297891, 1966.0661185936708, 1971.044043638834, 1975.2395327798902, 80255.59872200602, 84749.0, 84996.57501712452, 85009.14990850074, 85324.0, 10720.571177152826, 10775.407352595683, 10814.297070690538, 10879.891201088047, 11213.943930280297, 11967.281963082243, 12640.683982900317, 15403.614909627126, 15571.688566228839, 15589.610259743371, 7450.217727138573, 7546.396288296923, 7779.0, 7909.09045459768, 7962.482438641469, 7631.885521717179, 7706.961465192639, 7786.065672119382, 7942.682292708227, 7986.201379861967, 3939.5666476687543, 3972.920541589152, 3989.6209860063245, 4072.6945479089186, 4088.7751173685733, 1934.3809980806288, 1951.268274397101, 1954.9218031278874, 2008.648486514854, 2030.9385973237177, 806.7136166660869, 865.1435079271475, 879.7096958003843, 917.5183028909876, 928.0116675740315, 14906.627334316512, 15364.078155310717, 15677.686446271238, 15755.369785208693, 15872.761908571381, 909.2180724576858, 914.2320450821342, 919.2094798473307, 961.2118063188259, 990.5542505872386, 8079.0, 8482.151784821468, 8578.313734901192, 8675.913240867636, 8695.782605434788, 504366.0, 517335.0, 518625.0, 520532.0, 524593.0, 71898.0, 92644.0, 95003.52498237464, 95246.0, 96460.0, 987.5506644476745, 987.7036888933292, 1004.9447280399502, 1006.8288390973552, 1016.8830584482731, 13657.0, 13870.4451821926, 13951.58145255644, 14074.718505630035, 14185.290735463392, 41163.7941810301, 41192.588074118874, 41214.175716486105, 41532.79233603933, 41597.79201103975, 57990.710046449494, 58110.0, 59865.10202346881, 61183.0, 63492.682536587025, 5469.507744303032, 6040.697965101639, 7787.377009839312, 8342.749717508485, 8543.579405236442, 11998.880011199777, 12859.614211573667, 13167.0, 13362.265075420944, 13373.063885528309, 11117.388543630179, 11154.49804758804, 11319.207655464039, 11354.602588909349, 11612.419379031184, 11163.162762792661, 11179.66461006171, 11233.831492527455, 11754.0, 11921.0, 11414.885851141382, 11779.587714429954, 11889.702757431134, 11921.582744603897, 12220.388980551115, 8285.58572071382, 8445.366597505335, 8497.277731392654, 8527.275181609633, 8744.91255087441, 11307.038901693448, 11758.176927614984, 11824.940875295568, 11834.171607987359, 11853.5851245206], "value": 8795.865292696411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.5579254120034, 1529.5411376587022, 1712.854407375373, 1842.5393651587103, 1850.4078694817663, 8147.551884646342, 8643.827123457535, 8657.826843463143, 9175.81648367033, 9181.586828592712, 8733.86899196511, 8936.0, 9028.36801423899, 9081.818363632723, 9099.954500227506, 2302.7582103879104, 2335.9065637374483, 2340.8010319122895, 2342.8594284342994, 2344.566255242777, 2268.534950335177, 2279.350385140235, 2341.063574570177, 2394.449276666368, 2399.4241382068353, 2347.600907845662, 2358.174638876397, 2361.102780943239, 2387.6299173628117, 2390.557746816836, 2303.3550605830396, 2322.3613506285737, 2329.9999999999914, 2338.029717667166, 2356.375560476475, 2273.9090436382526, 2279.282026161754, 2294.070901284982, 2299.7470278269375, 2303.8502497337786, 9054.094590540959, 9164.633414663405, 9178.770530736718, 9188.816223675489, 9209.0, 5148.150555158394, 5281.181416880389, 5374.838754837361, 5386.8922621547745, 5391.24522566837, 3236.1942515364663, 3329.4839299908554, 3408.0, 3408.744344174172, 3409.6760807723226, 1181.4565299962028, 1189.108168873345, 1206.9396530173544, 1227.7648396475263, 2197.230969160781, 12837.807432888514, 12885.67785805353, 12888.742225155538, 12900.548480803127, 12925.806112908314, 4643.303504474356, 4652.581267685857, 4703.623710103184, 4867.5132486751045, 4910.312556242129, 10009.049140331657, 10013.649522266685, 10024.699259022242, 10025.799484010426, 10034.548445319979, 5382.111951527954, 5401.648892821954, 5402.91895621566, 5411.350637923474, 5416.729163541807, 4432.0, 4871.537203965618, 4969.82605608802, 4982.825601104017, 5047.621428392812, 3757.7181711371754, 3842.1547259602844, 3864.439656249828, 3930.449737036817, 3966.0679740261016, 1084.203110713625, 1159.750653609461, 1197.4072833947253, 1210.1287073307205, 1211.0795795195538, 949.9145076943108, 995.2485873165858, 995.4574756757585, 1026.4559783314855, 1053.146950969717, 6390.360963903572, 6413.198350206224, 6426.4537514311805, 6461.25695545009, 6496.155499784998, 480.8533397313783, 483.3450674336294, 495.00998003992015, 507.69538277033485, 677.9593224406551, 4057.269691455507, 4084.9183016339507, 4112.321466957918, 4184.476940382452, 4195.706300558993, 10643.733906652396, 10913.945430272957, 11059.834102488468, 11115.999560039636, 11147.442627868737, 10515.684529464128, 10815.134789216843, 10843.67468975932, 10890.183236257313, 10962.671119866416, 8186.590670466572, 8282.751517454606, 8383.371247156487, 8385.454945428528, 8410.78973025667, 6178.845528861814, 6472.838179045373, 6479.611223326616, 6499.3175716549085, 6499.3175716549085, 10318.226133039901, 10360.171186305228, 10481.213908956706, 10487.52806123711, 10527.263091583516, 10478.842817357898, 10629.309094908805, 10653.57385704563, 10660.307080039773, 10663.360198388122, 8238.50568965864, 8314.62584183701, 8329.916700833157, 8341.16588341161, 8364.163583641588, 8556.229939305493, 8929.285657147542, 8941.239994600532, 9232.399894006869, 9236.122568355995, 7756.495827771177, 8026.7591972240925, 8273.048599411144, 8337.291330236998, 8372.246497815226, 7651.693932242648, 7880.802979925318, 7965.800854978672, 7996.840063198587, 8189.590520474072, 7096.112985876765, 7097.574145551283, 7178.5692858428665, 7185.389241914496, 7186.820329491805, 5170.922436163536, 5218.295530103539, 5263.36839579253, 5271.736413179249, 5409.810656626999, 5394.002109609734, 5411.918821217763, 5536.667799932017, 5563.248961390161, 5684.545236381162], "value": 4697.0294439715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.9044232843485, 338.4888817884994, 345.1302717152775, 346.18818869750424, 347.64713815477313, 5458.6724796512135, 5476.712972451471, 5571.665700057994, 5597.412271711468, 5667.489925906668, 5578.86052848679, 5600.85997850054, 5603.7478313475885, 5606.383297837245, 5607.551395888329, 4370.147821174872, 4375.628071613916, 4384.649228061763, 4391.0, 4391.516933137353, 4069.7354671946227, 4356.738595684254, 4364.738115713051, 4398.0, 4438.0, 4215.515215750197, 4265.573442655741, 4268.637165840907, 4295.78521073945, 4299.742015479065, 4306.978465107686, 4325.9351109733225, 4328.63206627437, 4360.629346505519, 4365.2142614329405, 3604.2611264690677, 3784.280986612562, 3828.2343531293855, 3834.635709607611, 3850.2299540092095, 5391.919121213185, 5395.217693434469, 5406.135018397077, 5414.539764120015, 5421.756020979065, 4870.196417591093, 4908.680935739201, 4927.334809800703, 4936.333594964705, 4948.307236986825, 5472.480114389126, 5819.73811178498, 5822.9417705822825, 5836.431969933215, 5844.240248767633, 4110.753354798721, 4154.833806647731, 4164.666826653891, 4193.370994350841, 4195.727277726938, 6185.536084793658, 6194.4425001749605, 6208.068789681539, 6210.782622608187, 6221.5333849961435, 4207.410962465257, 4236.322188449833, 4246.40550322955, 4249.618873865944, 4266.552012038754, 4303.82784688609, 4307.203167413976, 4313.856827940598, 4316.395704601358, 4328.199283132631, 4754.595859351924, 4908.901821963541, 4913.108453245526, 4925.482824303396, 4978.253262010655, 5609.607327487037, 5866.7653293868625, 5870.911936320958, 5892.204552385373, 5899.528037756969, 1480.5188313797844, 1487.4570781664615, 1490.9776353354707, 1500.8424115467938, 1507.8944473886722, 925.22281283722, 935.0415823780544, 943.3396622364372, 957.9462591149819, 976.3068221562628, 4967.801287948441, 5002.699838009731, 5033.446320904697, 5078.984203159383, 5081.8475445736685, 5288.286081379041, 5355.0896347621, 5357.0357335679955, 5394.541463975527, 5430.56555475561, 4909.2881532177635, 5036.622253331015, 5061.974690126526, 5094.700851282899, 5114.846554603368, 2859.8846449884563, 2870.8995185168837, 2880.1215629233284, 2883.5818806272973, 2928.68209305809, 5442.319710036246, 5499.9375234287145, 5550.528205102531, 5576.581756368289, 5590.524805391506, 5168.821174977362, 5375.489328513785, 5394.352677678625, 5421.539169170585, 5438.483344082306, 5431.755570999315, 5453.481919217668, 5463.852590955864, 5478.890422191534, 5500.477454641803, 4934.988327392947, 5221.008008478377, 5272.604554658339, 5329.493698098674, 5367.302250707539, 5151.330327057459, 5182.0308282852275, 5240.877444634929, 5241.659292145999, 5321.5476684482255, 5449.972750136224, 5477.561795056306, 5503.926734286776, 5516.924199781165, 5571.192177134212, 3753.2493501299305, 3833.233353329401, 3908.9609103908597, 3920.9019774505864, 3926.5680775114142, 5219.921701174561, 5221.321228240305, 5356.491133342326, 5682.573806964411, 5853.619514731528, 5839.474447299764, 5842.269716285465, 5876.147958545901, 5877.500412464989, 5879.94120058811, 5804.158397032491, 5819.37057623866, 5831.212786273799, 5868.413158684098, 5896.734646940812, 5509.862253443696, 5715.8856822864145, 5754.625949313281, 5765.250517432874, 5768.278965129359, 5887.911681324869, 5902.881942361215, 5909.134069976144, 5929.85175370602, 5964.433378829004, 5492.725363731877, 5743.4543718346695, 5754.251947246831, 5777.255803493307, 5786.855328616818], "value": 4282.8486120966, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6947742993079, 695.6695569604439, 727.7671145233527, 736.3446532585998, 856.1566856646205, 14486.855131448696, 15512.767308490353, 15524.223788810543, 15532.145731984736, 15586.454474093394, 14482.0, 14547.199904005276, 14547.636309092251, 14580.05229660074, 14595.635109122277, 804.8148925747067, 815.5229190923317, 815.64927081355, 815.6981916690833, 818.6725309876067, 812.1350761439078, 815.6003558256441, 816.1634324817051, 817.0848649512554, 818.8935438393, 864.8918885139358, 869.6260607938584, 869.7347309070731, 869.9739007829744, 872.1932212703256, 842.465034702965, 857.4169564696004, 858.952757598335, 862.06465984407, 862.9568521573896, 617.3116974573319, 617.6386813713983, 617.9907301390438, 622.5673157155778, 622.9719662615194, 14802.185879776607, 14822.40710371584, 14895.255237238203, 14900.254987250593, 14958.401663933539, 13677.589672309847, 13739.313034348243, 13796.655083622989, 13800.447982080705, 13807.928810678479, 10820.350778953289, 10859.619913302997, 11181.0, 11186.216964812467, 11215.271007384576, 3677.669009789105, 3680.3191409589313, 3755.8497660093562, 3760.4735337052834, 3874.0314921269683, 45890.0, 46730.299045514344, 53528.73235633836, 54174.99999999961, 61110.38889611136, 10774.676759697222, 10870.782584348268, 10913.508892099875, 10988.505517251742, 11197.66407007791, 17403.912980435016, 18482.722759158623, 18712.53218669517, 18768.53078673044, 18805.341813036477, 8090.190980901981, 8091.0, 8213.425060245725, 8294.58527073644, 8472.19514146155, 4514.841980530666, 4573.565511276423, 4711.8350857719815, 4868.488808675109, 4876.292937524039, 3415.3852306585054, 3483.9477407838904, 3488.89533314001, 3494.353544594258, 3499.0, 616.1097214525058, 623.9188905442263, 625.3465128940178, 632.1087266953665, 642.3480167629859, 680.9353111454404, 720.8053825467094, 722.1226210154688, 743.5427212264418, 746.3767753925533, 9272.666822153904, 9606.615735370508, 9616.663416780379, 9644.251388354425, 9692.612295508101, 727.1020289941918, 732.9816754581071, 745.8396444764402, 761.9428542859308, 785.9842803143905, 4321.719088259253, 4391.956080439155, 4577.771111444415, 4667.407366810951, 4677.204875171229, 61405.0, 70110.29889701038, 70493.64753176304, 71877.28122718706, 72119.0, 55520.444795552336, 63262.68368658219, 65061.349386506474, 65189.348106519275, 65320.67339663366, 52004.47995520072, 59112.40887591155, 60354.396456035756, 60653.39346606566, 62528.0, 9667.129958303787, 9876.950615246878, 9914.851277230702, 9937.65218217359, 9980.650677226262, 35739.46390804192, 37421.25157496889, 37997.24005519929, 38004.29483228225, 38058.0485487865, 45670.08659826851, 48394.0, 52236.477635224684, 52403.21395178999, 53117.468825311254, 12259.816102758288, 12332.19840710351, 12377.876221238033, 12458.750824983268, 12554.309512976508, 13697.452101915811, 14014.649633759238, 14030.29848507591, 14054.508092216724, 14118.364673589918, 12652.30412327294, 12860.485580577046, 12977.740445191232, 13139.14595551286, 13563.796543051665, 13048.41282142287, 13242.602721918358, 13400.128991615515, 13434.596962091153, 13741.793873091712, 12681.619551413472, 12844.93744638449, 12849.357532123544, 13255.53605623837, 13259.469621215429, 10183.643572474928, 10415.047721521607, 10482.52828622729, 10730.141588673043, 10836.566537338418, 10171.440570768678, 10549.314294570828, 10593.865456619551, 10932.125429965425, 10982.286151400453], "value": 6936.998147671174, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 114.0, 111.0, 112.0, 114.0, 111.0, 110.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 150.0, 173.0, 126.0, 154.0, 146.0, 131.0, 186.0, 126.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 162.0, 164.0, 172.0, 163.0, 160.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 170.0, 75.0, 75.0, 73.0, 75.0, 160.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 159.0, 84.0, 83.0, 82.0, 135.0, 83.0, 84.0, 140.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 68.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 86.0, 79.0, 80.0, 86.0, 81.0, 79.0, 114.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 136.0, 141.0, 119.0, 125.0, 128.0, 130.0, 129.0, 133.0, 125.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 158.0, 158.0, 160.0, 161.0, 161.0, 165.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 64.0, 63.0, 63.0, 64.0, 62.0, 63.0, 62.0], "value": 63.0, "unit": "score"}]}]} 19:50:52 INFO - Return code: 0 19:50:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:50:52 ERROR - # TBPL SUCCESS # 19:50:52 INFO - Running post-action listener: _resource_record_post_action 19:50:52 INFO - ##### 19:50:52 INFO - ##### Finished run-tests step (success) 19:50:52 INFO - ##### 19:50:52 INFO - Running post-run listener: _resource_record_post_run 19:50:52 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 540794880; Read time: 0; Write time: 506416 19:50:52 INFO - TinderboxPrint: CPU usage
13.5% 19:50:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:50:52 INFO - TinderboxPrint: I/O write bytes / time
540,794,880 / 506,416 19:50:52 INFO - TinderboxPrint: CPU idle
8,208.8 (86.5%) 19:50:52 INFO - TinderboxPrint: CPU user
1,230.4 (13.0%) 19:50:52 INFO - TinderboxPrint: Swap in / out
0 / 0 19:50:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247267328; Read time: 0; Write time: 296020 19:50:52 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 293396480; Read time: 0; Write time: 210396 19:50:52 INFO - Running post-run listener: _upload_blobber_files 19:50:52 INFO - Blob upload gear active. 19:50:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:50:52 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 19:50:52 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'] 19:50:52 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 19:50:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:58 INFO - (blobuploader) - INFO - Done attempting. 19:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:58 INFO - (blobuploader) - INFO - Done attempting. 19:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:59 INFO - (blobuploader) - INFO - Done attempting. 19:50:59 INFO - (blobuploader) - INFO - Iteration through files over. 19:50:59 INFO - Return code: 0 19:50:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:50:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:50:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e216d3815dbc104f8b25c0a02ec1533442f3a680af029a219552a7c38fc534afd7054afffb801ef5ff97ffab6e256ba2fb5c91313857d501a21003755c3d6903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47dd7a958cfd42b3c7a2e27200ec4eca7dcc7cfd213c8d744e2896f7f7b25ac940cad35da4d6f52c59e71d4eb77b9f82269a101f74c958115482c9043541833b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8006bfbb8eced7d0fcec162ce08f1e8e56147fc76d53e2178d17d89bebefc7186bf7c510b028cb893d819e0e1d6facaa5e37b0d3bb665748541fa6554b160232"} 19:50:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:50:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:50:59 INFO - Contents: 19:50:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e216d3815dbc104f8b25c0a02ec1533442f3a680af029a219552a7c38fc534afd7054afffb801ef5ff97ffab6e256ba2fb5c91313857d501a21003755c3d6903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47dd7a958cfd42b3c7a2e27200ec4eca7dcc7cfd213c8d744e2896f7f7b25ac940cad35da4d6f52c59e71d4eb77b9f82269a101f74c958115482c9043541833b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8006bfbb8eced7d0fcec162ce08f1e8e56147fc76d53e2178d17d89bebefc7186bf7c510b028cb893d819e0e1d6facaa5e37b0d3bb665748541fa6554b160232"} 19:50:59 INFO - Running post-run listener: copy_logs_to_upload_dir 19:50:59 INFO - Copying logs to upload dir... 19:50:59 INFO - mkdir: /builds/slave/test/build/upload/logs 19:50:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.672872 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-29 19:50:59.107256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 19:50:59.110879) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 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/e216d3815dbc104f8b25c0a02ec1533442f3a680af029a219552a7c38fc534afd7054afffb801ef5ff97ffab6e256ba2fb5c91313857d501a21003755c3d6903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47dd7a958cfd42b3c7a2e27200ec4eca7dcc7cfd213c8d744e2896f7f7b25ac940cad35da4d6f52c59e71d4eb77b9f82269a101f74c958115482c9043541833b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8006bfbb8eced7d0fcec162ce08f1e8e56147fc76d53e2178d17d89bebefc7186bf7c510b028cb893d819e0e1d6facaa5e37b0d3bb665748541fa6554b160232"} build_url:https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/NlirkbBcTpeTAmS3AdrIBQ/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/e216d3815dbc104f8b25c0a02ec1533442f3a680af029a219552a7c38fc534afd7054afffb801ef5ff97ffab6e256ba2fb5c91313857d501a21003755c3d6903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47dd7a958cfd42b3c7a2e27200ec4eca7dcc7cfd213c8d744e2896f7f7b25ac940cad35da4d6f52c59e71d4eb77b9f82269a101f74c958115482c9043541833b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8006bfbb8eced7d0fcec162ce08f1e8e56147fc76d53e2178d17d89bebefc7186bf7c510b028cb893d819e0e1d6facaa5e37b0d3bb665748541fa6554b160232"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 19:50:59.136311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:50:59.136633) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1464574584.437623-758965747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 19:50:59.223965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 19:50:59.224312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 19:50:59.224720) ========= ========= Total master_lag: 0.18 =========