builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1464317689.04 results: success (0) buildid: 20160526184553 builduid: 7df0ca47746848eca179f3704fef34cd revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.037849) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.038268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.038545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.060863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.061131) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 19:54:49-- 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% 43.2M=0s 2016-05-26 19:54:49 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.192125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.192438) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019073 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:49.258414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 19:54:49.258749) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d63dde701b47b8661ab7990f197b6b60e543839 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4d63dde701b47b8661ab7990f197b6b60e543839 --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=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 19:54:49,394 truncating revision to first 12 chars 2016-05-26 19:54:49,394 Setting DEBUG logging. 2016-05-26 19:54:49,394 attempt 1/10 2016-05-26 19:54:49,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d63dde701b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 19:54:50,674 unpacking tar archive at: mozilla-central-4d63dde701b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.611177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 19:54:50.887584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:50.887956) ========= script_repo_revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:50.888428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:50.888783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 19:54:50.900385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-26 19:54:50.900733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:54:51 INFO - MultiFileLogger online at 20160526 19:54:51 in /builds/slave/test 19:54:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:54:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:54:51 INFO - {'append_to_log': False, 19:54:51 INFO - 'base_work_dir': '/builds/slave/test', 19:54:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:54:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:54:51 INFO - 'branch': 'Firefox-Non-PGO', 19:54:51 INFO - 'buildbot_json_path': 'buildprops.json', 19:54:51 INFO - 'config_files': ('talos/linux_config.py',), 19:54:51 INFO - 'default_actions': ('clobber', 19:54:51 INFO - 'read-buildbot-config', 19:54:51 INFO - 'download-and-extract', 19:54:51 INFO - 'populate-webroot', 19:54:51 INFO - 'create-virtualenv', 19:54:51 INFO - 'install', 19:54:51 INFO - 'run-tests'), 19:54:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:54:51 INFO - 'download_minidump_stackwalk': True, 19:54:51 INFO - 'download_symbols': 'ondemand', 19:54:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:54:51 INFO - 'tooltool.py': '/tools/tooltool.py', 19:54:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:54:51 INFO - '/tools/misc-python/virtualenv.py')}, 19:54:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:54:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:54:51 INFO - 'installer_path': 'installer.exe', 19:54:51 INFO - 'log_level': 'info', 19:54:51 INFO - 'log_name': 'talos', 19:54:51 INFO - 'log_to_console': True, 19:54:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:54:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:54:51 INFO - 'opt_config_files': (), 19:54:51 INFO - 'pip_index': False, 19:54:51 INFO - 'sps_profile': False, 19:54:51 INFO - 'sps_profile_interval': 0, 19:54:51 INFO - 'suite': 'dromaeojs', 19:54:51 INFO - 'system_bits': '32', 19:54:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:54:51 INFO - 'title': 'talos-linux64-ix-015', 19:54:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:54:51 INFO - 'use_talos_json': True, 19:54:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:54:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:54:51 INFO - 'work_dir': 'build'} 19:54:51 INFO - ##### 19:54:51 INFO - ##### Running clobber step. 19:54:51 INFO - ##### 19:54:51 INFO - Running pre-action listener: _resource_record_pre_action 19:54:51 INFO - Running main action method: clobber 19:54:51 INFO - rmtree: /builds/slave/test/build 19:54:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:54:52 INFO - Running post-action listener: _resource_record_post_action 19:54:52 INFO - ##### 19:54:52 INFO - ##### Finished clobber step (success) 19:54:52 INFO - ##### 19:54:52 INFO - ##### 19:54:52 INFO - ##### Running read-buildbot-config step. 19:54:52 INFO - ##### 19:54:52 INFO - Running pre-action listener: _resource_record_pre_action 19:54:52 INFO - Running main action method: read_buildbot_config 19:54:52 INFO - Using buildbot properties: 19:54:52 INFO - { 19:54:52 INFO - "project": "", 19:54:52 INFO - "product": "firefox", 19:54:52 INFO - "script_repo_revision": "production", 19:54:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:54:52 INFO - "repository": "", 19:54:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:54:52 INFO - "buildid": "20160526184553", 19:54:52 INFO - "pgo_build": "False", 19:54:52 INFO - "basedir": "/builds/slave/test", 19:54:52 INFO - "buildnumber": 596, 19:54:52 INFO - "slavename": "talos-linux64-ix-015", 19:54:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:54:52 INFO - "platform": "ubuntu64_hw", 19:54:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:54:52 INFO - "branch": "mozilla-central", 19:54:52 INFO - "repo_path": "mozilla-central", 19:54:52 INFO - "revision": "4d63dde701b47b8661ab7990f197b6b60e543839", 19:54:52 INFO - "stage_platform": "linux64", 19:54:52 INFO - "builduid": "7df0ca47746848eca179f3704fef34cd", 19:54:52 INFO - "slavebuilddir": "test" 19:54:52 INFO - } 19:54:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:54:52 INFO - Running post-action listener: _resource_record_post_action 19:54:52 INFO - ##### 19:54:52 INFO - ##### Finished read-buildbot-config step (success) 19:54:52 INFO - ##### 19:54:52 INFO - ##### 19:54:52 INFO - ##### Running download-and-extract step. 19:54:52 INFO - ##### 19:54:52 INFO - Running pre-action listener: _resource_record_pre_action 19:54:52 INFO - Running main action method: download_and_extract 19:54:52 INFO - mkdir: /builds/slave/test/build/tests 19:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:52 INFO - https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:54:56 INFO - Downloaded 1361 bytes. 19:54:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:54:56 INFO - Using the following test package requirements: 19:54:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:54:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:54:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'jsshell-linux-x86_64.zip'], 19:54:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:54:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:54:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:54:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:54:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:54:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:56 INFO - https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:54:59 INFO - Downloaded 22837958 bytes. 19:54:59 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:54:59 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:55:01 INFO - Return code: 0 19:55:01 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:55:01 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:55:01 INFO - https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:08 INFO - Downloaded 22837958 bytes. 19:55:08 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:55:08 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:55:10 INFO - Return code: 0 19:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:10 INFO - https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:55:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:12 INFO - Downloaded 10834034 bytes. 19:55:12 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:55:12 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:55:12 INFO - Return code: 0 19:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:12 INFO - https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:55:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/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:55:13 INFO - Downloaded 54834309 bytes. 19:55:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:13 INFO - mkdir: /builds/slave/test/properties 19:55:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:13 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:13 INFO - Contents: 19:55:13 INFO - build_url:https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:55:14 INFO - Running post-action listener: _resource_record_post_action 19:55:14 INFO - Running post-action listener: set_extra_try_arguments 19:55:14 INFO - ##### 19:55:14 INFO - ##### Finished download-and-extract step (success) 19:55:14 INFO - ##### 19:55:14 INFO - ##### 19:55:14 INFO - ##### Running populate-webroot step. 19:55:14 INFO - ##### 19:55:14 INFO - Running pre-action listener: _resource_record_pre_action 19:55:14 INFO - Running main action method: populate_webroot 19:55:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:14 INFO - '--tppagecycles', 19:55:14 INFO - '7'], 19:55:14 INFO - 'tests': ['tsvgm']}}, 19:55:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:55:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:55:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:55:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['damp', 'tps']}, 19:55:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'tests': ['damp', 'tps']}, 19:55:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['dromaeo_dom']}, 19:55:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'other-e10s': {'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['a11yr', 19:55:14 INFO - 'ts_paint', 19:55:14 INFO - 'tpaint', 19:55:14 INFO - 'sessionrestore', 19:55:14 INFO - 'sessionrestore_no_auto_restore', 19:55:14 INFO - 'tabpaint']}, 19:55:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['tsvgx', 19:55:14 INFO - 'tsvgr_opacity', 19:55:14 INFO - 'tart', 19:55:14 INFO - 'tscrollx', 19:55:14 INFO - 'cart']}, 19:55:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:55:14 INFO - 'tsvgr_opacity', 19:55:14 INFO - 'tart', 19:55:14 INFO - 'tscrollx', 19:55:14 INFO - 'cart']}, 19:55:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'talos_options': ['--disable-e10s'], 19:55:14 INFO - 'tests': ['tp5o']}, 19:55:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'tests': ['tp5o']}, 19:55:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'talos_options': ['--disable-e10s', 19:55:14 INFO - '--xperf_path', 19:55:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:14 INFO - 'tests': ['tp5n']}, 19:55:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:14 INFO - 'talos_options': ['--xperf_path', 19:55:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:14 INFO - 'tests': ['tp5n']}}, 19:55:14 INFO - 'talos.zip': {'path': '', 19:55:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:14 INFO - Running post-action listener: _resource_record_post_action 19:55:14 INFO - ##### 19:55:14 INFO - ##### Finished populate-webroot step (success) 19:55:14 INFO - ##### 19:55:14 INFO - ##### 19:55:14 INFO - ##### Running create-virtualenv step. 19:55:14 INFO - ##### 19:55:14 INFO - Running pre-action listener: _resource_record_pre_action 19:55:14 INFO - Running main action method: create_virtualenv 19:55:14 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:14 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:55:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:14 INFO - Using real prefix '/usr' 19:55:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:15 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:17 INFO - Installing pip.................done. 19:55:17 INFO - Return code: 0 19:55:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:55:17 INFO - Using env: {'DISPLAY': ':0', 19:55:17 INFO - 'HOME': '/home/cltbld', 19:55:17 INFO - 'LANG': 'en_US.UTF-8', 19:55:17 INFO - 'LANGUAGE': 'en_US:en', 19:55:17 INFO - 'LOGNAME': 'cltbld', 19:55:17 INFO - 'MAIL': '/var/mail/cltbld', 19:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:17 INFO - 'MOZ_NO_REMOTE': '1', 19:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:17 INFO - 'NO_EM_RESTART': '1', 19:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:17 INFO - 'PWD': '/builds/slave/test', 19:55:17 INFO - 'SHELL': '/bin/bash', 19:55:17 INFO - 'SHLVL': '1', 19:55:17 INFO - 'TERM': 'linux', 19:55:17 INFO - 'TMOUT': '86400', 19:55:17 INFO - 'USER': 'cltbld', 19:55:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:17 INFO - '_': '/tools/buildbot/bin/python'} 19:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:17 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:55:17 INFO - Cleaning up... 19:55:17 INFO - Return code: 0 19:55:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:55:17 INFO - Using env: {'DISPLAY': ':0', 19:55:17 INFO - 'HOME': '/home/cltbld', 19:55:17 INFO - 'LANG': 'en_US.UTF-8', 19:55:17 INFO - 'LANGUAGE': 'en_US:en', 19:55:17 INFO - 'LOGNAME': 'cltbld', 19:55:17 INFO - 'MAIL': '/var/mail/cltbld', 19:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:17 INFO - 'MOZ_NO_REMOTE': '1', 19:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:17 INFO - 'NO_EM_RESTART': '1', 19:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:17 INFO - 'PWD': '/builds/slave/test', 19:55:17 INFO - 'SHELL': '/bin/bash', 19:55:17 INFO - 'SHLVL': '1', 19:55:17 INFO - 'TERM': 'linux', 19:55:17 INFO - 'TMOUT': '86400', 19:55:17 INFO - 'USER': 'cltbld', 19:55:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:17 INFO - '_': '/tools/buildbot/bin/python'} 19:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:17 INFO - Downloading/unpacking psutil>=3.1.1 19:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:19 INFO - Installing collected packages: psutil 19:55:19 INFO - Running setup.py install for psutil 19:55:19 INFO - building 'psutil._psutil_linux' extension 19:55:19 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:55:19 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:55:19 INFO - building 'psutil._psutil_posix' extension 19:55:19 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:55:19 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:55:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:20 INFO - Successfully installed psutil 19:55:20 INFO - Cleaning up... 19:55:20 INFO - Return code: 0 19:55:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:55:20 INFO - Using env: {'DISPLAY': ':0', 19:55:20 INFO - 'HOME': '/home/cltbld', 19:55:20 INFO - 'LANG': 'en_US.UTF-8', 19:55:20 INFO - 'LANGUAGE': 'en_US:en', 19:55:20 INFO - 'LOGNAME': 'cltbld', 19:55:20 INFO - 'MAIL': '/var/mail/cltbld', 19:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:20 INFO - 'MOZ_NO_REMOTE': '1', 19:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:20 INFO - 'NO_EM_RESTART': '1', 19:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:20 INFO - 'PWD': '/builds/slave/test', 19:55:20 INFO - 'SHELL': '/bin/bash', 19:55:20 INFO - 'SHLVL': '1', 19:55:20 INFO - 'TERM': 'linux', 19:55:20 INFO - 'TMOUT': '86400', 19:55:20 INFO - 'USER': 'cltbld', 19:55:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:20 INFO - '_': '/tools/buildbot/bin/python'} 19:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:55:22 INFO - Installing collected packages: mozsystemmonitor 19:55:22 INFO - Running setup.py install for mozsystemmonitor 19:55:22 INFO - Successfully installed mozsystemmonitor 19:55:22 INFO - Cleaning up... 19:55:22 INFO - Return code: 0 19:55:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:22 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:22 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:55:22 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:55:22 INFO - Using env: {'DISPLAY': ':0', 19:55:22 INFO - 'HOME': '/home/cltbld', 19:55:22 INFO - 'LANG': 'en_US.UTF-8', 19:55:22 INFO - 'LANGUAGE': 'en_US:en', 19:55:22 INFO - 'LOGNAME': 'cltbld', 19:55:22 INFO - 'MAIL': '/var/mail/cltbld', 19:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:22 INFO - 'MOZ_NO_REMOTE': '1', 19:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:22 INFO - 'NO_EM_RESTART': '1', 19:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:22 INFO - 'PWD': '/builds/slave/test', 19:55:22 INFO - 'SHELL': '/bin/bash', 19:55:22 INFO - 'SHLVL': '1', 19:55:22 INFO - 'TERM': 'linux', 19:55:22 INFO - 'TMOUT': '86400', 19:55:22 INFO - 'USER': 'cltbld', 19:55:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:22 INFO - '_': '/tools/buildbot/bin/python'} 19:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:22 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:24 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:24 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:55:24 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:55:24 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:55:24 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:55:24 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:55:24 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:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:55:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55:24 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:55:24 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:55:24 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:55:24 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:55:24 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:55:24 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:55:25 INFO - Downloading docopt-0.6.1.tar.gz 19:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:55:25 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:25 INFO - Running setup.py install for blobuploader 19:55:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:55:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:55:25 INFO - Running setup.py install for requests 19:55:25 INFO - Running setup.py install for docopt 19:55:25 INFO - Successfully installed blobuploader requests docopt 19:55:25 INFO - Cleaning up... 19:55:25 INFO - Return code: 0 19:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55:25 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:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:25 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:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:25 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:25 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:55:25 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:55:25 INFO - Using env: {'DISPLAY': ':0', 19:55:25 INFO - 'HOME': '/home/cltbld', 19:55:25 INFO - 'LANG': 'en_US.UTF-8', 19:55:25 INFO - 'LANGUAGE': 'en_US:en', 19:55:25 INFO - 'LOGNAME': 'cltbld', 19:55:25 INFO - 'MAIL': '/var/mail/cltbld', 19:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:25 INFO - 'MOZ_NO_REMOTE': '1', 19:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:25 INFO - 'NO_EM_RESTART': '1', 19:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:25 INFO - 'PWD': '/builds/slave/test', 19:55:25 INFO - 'SHELL': '/bin/bash', 19:55:25 INFO - 'SHLVL': '1', 19:55:25 INFO - 'TERM': 'linux', 19:55:25 INFO - 'TMOUT': '86400', 19:55:25 INFO - 'USER': 'cltbld', 19:55:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:25 INFO - '_': '/tools/buildbot/bin/python'} 19:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:55:26 INFO - Running setup.py (path:/tmp/pip-b48_fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:55:26 INFO - Running setup.py (path:/tmp/pip-uPEEnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:55:26 INFO - Running setup.py (path:/tmp/pip-xAT3rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:55:26 INFO - Running setup.py (path:/tmp/pip-22yctm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:55:26 INFO - Running setup.py (path:/tmp/pip-jq5jCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:55:26 INFO - Running setup.py (path:/tmp/pip-T9qOE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:55:26 INFO - Running setup.py (path:/tmp/pip-2dQ9zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:55:26 INFO - Running setup.py (path:/tmp/pip-3xhEwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:55:26 INFO - Running setup.py (path:/tmp/pip-6STSvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:55:26 INFO - Running setup.py (path:/tmp/pip-0RkOsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:55:26 INFO - Running setup.py (path:/tmp/pip-fFQQ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:55:26 INFO - Running setup.py (path:/tmp/pip-My97gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:55:26 INFO - Running setup.py (path:/tmp/pip-4eV5Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:55:26 INFO - Running setup.py (path:/tmp/pip-5qFjEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:27 INFO - Running setup.py (path:/tmp/pip-ThH6TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:55:27 INFO - Running setup.py (path:/tmp/pip-nyUly5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:55:27 INFO - Running setup.py (path:/tmp/pip-XBJMT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:55:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:27 INFO - Running setup.py install for manifestparser 19:55:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:55:27 INFO - Running setup.py install for mozcrash 19:55:27 INFO - Running setup.py install for mozdebug 19:55:27 INFO - Running setup.py install for mozdevice 19:55:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:55:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:55:27 INFO - Running setup.py install for mozfile 19:55:27 INFO - Running setup.py install for mozhttpd 19:55:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:55:27 INFO - Running setup.py install for mozinfo 19:55:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:55:27 INFO - Running setup.py install for mozInstall 19:55:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Running setup.py install for mozleak 19:55:28 INFO - Running setup.py install for mozlog 19:55:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Running setup.py install for moznetwork 19:55:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Running setup.py install for mozprocess 19:55:28 INFO - Running setup.py install for mozprofile 19:55:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Running setup.py install for mozrunner 19:55:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:55:28 INFO - Running setup.py install for mozscreenshot 19:55:28 INFO - Running setup.py install for moztest 19:55:28 INFO - Running setup.py install for mozversion 19:55:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:55:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:55:29 INFO - Cleaning up... 19:55:29 INFO - Return code: 0 19:55:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55: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:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:29 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:29 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:55:29 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:55:29 INFO - Using env: {'DISPLAY': ':0', 19:55:29 INFO - 'HOME': '/home/cltbld', 19:55:29 INFO - 'LANG': 'en_US.UTF-8', 19:55:29 INFO - 'LANGUAGE': 'en_US:en', 19:55:29 INFO - 'LOGNAME': 'cltbld', 19:55:29 INFO - 'MAIL': '/var/mail/cltbld', 19:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:29 INFO - 'MOZ_NO_REMOTE': '1', 19:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:29 INFO - 'NO_EM_RESTART': '1', 19:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:29 INFO - 'PWD': '/builds/slave/test', 19:55:29 INFO - 'SHELL': '/bin/bash', 19:55:29 INFO - 'SHLVL': '1', 19:55:29 INFO - 'TERM': 'linux', 19:55:29 INFO - 'TMOUT': '86400', 19:55:29 INFO - 'USER': 'cltbld', 19:55:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:29 INFO - '_': '/tools/buildbot/bin/python'} 19:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:55:29 INFO - Running setup.py (path:/tmp/pip-Yd1edn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:55:29 INFO - Running setup.py (path:/tmp/pip-wvekN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:55:29 INFO - Running setup.py (path:/tmp/pip-OI8GuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:55:29 INFO - Running setup.py (path:/tmp/pip-PYcohz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:55:29 INFO - Running setup.py (path:/tmp/pip-EoCdbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:55:29 INFO - Running setup.py (path:/tmp/pip-LAR9j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:55:29 INFO - Running setup.py (path:/tmp/pip-XWVCqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:55:29 INFO - Running setup.py (path:/tmp/pip-j3kB1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:55:29 INFO - Running setup.py (path:/tmp/pip-Wbal_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:55:29 INFO - Running setup.py (path:/tmp/pip-Ewld6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:55:29 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:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:55:29 INFO - Running setup.py (path:/tmp/pip-NxhkEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:55:30 INFO - Running setup.py (path:/tmp/pip-gOwnbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:55:30 INFO - Running setup.py (path:/tmp/pip-HhgLbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:55:30 INFO - Running setup.py (path:/tmp/pip-zm6Q8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:30 INFO - Running setup.py (path:/tmp/pip-dGYsDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:55:30 INFO - Running setup.py (path:/tmp/pip-qR5JT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:55:30 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:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:55:30 INFO - Running setup.py (path:/tmp/pip-y76jsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:55:30 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:55:30 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:55:30 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:55:30 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:55:30 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:55:30 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:55:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:55:30 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:55:30 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:55:30 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:55:30 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:55:30 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:55:30 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:55:32 INFO - Downloading blessings-1.6.tar.gz 19:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:55:32 INFO - Installing collected packages: blessings 19:55:32 INFO - Running setup.py install for blessings 19:55:32 INFO - Successfully installed blessings 19:55:32 INFO - Cleaning up... 19:55:32 INFO - Return code: 0 19:55:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:55:32 INFO - Reading from file tmpfile_stdout 19:55:32 INFO - Current package versions: 19:55:32 INFO - argparse == 1.2.1 19:55:32 INFO - blessings == 1.6 19:55:32 INFO - blobuploader == 1.2.4 19:55:32 INFO - docopt == 0.6.1 19:55:32 INFO - manifestparser == 1.1 19:55:32 INFO - mozInstall == 1.12 19:55:32 INFO - mozcrash == 0.17 19:55:32 INFO - mozdebug == 0.1 19:55:32 INFO - mozdevice == 0.48 19:55:32 INFO - mozfile == 1.2 19:55:32 INFO - mozhttpd == 0.7 19:55:32 INFO - mozinfo == 0.9 19:55:32 INFO - mozleak == 0.1 19:55:32 INFO - mozlog == 3.2 19:55:32 INFO - moznetwork == 0.27 19:55:32 INFO - mozprocess == 0.22 19:55:32 INFO - mozprofile == 0.28 19:55:32 INFO - mozrunner == 6.11 19:55:32 INFO - mozscreenshot == 0.1 19:55:32 INFO - mozsystemmonitor == 0.3 19:55:32 INFO - moztest == 0.7 19:55:32 INFO - mozversion == 1.4 19:55:32 INFO - psutil == 3.1.1 19:55:32 INFO - requests == 1.2.3 19:55:32 INFO - wsgiref == 0.1.2 19:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:32 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:32 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:55:32 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:55:32 INFO - Using env: {'DISPLAY': ':0', 19:55:32 INFO - 'HOME': '/home/cltbld', 19:55:32 INFO - 'LANG': 'en_US.UTF-8', 19:55:32 INFO - 'LANGUAGE': 'en_US:en', 19:55:32 INFO - 'LOGNAME': 'cltbld', 19:55:32 INFO - 'MAIL': '/var/mail/cltbld', 19:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:32 INFO - 'MOZ_NO_REMOTE': '1', 19:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:32 INFO - 'NO_EM_RESTART': '1', 19:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:32 INFO - 'PWD': '/builds/slave/test', 19:55:32 INFO - 'SHELL': '/bin/bash', 19:55:32 INFO - 'SHLVL': '1', 19:55:32 INFO - 'TERM': 'linux', 19:55:32 INFO - 'TMOUT': '86400', 19:55:32 INFO - 'USER': 'cltbld', 19:55:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:32 INFO - '_': '/tools/buildbot/bin/python'} 19:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 INFO - Cleaning up... 19:55:33 INFO - Return code: 0 19:55:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:55: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:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:33 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:33 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:55:33 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:55:33 INFO - Using env: {'DISPLAY': ':0', 19:55:33 INFO - 'HOME': '/home/cltbld', 19:55:33 INFO - 'LANG': 'en_US.UTF-8', 19:55:33 INFO - 'LANGUAGE': 'en_US:en', 19:55:33 INFO - 'LOGNAME': 'cltbld', 19:55:33 INFO - 'MAIL': '/var/mail/cltbld', 19:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:33 INFO - 'MOZ_NO_REMOTE': '1', 19:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:33 INFO - 'NO_EM_RESTART': '1', 19:55:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:33 INFO - 'PWD': '/builds/slave/test', 19:55:33 INFO - 'SHELL': '/bin/bash', 19:55:33 INFO - 'SHLVL': '1', 19:55:33 INFO - 'TERM': 'linux', 19:55:33 INFO - 'TMOUT': '86400', 19:55:33 INFO - 'USER': 'cltbld', 19:55:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:33 INFO - '_': '/tools/buildbot/bin/python'} 19:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:33 INFO - Downloading/unpacking jsonschema 19:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:33 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:55:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:55:35 INFO - Downloading/unpacking functools32 (from jsonschema) 19:55:35 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:55:35 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:55:35 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:55:35 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:55:35 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:55:35 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:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 19:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:55:35 INFO - warning: no files found matching '*.txt' 19:55:35 INFO - no previously-included directories found matching 'build' 19:55:35 INFO - no previously-included directories found matching 'dist' 19:55:35 INFO - no previously-included directories found matching '.git*' 19:55:35 INFO - Installing collected packages: jsonschema, functools32 19:55:35 INFO - Running setup.py install for functools32 19:55:35 INFO - warning: no files found matching '*.txt' 19:55:35 INFO - no previously-included directories found matching 'build' 19:55:35 INFO - no previously-included directories found matching 'dist' 19:55:35 INFO - no previously-included directories found matching '.git*' 19:55:35 INFO - Successfully installed jsonschema functools32 19:55:35 INFO - Cleaning up... 19:55:35 INFO - Return code: 0 19:55:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:35 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 0x7f9d8e556f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', '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:55:35 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:55:35 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:55:35 INFO - Using env: {'DISPLAY': ':0', 19:55:35 INFO - 'HOME': '/home/cltbld', 19:55:35 INFO - 'LANG': 'en_US.UTF-8', 19:55:35 INFO - 'LANGUAGE': 'en_US:en', 19:55:35 INFO - 'LOGNAME': 'cltbld', 19:55:35 INFO - 'MAIL': '/var/mail/cltbld', 19:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:35 INFO - 'MOZ_NO_REMOTE': '1', 19:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:35 INFO - 'NO_EM_RESTART': '1', 19:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:35 INFO - 'PWD': '/builds/slave/test', 19:55:35 INFO - 'SHELL': '/bin/bash', 19:55:35 INFO - 'SHLVL': '1', 19:55:35 INFO - 'TERM': 'linux', 19:55:35 INFO - 'TMOUT': '86400', 19:55:35 INFO - 'USER': 'cltbld', 19:55:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:35 INFO - '_': '/tools/buildbot/bin/python'} 19:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:35 INFO - Downloading/unpacking flake8 19:55:35 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:55:35 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:55:35 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:55:35 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:55:35 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:55:35 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:55:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:55:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:55:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:55:38 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:55:38 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:55:38 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:55:38 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:55:38 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:55:38 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:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:38 INFO - no previously-included directories found matching 'docs/_build' 19:55:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:55:38 INFO - Running setup.py install for pep8 19:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:38 INFO - no previously-included directories found matching 'docs/_build' 19:55:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:55:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:55:38 INFO - Cleaning up... 19:55:38 INFO - Return code: 0 19:55:38 INFO - Running post-action listener: _resource_record_post_action 19:55:38 INFO - Running post-action listener: _start_resource_monitoring 19:55:38 INFO - Starting resource monitoring. 19:55:38 INFO - ##### 19:55:38 INFO - ##### Finished create-virtualenv step (success) 19:55:38 INFO - ##### 19:55:38 INFO - ##### 19:55:38 INFO - ##### Running install step. 19:55:38 INFO - ##### 19:55:38 INFO - Running pre-action listener: _resource_record_pre_action 19:55:38 INFO - Running main action method: install 19:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:55:38 INFO - Reading from file tmpfile_stdout 19:55:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:55:38 INFO - Reading from file tmpfile_stdout 19:55:38 INFO - Output received: 19:55:38 INFO - Usage: mozinstall [options] installer 19:55:38 INFO - Options: 19:55:38 INFO - -h, --help show this help message and exit 19:55:38 INFO - -d DEST, --destination=DEST 19:55:38 INFO - Directory to install application into. [default: 19:55:38 INFO - "/builds/slave/test"] 19:55:38 INFO - --app=APP Application being installed. [default: firefox] 19:55:38 INFO - mkdir: /builds/slave/test/build/application 19:55:38 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:55:38 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:55:54 INFO - Reading from file tmpfile_stdout 19:55:54 INFO - Output received: 19:55:54 INFO - /builds/slave/test/build/application/firefox/firefox 19:55:54 INFO - Running post-action listener: _resource_record_post_action 19:55:54 INFO - ##### 19:55:54 INFO - ##### Finished install step (success) 19:55:54 INFO - ##### 19:55:54 INFO - ##### 19:55:54 INFO - ##### Running run-tests step. 19:55:54 INFO - ##### 19:55:54 INFO - Running pre-action listener: _resource_record_pre_action 19:55:54 INFO - Running main action method: run_tests 19:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:55:54 INFO - Python 2.7.3 19:55:54 INFO - Return code: 0 19:55:54 INFO - grabbing minidump binary from tooltool 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:54 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 0x254a9c0>, '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 0x254b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:55:54 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:55:54 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:55:54 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:55:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:55:54 INFO - Return code: 0 19:55:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:55:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:55:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:55:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:55:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:55:55 INFO - Return code: 0 19:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:55:55 INFO - Using env: {'DISPLAY': ':0', 19:55:55 INFO - 'HOME': '/home/cltbld', 19:55:55 INFO - 'LANG': 'en_US.UTF-8', 19:55:55 INFO - 'LANGUAGE': 'en_US:en', 19:55:55 INFO - 'LOGNAME': 'cltbld', 19:55:55 INFO - 'MAIL': '/var/mail/cltbld', 19:55:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:55:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:55 INFO - 'MOZ_NO_REMOTE': '1', 19:55:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:55 INFO - 'NO_EM_RESTART': '1', 19:55:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:55 INFO - 'PWD': '/builds/slave/test', 19:55:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:55:55 INFO - 'SHELL': '/bin/bash', 19:55:55 INFO - 'SHLVL': '1', 19:55:55 INFO - 'TERM': 'linux', 19:55:55 INFO - 'TMOUT': '86400', 19:55:55 INFO - 'USER': 'cltbld', 19:55:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683', 19:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:55 INFO - '_': '/tools/buildbot/bin/python'} 19:55:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:55:55 INFO - mozversion application_buildid: 20160526184553 19:55:55 INFO - mozversion application_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 19:55:55 INFO - mozversion application_display_name: Nightly 19:55:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:55:55 INFO - mozversion application_name: Firefox 19:55:55 INFO - mozversion application_remotingname: firefox 19:55:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:55:55 INFO - mozversion application_vendor: Mozilla 19:55:55 INFO - mozversion application_version: 49.0a1 19:55:55 INFO - mozversion platform_buildid: 20160526184553 19:55:55 INFO - mozversion platform_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 19:55:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:55:55 INFO - mozversion platform_version: 49.0a1 19:55:55 INFO - using testdate: 1464317755 19:55:55 INFO - actual date: 1464317755 19:55:55 INFO - starting webserver on 'localhost:49723' 19:55:55 INFO - SUITE-START | Running 2 tests 19:55:55 INFO - TEST-START | dromaeo_css 19:55:55 INFO - operating with platform_type : linux_ 19:55:55 INFO - Initialising browser for dromaeo_css test... 19:55:55 INFO - TEST-INFO | started process 21809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HLfZj/profile http://localhost:49723/getInfo.html) 19:56:00 INFO - PROCESS | 21809 | __metrics Screen width/height:1600/1200 19:56:00 INFO - PROCESS | 21809 | colorDepth:24 19:56:00 INFO - PROCESS | 21809 | Browser inner width/height: 1024/697 19:56:00 INFO - PROCESS | 21809 | __metrics 19:56:01 ERROR - PROCESS | 21809 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:56:02 INFO - TEST-INFO | 21809: exit 0 19:56:02 INFO - Browser initialized. 19:56:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:02 INFO - TEST-INFO | started process 21891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HLfZj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:14 INFO - PROCESS | 21891 | RSS: Main: 157667328 19:56:14 INFO - PROCESS | 21891 | 19:57:05 INFO - PROCESS | 21891 | 1464317825760 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:59:17 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49723/tests/dromaeo/cssquery-ext.html) 19:59:18 INFO - PROCESS | 21891 | RSS: Main: 268697600 19:59:18 INFO - PROCESS | 21891 | 20:02:21 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-ext.html (next: http://localhost:49723/tests/dromaeo/cssquery-jquery.html) 20:02:21 INFO - PROCESS | 21891 | RSS: Main: 241410048 20:02:21 INFO - PROCESS | 21891 | 20:05:24 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49723/tests/dromaeo/cssquery-mootools.html) 20:05:24 INFO - PROCESS | 21891 | RSS: Main: 244965376 20:05:24 INFO - PROCESS | 21891 | 20:08:26 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49723/tests/dromaeo/cssquery-prototype.html) 20:08:27 INFO - PROCESS | 21891 | RSS: Main: 244748288 20:08:27 INFO - PROCESS | 21891 | 20:11:30 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49723/tests/dromaeo/cssquery-yui.html) 20:11:31 INFO - PROCESS | 21891 | RSS: Main: 217542656 20:11:31 INFO - PROCESS | 21891 | 20:14:33 INFO - PROCESS | 21891 | Cycle 1(1): loaded http://localhost:49723/tests/dromaeo/cssquery-yui.html (next: http://localhost:49723/tests/dromaeo/cssquery-dojo.html) 20:14:34 INFO - PROCESS | 21891 | RSS: Main: 270041088 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | __start_tp_report 20:14:34 INFO - PROCESS | 21891 | _x_x_mozilla_page_load 20:14:34 INFO - PROCESS | 21891 | _x_x_mozilla_page_load_details 20:14:34 INFO - PROCESS | 21891 | |i|pagename|runs| 20:14:34 INFO - PROCESS | 21891 | |0;dojo.html;2673.812833101683;2705.9458810823785;2715.6469658944334;2725.0189931624623;2765.0598796409217;4712.222483290261;4782.067496838118;4789.664723469358;4905.705657660538;4906.411230652322;4794.352762377078;4829.903401931968;4839.298301746245;4891.364122664048;4923.433805112413;4444.266695995157;4449.66627502937;4485.215087359716;4527.479339875924;4545.749983750892;4478.865634030968;4556.886077848064;4584.701994370372;4592.770361481929;4633.4208223972;4496.280595104784;4498.572635599613;4524.140413321458;4526.366308716782;4563.885902852438;4339.5877391648055;4369.279068953619;4443.200223959686;4487.147441986045;4514.932276015862;4402.8679139625865;4462.843800466968;4471.374007638933;4500.34744961982;4511.526289739563;4763.54746299101;4778.737169455679;4813.133635945528;4829.227323628203;4832.5409086137115;5107.923381149286;5169.793208271664;5236.345456817898;5237.580993520509;5313.335833020872;5304.893902121975;5314.5748340132695;5317.282166907496;5336.706481143536;5364.0612892744;4769.403824521934;4925.4335751388335;4940.258961155855;4969.900601987976;4986.326845875797;5334.146536554133;5392.514673679388;5410.458954104558;5425.891482170335;5459.262999495097;5194.636375453758;5197.376314842168;5233.607479439057;5246.31797866275;5249.973750131225;5153.994970980622;5195.584353251731;5300.04599172145;5301.920471192935;5348.9732551337775;5203.583713302926;5225.921611175835;5233.371995360581;5253.133233016586;5298.867528311746;5222.503862133091;5233.031889100528;5238.8166414176085;5241.790328386822;5291.682499050069;4435.401220835146;4462.776861156929;4502.032063106448;4526.275795872644;4535.092981403666;3821.9426708599394;3841.2893614680816;3855.4216867470104;3865.168988667394;3926.1362500249897;4439.445069366329;4463.241248987615;4465.0400163964905;4477.328400739915;4520.208963431386;5116.3348764661105;5148.433672296044;5156.7421628919155;5242.868928276747;5305.734713264398;4417.359482874966;4434.179676759745;4453.955460445354;4488.169688607552;4494.9325760113625;4708.717476951394;4721.126591580569;4721.4570324413135;4748.287756836502;4766.737829419415;4787.114383839001;4871.780769865293;4889.608831293417;4890.388701412252;4906.607471402208;5249.632525723316;5303.628745987899;5334.493223143795;5338.626296159232;5353.2505449237915;4897.755112244445;4927.211646136601;4930.8767280818265;4931.3096166536;4976.925346119883;5061.139606267017;5128.307678463509;5188.143956247177;5188.636795424284;5189.169732842727;5280.841574752763;5288.3918349390315;5290.100682883842;5291.153415453509;5338.412774594869;5037.798488060436;5066.44269130388;5067.391912970467;5081.161608334583;5121.8719532012;5010.849674509771;5061.392632884077;5066.214736715815;5108.106081435808;5164.509371609691;5085.135526960352;5098.694078355162;5116.923246151385;5142.871428214325;5156.278121062979;5172.250023746611;5189.040027594907;5192.350956130484;5223.2948551945;5242.816501422432;4951.5048495150195;5001.4998500149695;5040.596752259884;5046.34397528319;5072.289879416959 20:14:34 INFO - PROCESS | 21891 | |1;ext.html;554.1632135475431;597.107324549798;608.6348191085349;610.9877802443948;611.184069267528;27616;29913.85043074787;40184.79907600458;41201;41204.38193427093;41931.790341048254;42541.57458425415;42562.36156457655;42573;42633;7871.999999999985;8046.919530804705;8078.474899131567;8081.515109093444;8093.716719914804;7863.56750378729;7968.12350641429;7990.240927111915;7992.720254791084;7994.360451163893;8021.117677055519;8067.556284404355;8068.596570171498;8071.394645401619;8071.434999550034;7954.681812727484;8040.8391832163325;8054.637541310596;8057.5165490070785;8059.274665280094;7874;7954.284114429729;7967;7972.60136993148;7974.720884769005;38795.41806872899;38982;39101.41347879784;39105.413418798744;39174;3029.2763616796733;3072.7234548890483;3101.0386780098015;3182.45898197307;3358.2611825398617;29626.407471850656;30001.849990749906;30455;30504.08487745371;31682.207944801336;3291.687289707474;3392.423288041039;3432.3478539077496;3457.291255292659;3481.3733527964955;266388;267179;267985;268158;269644;32086.83956580202;56594.15108773372;57858.34629017633;57901.420985789606;57901.420985789606;33002.504962425584;33096.50355244673;33323.500147497805;33343.99936003848;33349.499757503654;11693;11790.292582445081;11791.410429478492;11792.587259445878;11795;9673.516324183762;9694.175995040501;9696.272779541421;9715.805683886283;9721.513924303756;7998.4001199910235;8007.199280071946;8010.3191228745045;8061.758147255592;8096.392770542233;3099.395617854497;3125.281185327342;3162.6204855417495;3168.987692815033;3174.1905814017277;853.7225401744333;893.5889490834159;895.8432274352093;911.284641556375;1006.6879267427121;26208;27505.31236719098;27734.3066423337;28637.28406789847;29136.125916222547;897.0536084430857;910.239949642043;924.5977999570074;935.3966691483955;971.7522031881966;14415.135091894519;15041.473548425753;15053.172075535951;15161.62095947588;15313.693726125415;402939;403819;407106;408628;409025;50888.745556271984;51630.48369516332;51658.74170629198;51672;51830.74084629553;1091.3560999010463;1177.3348058347005;1200.0699457920007;1204.8192771084407;1226.4726167747954;28749.85000600036;29671.703282966893;30068.849655752456;30211.546826798054;30378.240543986576;43140.352894705975;43825.34261986137;43879;43928;43959.78020109879;296288;298210;298934;299138;299271;25466.879528917903;26198;26303.4739305209;26419.735802642495;26464.470710586065;43027.139457210054;43178.568214317456;43775.78112109419;44545.77727111344;44711;36833.81583092068;37499.43750843685;37928.43107353447;38080.052782054234;38300.233995320494;36431.635683642824;37804.24391512099;37831.81084094562;40913;40929.795351024244;36029.15930634646;37165.62834371622;37538.81230593829;37556.248875022895;37654.62345376621;31497.527537086502;33457.33085338328;34165.65834341724;34297.142571435914;34410.655893440744;24216.63675044911;24477.632835507124;24770;24793.256202313958;24998.750012500368 20:14:34 INFO - PROCESS | 21891 | |2;jquery.html;379.2074564160905;379.8006046825415;386.8452618952419;397.1441543473811;398.1439904205957;16168.757468637965;16654.583635409123;17061.720370972194;17083.658326833473;17114.828851711478;16413.17934103296;17153.57116072099;17190.312387504484;17191.656166876684;17749.91125044373;5306.814261500848;5711.428857114276;5749.453801888814;5795.652260864362;5803.47768700819;4058.9188216235657;4123.505179378479;4160.7087503874745;6516.250631177428;7165.964170179142;7098.254683258261;7122.287771222862;7138.607376594286;7151.177614574312;7162.820929476753;6717.798466046026;6905.620190889499;7007.509474336798;7167.605781681979;7176.246494118094;3889.397143442771;6141.907871381933;6521.608703477807;6527.314631963671;6634.772567075107;19707.704384434244;19723.605527889504;22376.55246895053;23704.762952370602;23743.525129497313;1810.5473631592101;1839.5309196155029;1875.1749230338744;1893.0818553001784;2170.934871953844;13990.0906441081;14636.634084147876;14648.414063437556;14651.633709157357;14821.77767333491;1803.3958623861022;1871.363736329641;1894.6968485042464;1979.6436641404541;2031.1164643380177;53413;65815.3418465814;69106;78878;81178.18821811765;16533.866533366658;16563.6687266254;16602.58493537647;16812.915935420246;16819.83180168207;29666.851665741535;29817.552736708967;29899.551506727417;29929.551056734166;30028;7959.920400796033;8363.749087527383;8437.409381343246;8531.23218910301;8556.61495232716;6754.189497260262;6804.863902722017;6873.106496155568;6910.792676219721;6911.274316196727;8528.507511185519;8688.39181257306;8703.825923481621;8721.956390218009;8790.208881200595;3211.6627754085953;3231.8545665445113;3374.4094783412806;3453.1194545390763;3477.23500829817;778.9649465774054;800.1198681450358;814.0191069760924;836.0552575589545;847.3052097280171;15596.92201538985;15833;15857;16553.917230413772;16661.750073748663;885.6103314541581;903.9593218305192;940.0693313619604;946.1390134977275;962.3263715399248;9178.632854685738;9183.908160918305;9236.491992940319;9254.629814807333;9447.291453141042;326694;338858;356024;367757;367816;52447;75928.62035689787;77153.61423192848;78005.21994780093;78088;874.6239117179547;877.5683878616097;901.1709227510706;911.2072496927583;911.6763548940163;10717.732056698645;12678.683032924251;14692.779608306098;15432.92283538575;15581;35457.29085418329;35864.462033069;35948.46077308895;36228;36228.63771362253;45062.54937450714;45203.77398112988;46024.769876151746;46408.30387544257;46501.302480462145;7188.245234250328;7209.783706488814;7474.439417043634;7499.98750168742;7563.546187228784;9899.604015839286;11534.480948357177;11549;11570.305746678365;11614.593489227836;9198.540072996457;9215.953920230357;9393.201577865959;9419.387739796892;9453.149216570542;9595.712128636153;9694.854577181206;9756;9810;9959.502024898871;9263.583138758637;9458.763530911783;9507.572159252712;9618.51907404613;9862.704118876445;6953.374196322356;6967.756128535477;7156.928430715834;7208.56748595086;7315.3781928534545;7418.777436676908;9404;9598.472084035166;9656.259508856541;9731.756706082404 20:14:34 INFO - PROCESS | 21891 | |3;mootools.html;1243.0801207106745;1418.673705047839;1453.5348688419706;1548.3496931288857;1756.0605076284191;6588.637624930633;7392.5564466132;7635;7660.463767536282;7855.05739311282;7601.7719468416035;7635.923640763591;7681;7690.846183076335;7702.8844567331535;2219.05690081715;2245.854019488736;2248.7863652953024;2249.4826189976316;2251.7410497792716;2212.4358288636454;2236.4185311818965;2240.6639004149347;2241.069955968271;2247.2471721973156;2212.5685491329195;2216.3018649125556;2227.0312414099835;2229.308914236584;2254.425121593991;2139.6469582518866;2156.8813715245656;2158.935231943044;2161.8919054047315;2165.101482884601;2147.3128598848375;2148.495103650641;2151.182550630766;2151.7955794199684;2159.5356998245297;7419.591922444318;7627.313541781211;7664.578448185348;7694.9230507694765;7699.153093159748;4677.438707355105;4843.15244832153;4849.660523763338;4858.125537403266;4859.125357435661;2909.7090290970946;3053.328267781085;3116.111908106179;3116.548100525411;3122.5160100184507;958.5590628310986;968.3463662028103;974.1184228273424;1012.4026824173699;1025.0108645157459;10477.790444191074;10597.311174773693;10602.098821600173;10612.522436490299;10618.991195836461;4243.108947121139;4368.584984426474;4519.977400112978;4529.54704529551;4603;8027.598620068973;8105.27052565272;8129.390295727844;8156;8167.754967350989;4615.330777037311;4615.538446155425;4616.3537104805355;4620.514845941195;4636.629069674418;3677.5403074615674;3730.9813450933116;4321.373400856858;4322.78386080701;4354.085642015212;3492.4935884296633;3495.49315349278;3545.18460754028;3587.264610754789;3619.746617736786;1030.30454443252;1036.7304500829687;1037.2894567221476;1047.1413440978324;1057.6668349469892;706.9328413800681;833.1793183714037;840.6091167607092;843.2705709561308;879.6437442835662;5206.661566998208;5407.675539467645;5447.455254474521;5447.6731396115565;5517.282753242052;869.387082107113;883.430187529053;889.8131392407538;903.2864037410503;935.8409070458039;3607.7113830893463;3689.3543629864666;3738.140227747633;3752.380857158593;3774.7168962327937;9259.166674999147;9497.192738617296;9512.28657850664;9657.082577155159;9669.033096690275;9546.140847323773;9548;9555.426674399558;9580.856287155699;9613;7265.309795569412;7278.854422911512;7387.519811212254;7428.071491063617;7442.255774422622;5206.271122042993;5234.790608375774;5235;5264.605154613343;5334.1732031535175;8957.059508751487;9042.50266235337;9042.593083311398;9066.410683305565;9076;8827.117288271378;9050.683226087318;9169.954150229472;9187.770305742142;9195.310351723781;5767.307923049261;5843.386444423274;6336.461400780985;6392.488600912009;6525.673716314071;7512;7541.472096953161;7577.16651168382;7595.08858936909;7620.161782203842;6802.93197068023;6844.520883538304;6873.896891546731;6920.30796920304;7156.534825236343;6872.347127022925;6907.965460172667;6931;6978.651067446709;7017.2631873652535;6391.96804015977;6399.168108145911;6465.579737317059;6484.773032943825;6523.054157147282;4557.749323787223;4690.906181876411;4693.108309421199;4738.028704115579;4764.213904705684;4665.836695715634;4676.906461870675;4700.412448443944;4756.239001759702;4774.427068751772 20:14:34 INFO - PROCESS | 21891 | |4;prototype.html;310.1641077296685;310.59932686833986;315.55664291670206;316.0723277181473;316.13064073797057;4896.510348965102;4898.559129678329;4910.2634604809255;4935.161022626153;4937.925931111032;4830.686005409646;4847.830325938593;4867.610591152708;4881.4630390657;4903.215485522317;3632.3483856784496;3698.6486283802997;3708.128589781399;3765.7363984521094;3853.1715681128553;3771;3800.1069748609057;3805.5243094613174;3825.598312177223;3831.731778775487;3641.1625326174994;3754.2866855297407;3798.7274263121885;3800.9619903800885;3802.372608519605;3681.4293784463453;3818.3127037133304;3824.7131465140224;3842;3843.2889915365745;3387.5257463955068;3392.0671815251003;3398.3713013092656;3410.5225268462436;3411.624721280657;4660.906781864378;4675.298705194214;4675.901163226639;4685.8594242172785;4704.223803072489;4277.572242775728;4385.539518350591;4387.429634147572;4397.1865204937185;4406.700023493077;5094.847154585368;5125.79543807205;5129.410117836459;5136.280920671109;5152.201408781645;3699.315626609059;3717.9814100929593;3718.2935242303874;3718.3864662330684;3739.607341229186;5107.565856902168;5339.599530035263;5351.491608297206;5356.491133342326;5357.4106848246665;3753.0242137044565;3774.6036666149657;3777.490038844721;3788.8484460621266;3797.784708893183;3833.6358045985585;3849.2493963677375;3865.1883104547796;3870.5355357356734;3873.3802591585213;4395.428594282723;4397.978010109929;4401.119776044804;4414.404055452473;4429.247028005247;4873.610111191097;5102.923456148161;5129.794808207705;5138.3577052868395;5140.820071297487;1257.937103144839;1286.1575667937516;1292.9224246545236;1301.271288078679;1306.196689036236;804.284187073505;820.4912953968578;848.245061894914;867.3018220332567;872.5680788009976;4483.865484035419;4498.100379924028;4498.932516012263;4501.122281155209;4511.909761804745;5232.816851410258;5232.9738351308;5245.344331958505;5279.709615971158;5285.757846905974;4314.288142456522;4399.186150562156;4410.294352903584;4470.128324976598;4602.309653551927;2811.9015834445695;2812.54999200127;2814.690384057752;2839.872205750746;2843.3744576193203;4983.327250821165;4983.775730092155;4988.702937236272;4990.72551009698;4999.47505511916;5033.7734801934;5412.512873841373;5433.701146436984;5443.265159203536;5483.616146869761;4963.652544322007;4972;4992.301077849177;5012.298278241049;5025.246213067996;5325.147976323769;5331.813386531608;5336.306280183707;5338.626296159387;5359.571234301325;5010.799568017239;5254.632175747661;5255.237990491434;5272.420033796203;5276.997370499593;4955.702657840541;4980.800767969241;4987.376577927759;4988.852563910248;4993.425756038102;3732.384156614128;3767.6420740029653;3790.2040571479197;3795.1650636859845;3800.277947190025;5122.743862806919;5264.9736751315995;5313.601479889101;5321.951048846299;5357.8300788179295;5089.05852417304;5101.260317253903;5101.540861322499;5153.922691159561;5164.354455693038;5120.846374608767;5149.845504634867;5159.2003239497935;5192.701824543864;5194.68831870089;4823.252395878504;4942.75286235694;5070.340855688737;5070.960453107031;5100.132977393926;5053.545180933734;5142.228665700175;5146.8970620588125;5169.009931176449;5182.663126896739;5059.316992206005;5059.974700126476;5074.619403544675;5074.6194035448225;5079.87300317495 20:14:34 INFO - PROCESS | 21891 | |5;yui.html;649.164015500649;655.197383205573;657.8651376467825;697.3897839390534;703.4829400390715;10909.399983000932;12137.089718271132;12834.229946203222;13027.088103832735;13066.95464362851;12639.494420223204;12668.61994140175;12727.618171454847;12728.427220775064;12752.936235318833;635.6154526511464;796.5539297993114;808.4744915804745;810.2059981218409;810.2990912860392;648.8540078482351;654.7446495866616;655.3021032600266;783.8863364812099;804.2962407893093;843.4812590256978;847.3560094328324;848.516345682961;852.497026754218;853.0744142605281;838.3502785341378;840.684743221292;840.7982084299786;840.9621567029499;841.4362377207286;490.5045903637316;599.2988203801519;618.653554009756;619.5601123202532;621.3786213786213;12558.183718058297;12566.371681415892;12580.559680411234;12598.55905043319;12655.93672031634;11930.463129159121;12349.19730217533;12541.435635396429;12641.557545485955;12678.039912902772;11045.502952367162;11080.168987325902;11239.550417983271;11280.097592192606;11290.604828830952;4029.3553031514816;4048.8582899598373;4056.7363121397016;4073.185362927397;4195.202911446815;43141.35287970683;43461.13077738459;43713.34429983553;43853.780731096456;44102;9118.908810911938;9361.157495825408;9939.453330066915;9979.101880830614;10131.64539241123;16999.830001700073;17141.828581714024;17190.656186876193;17205.7419138713;17209.91395043042;6177.7837775677635;6312.116303717483;6455.548111632234;6531.412172904462;6594.934050659528;3544.503769472276;3576.3562558739154;3641.9453708194396;3712.6658600726064;3820.7707537547835;2824.1386377154754;2884.4663737208684;2893.030834670409;2896.20354402541;2896.8986085487327;553.7867920850501;582.5747204540625;585.5374254339024;593.7387549478216;598.7814447726548;523.2831021500492;561.5535649158928;616.3774587666489;617.2438762515882;633.2179757998867;7874.72438464651;7925.088614809255;7957.7612671619945;7987.400944929037;8046.195380462024;611.0711718188329;613.1324176290589;620.9844753881099;622.9065640154013;633.6958260035209;3973.8609148679657;4241.1941731071;4241.491021077491;4310.288802347577;4312.654987600984;57695.711521442965;58162.127568086515;58526.70736646289;59591.702041489516;59807;51180.74409627928;51365.48634513607;52321;52548.73725631424;53194.468055319725;47423.52576474191;47549.5245047552;47768;47854.760726196146;48248.27627585589;7923.20767923203;8078.111407745261;8094.51432914027;8110.432269741062;8283.83432331362;31957.36085278235;32355.838220808746;32387;33196;33221;40543.79728101341;42339.364909527;42753.78623106865;42928.141437171704;43011.569884300756;10951.178661600572;10989.285696429706;11028.669139925814;11283.492242849255;11474.082073434272;12122.696932576757;12284.692882677648;12294.446749896097;12388;12621.368931553568;10723.088537474401;11242.269252498561;11285.71785705364;11522.769544608893;11773.234739741889;11160.497777599865;11227.27022743519;11767.176297659082;11787.528498860293;11820.940895295469;10414.843777343194;10555.261131720707;10684.198685098494;10805.135589152691;11061.668149955514;9409.153176214173;9446.95276523613;9534.380265282734;9740.344141495822;9812;9136.543172841464;9167.358284919992;9173.40372875761;9186.632534698805;9282.767930801783 20:14:34 INFO - PROCESS | 21891 | __end_tp_report 20:14:34 INFO - PROCESS | 21891 | __start_cc_report 20:14:34 INFO - PROCESS | 21891 | _x_x_mozilla_cycle_collect,1018 20:14:34 INFO - PROCESS | 21891 | __end_cc_report 20:14:34 INFO - PROCESS | 21891 | __startTimestamp1464318874141__endTimestamp 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | ------- Summary: start ------- 20:14:34 INFO - PROCESS | 21891 | Number of tests: 6 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#0] dojo.html Cycles:165 Average:4842.32 Median:4951.50 stddev:521.53 (10.5%) stddev-sans-first:494.60 20:14:34 INFO - PROCESS | 21891 | Values: 2673.8 2705.9 2715.6 2725.0 2765.1 4712.2 4782.1 4789.7 4905.7 4906.4 4794.4 4829.9 4839.3 4891.4 4923.4 4444.3 4449.7 4485.2 4527.5 4545.7 4478.9 4556.9 4584.7 4592.8 4633.4 4496.3 4498.6 4524.1 4526.4 4563.9 4339.6 4369.3 4443.2 4487.1 4514.9 4402.9 4462.8 4471.4 4500.3 4511.5 4763.5 4778.7 4813.1 4829.2 4832.5 5107.9 5169.8 5236.3 5237.6 5313.3 5304.9 5314.6 5317.3 5336.7 5364.1 4769.4 4925.4 4940.3 4969.9 4986.3 5334.1 5392.5 5410.5 5425.9 5459.3 5194.6 5197.4 5233.6 5246.3 5250.0 5154.0 5195.6 5300.0 5301.9 5349.0 5203.6 5225.9 5233.4 5253.1 5298.9 5222.5 5233.0 5238.8 5241.8 5291.7 4435.4 4462.8 4502.0 4526.3 4535.1 3821.9 3841.3 3855.4 3865.2 3926.1 4439.4 4463.2 4465.0 4477.3 4520.2 5116.3 5148.4 5156.7 5242.9 5305.7 4417.4 4434.2 4454.0 4488.2 4494.9 4708.7 4721.1 4721.5 4748.3 4766.7 4787.1 4871.8 4889.6 4890.4 4906.6 5249.6 5303.6 5334.5 5338.6 5353.3 4897.8 4927.2 4930.9 4931.3 4976.9 5061.1 5128.3 5188.1 5188.6 5189.2 5280.8 5288.4 5290.1 5291.2 5338.4 5037.8 5066.4 5067.4 5081.2 5121.9 5010.8 5061.4 5066.2 5108.1 5164.5 5085.1 5098.7 5116.9 5142.9 5156.3 5172.3 5189.0 5192.4 5223.3 5242.8 4951.5 5001.5 5040.6 5046.3 5072.3 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#1] ext.html Cycles:180 Average:47192.62 Median:38190.14 stddev:87006.62 (227.8%) stddev-sans-first:87180.23 20:14:34 INFO - PROCESS | 21891 | Values: 554.2 597.1 608.6 611.0 611.2 27616.0 29913.9 40184.8 41201.0 41204.4 41931.8 42541.6 42562.4 42573.0 42633.0 7872.0 8046.9 8078.5 8081.5 8093.7 7863.6 7968.1 7990.2 7992.7 7994.4 8021.1 8067.6 8068.6 8071.4 8071.4 7954.7 8040.8 8054.6 8057.5 8059.3 7874.0 7954.3 7967.0 7972.6 7974.7 38795.4 38982.0 39101.4 39105.4 39174.0 3029.3 3072.7 3101.0 3182.5 3358.3 29626.4 30001.8 30455.0 30504.1 31682.2 3291.7 3392.4 3432.3 3457.3 3481.4 266388.0 267179.0 267985.0 268158.0 269644.0 32086.8 56594.2 57858.3 57901.4 57901.4 33002.5 33096.5 33323.5 33344.0 33349.5 11693.0 11790.3 11791.4 11792.6 11795.0 9673.5 9694.2 9696.3 9715.8 9721.5 7998.4 8007.2 8010.3 8061.8 8096.4 3099.4 3125.3 3162.6 3169.0 3174.2 853.7 893.6 895.8 911.3 1006.7 26208.0 27505.3 27734.3 28637.3 29136.1 897.1 910.2 924.6 935.4 971.8 14415.1 15041.5 15053.2 15161.6 15313.7 402939.0 403819.0 407106.0 408628.0 409025.0 50888.7 51630.5 51658.7 51672.0 51830.7 1091.4 1177.3 1200.1 1204.8 1226.5 28749.9 29671.7 30068.8 30211.5 30378.2 43140.4 43825.3 43879.0 43928.0 43959.8 296288.0 298210.0 298934.0 299138.0 299271.0 25466.9 26198.0 26303.5 26419.7 26464.5 43027.1 43178.6 43775.8 44545.8 44711.0 36833.8 37499.4 37928.4 38080.1 38300.2 36431.6 37804.2 37831.8 40913.0 40929.8 36029.2 37165.6 37538.8 37556.2 37654.6 31497.5 33457.3 34165.7 34297.1 34410.7 24216.6 24477.6 24770.0 24793.3 24998.8 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#2] jquery.html Cycles:180 Average:23886.23 Median:6329.08 stddev:58109.64 (918.1%) stddev-sans-first:58245.85 20:14:34 INFO - PROCESS | 21891 | Values: 379.2 379.8 386.8 397.1 398.1 16168.8 16654.6 17061.7 17083.7 17114.8 16413.2 17153.6 17190.3 17191.7 17749.9 5306.8 5711.4 5749.5 5795.7 5803.5 4058.9 4123.5 4160.7 6516.3 7166.0 7098.3 7122.3 7138.6 7151.2 7162.8 6717.8 6905.6 7007.5 7167.6 7176.2 3889.4 6141.9 6521.6 6527.3 6634.8 19707.7 19723.6 22376.6 23704.8 23743.5 1810.5 1839.5 1875.2 1893.1 2170.9 13990.1 14636.6 14648.4 14651.6 14821.8 1803.4 1871.4 1894.7 1979.6 2031.1 53413.0 65815.3 69106.0 78878.0 81178.2 16533.9 16563.7 16602.6 16812.9 16819.8 29666.9 29817.6 29899.6 29929.6 30028.0 7959.9 8363.7 8437.4 8531.2 8556.6 6754.2 6804.9 6873.1 6910.8 6911.3 8528.5 8688.4 8703.8 8722.0 8790.2 3211.7 3231.9 3374.4 3453.1 3477.2 779.0 800.1 814.0 836.1 847.3 15596.9 15833.0 15857.0 16553.9 16661.8 885.6 904.0 940.1 946.1 962.3 9178.6 9183.9 9236.5 9254.6 9447.3 326694.0 338858.0 356024.0 367757.0 367816.0 52447.0 75928.6 77153.6 78005.2 78088.0 874.6 877.6 901.2 911.2 911.7 10717.7 12678.7 14692.8 15432.9 15581.0 35457.3 35864.5 35948.5 36228.0 36228.6 45062.5 45203.8 46024.8 46408.3 46501.3 7188.2 7209.8 7474.4 7500.0 7563.5 9899.6 11534.5 11549.0 11570.3 11614.6 9198.5 9216.0 9393.2 9419.4 9453.1 9595.7 9694.9 9756.0 9810.0 9959.5 9263.6 9458.8 9507.6 9618.5 9862.7 6953.4 6967.8 7156.9 7208.6 7315.4 7418.8 9404.0 9598.5 9656.3 9731.8 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#3] mootools.html Cycles:180 Average:5128.94 Median:5249.80 stddev:2820.96 (53.7%) stddev-sans-first:2813.75 20:14:34 INFO - PROCESS | 21891 | Values: 1243.1 1418.7 1453.5 1548.3 1756.1 6588.6 7392.6 7635.0 7660.5 7855.1 7601.8 7635.9 7681.0 7690.8 7702.9 2219.1 2245.9 2248.8 2249.5 2251.7 2212.4 2236.4 2240.7 2241.1 2247.2 2212.6 2216.3 2227.0 2229.3 2254.4 2139.6 2156.9 2158.9 2161.9 2165.1 2147.3 2148.5 2151.2 2151.8 2159.5 7419.6 7627.3 7664.6 7694.9 7699.2 4677.4 4843.2 4849.7 4858.1 4859.1 2909.7 3053.3 3116.1 3116.5 3122.5 958.6 968.3 974.1 1012.4 1025.0 10477.8 10597.3 10602.1 10612.5 10619.0 4243.1 4368.6 4520.0 4529.5 4603.0 8027.6 8105.3 8129.4 8156.0 8167.8 4615.3 4615.5 4616.4 4620.5 4636.6 3677.5 3731.0 4321.4 4322.8 4354.1 3492.5 3495.5 3545.2 3587.3 3619.7 1030.3 1036.7 1037.3 1047.1 1057.7 706.9 833.2 840.6 843.3 879.6 5206.7 5407.7 5447.5 5447.7 5517.3 869.4 883.4 889.8 903.3 935.8 3607.7 3689.4 3738.1 3752.4 3774.7 9259.2 9497.2 9512.3 9657.1 9669.0 9546.1 9548.0 9555.4 9580.9 9613.0 7265.3 7278.9 7387.5 7428.1 7442.3 5206.3 5234.8 5235.0 5264.6 5334.2 8957.1 9042.5 9042.6 9066.4 9076.0 8827.1 9050.7 9170.0 9187.8 9195.3 5767.3 5843.4 6336.5 6392.5 6525.7 7512.0 7541.5 7577.2 7595.1 7620.2 6802.9 6844.5 6873.9 6920.3 7156.5 6872.3 6908.0 6931.0 6978.7 7017.3 6392.0 6399.2 6465.6 6484.8 6523.1 4557.7 4690.9 4693.1 4738.0 4764.2 4665.8 4676.9 4700.4 4756.2 4774.4 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#4] prototype.html Cycles:180 Average:4263.68 Median:4888.99 stddev:1238.29 (25.3%) stddev-sans-first:1205.68 20:14:34 INFO - PROCESS | 21891 | Values: 310.2 310.6 315.6 316.1 316.1 4896.5 4898.6 4910.3 4935.2 4937.9 4830.7 4847.8 4867.6 4881.5 4903.2 3632.3 3698.6 3708.1 3765.7 3853.2 3771.0 3800.1 3805.5 3825.6 3831.7 3641.2 3754.3 3798.7 3801.0 3802.4 3681.4 3818.3 3824.7 3842.0 3843.3 3387.5 3392.1 3398.4 3410.5 3411.6 4660.9 4675.3 4675.9 4685.9 4704.2 4277.6 4385.5 4387.4 4397.2 4406.7 5094.8 5125.8 5129.4 5136.3 5152.2 3699.3 3718.0 3718.3 3718.4 3739.6 5107.6 5339.6 5351.5 5356.5 5357.4 3753.0 3774.6 3777.5 3788.8 3797.8 3833.6 3849.2 3865.2 3870.5 3873.4 4395.4 4398.0 4401.1 4414.4 4429.2 4873.6 5102.9 5129.8 5138.4 5140.8 1257.9 1286.2 1292.9 1301.3 1306.2 804.3 820.5 848.2 867.3 872.6 4483.9 4498.1 4498.9 4501.1 4511.9 5232.8 5233.0 5245.3 5279.7 5285.8 4314.3 4399.2 4410.3 4470.1 4602.3 2811.9 2812.5 2814.7 2839.9 2843.4 4983.3 4983.8 4988.7 4990.7 4999.5 5033.8 5412.5 5433.7 5443.3 5483.6 4963.7 4972.0 4992.3 5012.3 5025.2 5325.1 5331.8 5336.3 5338.6 5359.6 5010.8 5254.6 5255.2 5272.4 5277.0 4955.7 4980.8 4987.4 4988.9 4993.4 3732.4 3767.6 3790.2 3795.2 3800.3 5122.7 5265.0 5313.6 5322.0 5357.8 5089.1 5101.3 5101.5 5153.9 5164.4 5120.8 5149.8 5159.2 5192.7 5194.7 4823.3 4942.8 5070.3 5071.0 5100.1 5053.5 5142.2 5146.9 5169.0 5182.7 5059.3 5060.0 5074.6 5074.6 5079.9 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - PROCESS | 21891 | [#5] yui.html Cycles:180 Average:13465.73 Median:45762.76 stddev:15757.02 (34.4%) stddev-sans-first:15771.83 20:14:34 INFO - PROCESS | 21891 | Values: 649.2 655.2 657.9 697.4 703.5 10909.4 12137.1 12834.2 13027.1 13067.0 12639.5 12668.6 12727.6 12728.4 12752.9 635.6 796.6 808.5 810.2 810.3 648.9 654.7 655.3 783.9 804.3 843.5 847.4 848.5 852.5 853.1 838.4 840.7 840.8 841.0 841.4 490.5 599.3 618.7 619.6 621.4 12558.2 12566.4 12580.6 12598.6 12655.9 11930.5 12349.2 12541.4 12641.6 12678.0 11045.5 11080.2 11239.6 11280.1 11290.6 4029.4 4048.9 4056.7 4073.2 4195.2 43141.4 43461.1 43713.3 43853.8 44102.0 9118.9 9361.2 9939.5 9979.1 10131.6 16999.8 17141.8 17190.7 17205.7 17209.9 6177.8 6312.1 6455.5 6531.4 6594.9 3544.5 3576.4 3641.9 3712.7 3820.8 2824.1 2884.5 2893.0 2896.2 2896.9 553.8 582.6 585.5 593.7 598.8 523.3 561.6 616.4 617.2 633.2 7874.7 7925.1 7957.8 7987.4 8046.2 611.1 613.1 621.0 622.9 633.7 3973.9 4241.2 4241.5 4310.3 4312.7 57695.7 58162.1 58526.7 59591.7 59807.0 51180.7 51365.5 52321.0 52548.7 53194.5 47423.5 47549.5 47768.0 47854.8 48248.3 7923.2 8078.1 8094.5 8110.4 8283.8 31957.4 32355.8 32387.0 33196.0 33221.0 40543.8 42339.4 42753.8 42928.1 43011.6 10951.2 10989.3 11028.7 11283.5 11474.1 12122.7 12284.7 12294.4 12388.0 12621.4 10723.1 11242.3 11285.7 11522.8 11773.2 11160.5 11227.3 11767.2 11787.5 11820.9 10414.8 10555.3 10684.2 10805.1 11061.7 9409.2 9447.0 9534.4 9740.3 9812.0 9136.5 9167.4 9173.4 9186.6 9282.8 20:14:34 INFO - PROCESS | 21891 | -------- Summary: end -------- 20:14:34 INFO - PROCESS | 21891 | 20:14:34 INFO - TEST-INFO | 21891: exit 0 20:14:34 INFO - TEST-OK | dromaeo_css | took 1118956ms 20:14:34 INFO - TEST-START | kraken 20:14:34 INFO - operating with platform_type : linux_ 20:14:34 INFO - Initialising browser for kraken test... 20:14:34 INFO - TEST-INFO | started process 22067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmTAxK/profile http://localhost:49723/getInfo.html) 20:14:39 INFO - PROCESS | 22067 | __metrics Screen width/height:1600/1200 20:14:39 INFO - PROCESS | 22067 | colorDepth:24 20:14:39 INFO - PROCESS | 22067 | Browser inner width/height: 1024/697 20:14:39 INFO - PROCESS | 22067 | __metrics 20:14:40 ERROR - PROCESS | 22067 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:14:40 INFO - TEST-INFO | 22067: exit 0 20:14:40 INFO - Browser initialized. 20:14:40 INFO - Running cycle 1/1 for kraken test... 20:14:40 INFO - TEST-INFO | started process 22148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmTAxK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:52 INFO - PROCESS | 22148 | RSS: Main: 157241344 20:14:52 INFO - PROCESS | 22148 | 20:14:55 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49723/tests/kraken/driver.html?testName=audio-beat-detection) 20:14:56 INFO - PROCESS | 22148 | RSS: Main: 214716416 20:14:56 INFO - PROCESS | 22148 | 20:14:59 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49723/tests/kraken/driver.html?testName=audio-dft) 20:14:59 INFO - PROCESS | 22148 | RSS: Main: 204247040 20:14:59 INFO - PROCESS | 22148 | 20:15:03 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49723/tests/kraken/driver.html?testName=audio-fft) 20:15:03 INFO - PROCESS | 22148 | RSS: Main: 269824000 20:15:03 INFO - PROCESS | 22148 | 20:15:06 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49723/tests/kraken/driver.html?testName=audio-oscillator) 20:15:06 INFO - PROCESS | 22148 | RSS: Main: 180359168 20:15:06 INFO - PROCESS | 22148 | 20:15:08 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:09 INFO - PROCESS | 22148 | RSS: Main: 184045568 20:15:09 INFO - PROCESS | 22148 | 20:15:12 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49723/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:13 INFO - PROCESS | 22148 | RSS: Main: 219844608 20:15:13 INFO - PROCESS | 22148 | 20:15:16 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49723/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:17 INFO - PROCESS | 22148 | RSS: Main: 216121344 20:15:17 INFO - PROCESS | 22148 | 20:15:20 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49723/tests/kraken/driver.html?testName=json-parse-financial) 20:15:20 INFO - PROCESS | 22148 | RSS: Main: 219500544 20:15:20 INFO - PROCESS | 22148 | 20:15:22 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:23 INFO - PROCESS | 22148 | RSS: Main: 206905344 20:15:23 INFO - PROCESS | 22148 | 20:15:24 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:25 INFO - PROCESS | 22148 | RSS: Main: 210046976 20:15:25 INFO - PROCESS | 22148 | 20:15:27 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:15:28 INFO - PROCESS | 22148 | RSS: Main: 217505792 20:15:28 INFO - PROCESS | 22148 | 20:15:31 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:15:31 INFO - PROCESS | 22148 | RSS: Main: 220913664 20:15:31 INFO - PROCESS | 22148 | 20:15:34 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:15:35 INFO - PROCESS | 22148 | RSS: Main: 220925952 20:15:35 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | Cycle 1(1): loaded http://localhost:49723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49723/tests/kraken/driver.html?testName=ai-astar) 20:15:37 INFO - PROCESS | 22148 | RSS: Main: 263331840 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | __start_tp_report 20:15:37 INFO - PROCESS | 22148 | _x_x_mozilla_page_load 20:15:37 INFO - PROCESS | 22148 | _x_x_mozilla_page_load_details 20:15:37 INFO - PROCESS | 22148 | |i|pagename|runs| 20:15:37 INFO - PROCESS | 22148 | |0;ai-astar;114;109;112;111;113;113;112;113;114;114 20:15:37 INFO - PROCESS | 22148 | |1;audio-beat-detection;168;131;132;198;132;134;158;128;170;129 20:15:37 INFO - PROCESS | 22148 | |2;audio-dft;164;159;160;163;166;161;160;163;169;160 20:15:37 INFO - PROCESS | 22148 | |3;audio-fft;75;75;76;104;76;77;77;76;106;76 20:15:37 INFO - PROCESS | 22148 | |4;audio-oscillator;84;85;114;84;84;86;118;84;84;131 20:15:37 INFO - PROCESS | 22148 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;116;117;117 20:15:37 INFO - PROCESS | 22148 | |6;imaging-darkroom;146;147;147;147;146;146;147;148;146;145 20:15:37 INFO - PROCESS | 22148 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;94;94 20:15:37 INFO - PROCESS | 22148 | |8;json-parse-financial;65;65;65;65;64;65;68;64;65;66 20:15:37 INFO - PROCESS | 22148 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;70;64 20:15:37 INFO - PROCESS | 22148 | |10;stanford-crypto-aes;88;86;83;89;83;86;91;91;115;90 20:15:37 INFO - PROCESS | 22148 | |11;stanford-crypto-ccm;131;132;133;130;147;131;134;132;134;132 20:15:37 INFO - PROCESS | 22148 | |12;stanford-crypto-pbkdf2;173;179;170;170;170;175;171;171;168;166 20:15:37 INFO - PROCESS | 22148 | |13;stanford-crypto-sha256-iterative;66;65;67;67;65;66;67;66;78;65 20:15:37 INFO - PROCESS | 22148 | __end_tp_report 20:15:37 INFO - PROCESS | 22148 | __start_cc_report 20:15:37 INFO - PROCESS | 22148 | _x_x_mozilla_cycle_collect,1880 20:15:37 INFO - PROCESS | 22148 | __end_cc_report 20:15:37 INFO - PROCESS | 22148 | __startTimestamp1464318937304__endTimestamp 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | ------- Summary: start ------- 20:15:37 INFO - PROCESS | 22148 | Number of tests: 14 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.58 (1.4%) stddev-sans-first:1.58 20:15:37 INFO - PROCESS | 22148 | Values: 114.0 109.0 112.0 111.0 113.0 113.0 112.0 113.0 114.0 114.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:146.00 stddev:24.13 (16.5%) stddev-sans-first:24.49 20:15:37 INFO - PROCESS | 22148 | Values: 168.0 131.0 132.0 198.0 132.0 134.0 158.0 128.0 170.0 129.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:3.17 (1.9%) stddev-sans-first:3.32 20:15:37 INFO - PROCESS | 22148 | Values: 164.0 159.0 160.0 163.0 166.0 161.0 160.0 163.0 169.0 160.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.25 (16.1%) stddev-sans-first:12.75 20:15:37 INFO - PROCESS | 22148 | Values: 75.0 75.0 76.0 104.0 76.0 77.0 77.0 76.0 106.0 76.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.17 (21.6%) stddev-sans-first:18.79 20:15:37 INFO - PROCESS | 22148 | Values: 84.0 85.0 114.0 84.0 84.0 86.0 118.0 84.0 84.0 131.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:15:37 INFO - PROCESS | 22148 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 20:15:37 INFO - PROCESS | 22148 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 148.0 146.0 145.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:15:37 INFO - PROCESS | 22148 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 20:15:37 INFO - PROCESS | 22148 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 68.0 64.0 65.0 66.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.00 stddev:1.87 (2.9%) stddev-sans-first:1.96 20:15:37 INFO - PROCESS | 22148 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 70.0 64.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:88.50 stddev:9.20 (10.4%) stddev-sans-first:9.72 20:15:37 INFO - PROCESS | 22148 | Values: 88.0 86.0 83.0 89.0 83.0 86.0 91.0 91.0 115.0 90.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.50 stddev:4.88 (3.7%) stddev-sans-first:5.09 20:15:37 INFO - PROCESS | 22148 | Values: 131.0 132.0 133.0 130.0 147.0 131.0 134.0 132.0 134.0 132.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.00 stddev:3.65 (2.1%) stddev-sans-first:3.82 20:15:37 INFO - PROCESS | 22148 | Values: 173.0 179.0 170.0 170.0 170.0 175.0 171.0 171.0 168.0 166.0 20:15:37 INFO - PROCESS | 22148 | 20:15:37 INFO - PROCESS | 22148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.50 stddev:3.88 (5.8%) stddev-sans-first:4.09 20:15:37 INFO - PROCESS | 22148 | Values: 66.0 65.0 67.0 67.0 65.0 66.0 67.0 66.0 78.0 65.0 20:15:37 INFO - PROCESS | 22148 | -------- Summary: end -------- 20:15:37 INFO - PROCESS | 22148 | 20:15:38 INFO - TEST-INFO | 22148: exit 0 20:15:38 INFO - TEST-OK | kraken | took 63417ms 20:15:38 INFO - SUITE-END | took 1182s 20:15:38 INFO - Completed test suite (00:19:42) 20:15:38 INFO - javascript benchmark 20:15:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.812833101683, 2705.9458810823785, 2715.6469658944334, 2725.0189931624623, 2765.0598796409217, 4712.222483290261, 4782.067496838118, 4789.664723469358, 4905.705657660538, 4906.411230652322, 4794.352762377078, 4829.903401931968, 4839.298301746245, 4891.364122664048, 4923.433805112413, 4444.266695995157, 4449.66627502937, 4485.215087359716, 4527.479339875924, 4545.749983750892, 4478.865634030968, 4556.886077848064, 4584.701994370372, 4592.770361481929, 4633.4208223972, 4496.280595104784, 4498.572635599613, 4524.140413321458, 4526.366308716782, 4563.885902852438, 4339.5877391648055, 4369.279068953619, 4443.200223959686, 4487.147441986045, 4514.932276015862, 4402.8679139625865, 4462.843800466968, 4471.374007638933, 4500.34744961982, 4511.526289739563, 4763.54746299101, 4778.737169455679, 4813.133635945528, 4829.227323628203, 4832.5409086137115, 5107.923381149286, 5169.793208271664, 5236.345456817898, 5237.580993520509, 5313.335833020872, 5304.893902121975, 5314.5748340132695, 5317.282166907496, 5336.706481143536, 5364.0612892744, 4769.403824521934, 4925.4335751388335, 4940.258961155855, 4969.900601987976, 4986.326845875797, 5334.146536554133, 5392.514673679388, 5410.458954104558, 5425.891482170335, 5459.262999495097, 5194.636375453758, 5197.376314842168, 5233.607479439057, 5246.31797866275, 5249.973750131225, 5153.994970980622, 5195.584353251731, 5300.04599172145, 5301.920471192935, 5348.9732551337775, 5203.583713302926, 5225.921611175835, 5233.371995360581, 5253.133233016586, 5298.867528311746, 5222.503862133091, 5233.031889100528, 5238.8166414176085, 5241.790328386822, 5291.682499050069, 4435.401220835146, 4462.776861156929, 4502.032063106448, 4526.275795872644, 4535.092981403666, 3821.9426708599394, 3841.2893614680816, 3855.4216867470104, 3865.168988667394, 3926.1362500249897, 4439.445069366329, 4463.241248987615, 4465.0400163964905, 4477.328400739915, 4520.208963431386, 5116.3348764661105, 5148.433672296044, 5156.7421628919155, 5242.868928276747, 5305.734713264398, 4417.359482874966, 4434.179676759745, 4453.955460445354, 4488.169688607552, 4494.9325760113625, 4708.717476951394, 4721.126591580569, 4721.4570324413135, 4748.287756836502, 4766.737829419415, 4787.114383839001, 4871.780769865293, 4889.608831293417, 4890.388701412252, 4906.607471402208, 5249.632525723316, 5303.628745987899, 5334.493223143795, 5338.626296159232, 5353.2505449237915, 4897.755112244445, 4927.211646136601, 4930.8767280818265, 4931.3096166536, 4976.925346119883, 5061.139606267017, 5128.307678463509, 5188.143956247177, 5188.636795424284, 5189.169732842727, 5280.841574752763, 5288.3918349390315, 5290.100682883842, 5291.153415453509, 5338.412774594869, 5037.798488060436, 5066.44269130388, 5067.391912970467, 5081.161608334583, 5121.8719532012, 5010.849674509771, 5061.392632884077, 5066.214736715815, 5108.106081435808, 5164.509371609691, 5085.135526960352, 5098.694078355162, 5116.923246151385, 5142.871428214325, 5156.278121062979, 5172.250023746611, 5189.040027594907, 5192.350956130484, 5223.2948551945, 5242.816501422432, 4951.5048495150195, 5001.4998500149695, 5040.596752259884, 5046.34397528319, 5072.289879416959], "value": 4808.224078391628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1632135475431, 597.107324549798, 608.6348191085349, 610.9877802443948, 611.184069267528, 27616.0, 29913.85043074787, 40184.79907600458, 41201.0, 41204.38193427093, 41931.790341048254, 42541.57458425415, 42562.36156457655, 42573.0, 42633.0, 7871.999999999985, 8046.919530804705, 8078.474899131567, 8081.515109093444, 8093.716719914804, 7863.56750378729, 7968.12350641429, 7990.240927111915, 7992.720254791084, 7994.360451163893, 8021.117677055519, 8067.556284404355, 8068.596570171498, 8071.394645401619, 8071.434999550034, 7954.681812727484, 8040.8391832163325, 8054.637541310596, 8057.5165490070785, 8059.274665280094, 7874.0, 7954.284114429729, 7967.0, 7972.60136993148, 7974.720884769005, 38795.41806872899, 38982.0, 39101.41347879784, 39105.413418798744, 39174.0, 3029.2763616796733, 3072.7234548890483, 3101.0386780098015, 3182.45898197307, 3358.2611825398617, 29626.407471850656, 30001.849990749906, 30455.0, 30504.08487745371, 31682.207944801336, 3291.687289707474, 3392.423288041039, 3432.3478539077496, 3457.291255292659, 3481.3733527964955, 266388.0, 267179.0, 267985.0, 268158.0, 269644.0, 32086.83956580202, 56594.15108773372, 57858.34629017633, 57901.420985789606, 57901.420985789606, 33002.504962425584, 33096.50355244673, 33323.500147497805, 33343.99936003848, 33349.499757503654, 11693.0, 11790.292582445081, 11791.410429478492, 11792.587259445878, 11795.0, 9673.516324183762, 9694.175995040501, 9696.272779541421, 9715.805683886283, 9721.513924303756, 7998.4001199910235, 8007.199280071946, 8010.3191228745045, 8061.758147255592, 8096.392770542233, 3099.395617854497, 3125.281185327342, 3162.6204855417495, 3168.987692815033, 3174.1905814017277, 853.7225401744333, 893.5889490834159, 895.8432274352093, 911.284641556375, 1006.6879267427121, 26208.0, 27505.31236719098, 27734.3066423337, 28637.28406789847, 29136.125916222547, 897.0536084430857, 910.239949642043, 924.5977999570074, 935.3966691483955, 971.7522031881966, 14415.135091894519, 15041.473548425753, 15053.172075535951, 15161.62095947588, 15313.693726125415, 402939.0, 403819.0, 407106.0, 408628.0, 409025.0, 50888.745556271984, 51630.48369516332, 51658.74170629198, 51672.0, 51830.74084629553, 1091.3560999010463, 1177.3348058347005, 1200.0699457920007, 1204.8192771084407, 1226.4726167747954, 28749.85000600036, 29671.703282966893, 30068.849655752456, 30211.546826798054, 30378.240543986576, 43140.352894705975, 43825.34261986137, 43879.0, 43928.0, 43959.78020109879, 296288.0, 298210.0, 298934.0, 299138.0, 299271.0, 25466.879528917903, 26198.0, 26303.4739305209, 26419.735802642495, 26464.470710586065, 43027.139457210054, 43178.568214317456, 43775.78112109419, 44545.77727111344, 44711.0, 36833.81583092068, 37499.43750843685, 37928.43107353447, 38080.052782054234, 38300.233995320494, 36431.635683642824, 37804.24391512099, 37831.81084094562, 40913.0, 40929.795351024244, 36029.15930634646, 37165.62834371622, 37538.81230593829, 37556.248875022895, 37654.62345376621, 31497.527537086502, 33457.33085338328, 34165.65834341724, 34297.142571435914, 34410.655893440744, 24216.63675044911, 24477.632835507124, 24770.0, 24793.256202313958, 24998.750012500368], "value": 16638.26815699949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.2074564160905, 379.8006046825415, 386.8452618952419, 397.1441543473811, 398.1439904205957, 16168.757468637965, 16654.583635409123, 17061.720370972194, 17083.658326833473, 17114.828851711478, 16413.17934103296, 17153.57116072099, 17190.312387504484, 17191.656166876684, 17749.91125044373, 5306.814261500848, 5711.428857114276, 5749.453801888814, 5795.652260864362, 5803.47768700819, 4058.9188216235657, 4123.505179378479, 4160.7087503874745, 6516.250631177428, 7165.964170179142, 7098.254683258261, 7122.287771222862, 7138.607376594286, 7151.177614574312, 7162.820929476753, 6717.798466046026, 6905.620190889499, 7007.509474336798, 7167.605781681979, 7176.246494118094, 3889.397143442771, 6141.907871381933, 6521.608703477807, 6527.314631963671, 6634.772567075107, 19707.704384434244, 19723.605527889504, 22376.55246895053, 23704.762952370602, 23743.525129497313, 1810.5473631592101, 1839.5309196155029, 1875.1749230338744, 1893.0818553001784, 2170.934871953844, 13990.0906441081, 14636.634084147876, 14648.414063437556, 14651.633709157357, 14821.77767333491, 1803.3958623861022, 1871.363736329641, 1894.6968485042464, 1979.6436641404541, 2031.1164643380177, 53413.0, 65815.3418465814, 69106.0, 78878.0, 81178.18821811765, 16533.866533366658, 16563.6687266254, 16602.58493537647, 16812.915935420246, 16819.83180168207, 29666.851665741535, 29817.552736708967, 29899.551506727417, 29929.551056734166, 30028.0, 7959.920400796033, 8363.749087527383, 8437.409381343246, 8531.23218910301, 8556.61495232716, 6754.189497260262, 6804.863902722017, 6873.106496155568, 6910.792676219721, 6911.274316196727, 8528.507511185519, 8688.39181257306, 8703.825923481621, 8721.956390218009, 8790.208881200595, 3211.6627754085953, 3231.8545665445113, 3374.4094783412806, 3453.1194545390763, 3477.23500829817, 778.9649465774054, 800.1198681450358, 814.0191069760924, 836.0552575589545, 847.3052097280171, 15596.92201538985, 15833.0, 15857.0, 16553.917230413772, 16661.750073748663, 885.6103314541581, 903.9593218305192, 940.0693313619604, 946.1390134977275, 962.3263715399248, 9178.632854685738, 9183.908160918305, 9236.491992940319, 9254.629814807333, 9447.291453141042, 326694.0, 338858.0, 356024.0, 367757.0, 367816.0, 52447.0, 75928.62035689787, 77153.61423192848, 78005.21994780093, 78088.0, 874.6239117179547, 877.5683878616097, 901.1709227510706, 911.2072496927583, 911.6763548940163, 10717.732056698645, 12678.683032924251, 14692.779608306098, 15432.92283538575, 15581.0, 35457.29085418329, 35864.462033069, 35948.46077308895, 36228.0, 36228.63771362253, 45062.54937450714, 45203.77398112988, 46024.769876151746, 46408.30387544257, 46501.302480462145, 7188.245234250328, 7209.783706488814, 7474.439417043634, 7499.98750168742, 7563.546187228784, 9899.604015839286, 11534.480948357177, 11549.0, 11570.305746678365, 11614.593489227836, 9198.540072996457, 9215.953920230357, 9393.201577865959, 9419.387739796892, 9453.149216570542, 9595.712128636153, 9694.854577181206, 9756.0, 9810.0, 9959.502024898871, 9263.583138758637, 9458.763530911783, 9507.572159252712, 9618.51907404613, 9862.704118876445, 6953.374196322356, 6967.756128535477, 7156.928430715834, 7208.56748595086, 7315.3781928534545, 7418.777436676908, 9404.0, 9598.472084035166, 9656.259508856541, 9731.756706082404], "value": 8948.710885403156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.0801207106745, 1418.673705047839, 1453.5348688419706, 1548.3496931288857, 1756.0605076284191, 6588.637624930633, 7392.5564466132, 7635.0, 7660.463767536282, 7855.05739311282, 7601.7719468416035, 7635.923640763591, 7681.0, 7690.846183076335, 7702.8844567331535, 2219.05690081715, 2245.854019488736, 2248.7863652953024, 2249.4826189976316, 2251.7410497792716, 2212.4358288636454, 2236.4185311818965, 2240.6639004149347, 2241.069955968271, 2247.2471721973156, 2212.5685491329195, 2216.3018649125556, 2227.0312414099835, 2229.308914236584, 2254.425121593991, 2139.6469582518866, 2156.8813715245656, 2158.935231943044, 2161.8919054047315, 2165.101482884601, 2147.3128598848375, 2148.495103650641, 2151.182550630766, 2151.7955794199684, 2159.5356998245297, 7419.591922444318, 7627.313541781211, 7664.578448185348, 7694.9230507694765, 7699.153093159748, 4677.438707355105, 4843.15244832153, 4849.660523763338, 4858.125537403266, 4859.125357435661, 2909.7090290970946, 3053.328267781085, 3116.111908106179, 3116.548100525411, 3122.5160100184507, 958.5590628310986, 968.3463662028103, 974.1184228273424, 1012.4026824173699, 1025.0108645157459, 10477.790444191074, 10597.311174773693, 10602.098821600173, 10612.522436490299, 10618.991195836461, 4243.108947121139, 4368.584984426474, 4519.977400112978, 4529.54704529551, 4603.0, 8027.598620068973, 8105.27052565272, 8129.390295727844, 8156.0, 8167.754967350989, 4615.330777037311, 4615.538446155425, 4616.3537104805355, 4620.514845941195, 4636.629069674418, 3677.5403074615674, 3730.9813450933116, 4321.373400856858, 4322.78386080701, 4354.085642015212, 3492.4935884296633, 3495.49315349278, 3545.18460754028, 3587.264610754789, 3619.746617736786, 1030.30454443252, 1036.7304500829687, 1037.2894567221476, 1047.1413440978324, 1057.6668349469892, 706.9328413800681, 833.1793183714037, 840.6091167607092, 843.2705709561308, 879.6437442835662, 5206.661566998208, 5407.675539467645, 5447.455254474521, 5447.6731396115565, 5517.282753242052, 869.387082107113, 883.430187529053, 889.8131392407538, 903.2864037410503, 935.8409070458039, 3607.7113830893463, 3689.3543629864666, 3738.140227747633, 3752.380857158593, 3774.7168962327937, 9259.166674999147, 9497.192738617296, 9512.28657850664, 9657.082577155159, 9669.033096690275, 9546.140847323773, 9548.0, 9555.426674399558, 9580.856287155699, 9613.0, 7265.309795569412, 7278.854422911512, 7387.519811212254, 7428.071491063617, 7442.255774422622, 5206.271122042993, 5234.790608375774, 5235.0, 5264.605154613343, 5334.1732031535175, 8957.059508751487, 9042.50266235337, 9042.593083311398, 9066.410683305565, 9076.0, 8827.117288271378, 9050.683226087318, 9169.954150229472, 9187.770305742142, 9195.310351723781, 5767.307923049261, 5843.386444423274, 6336.461400780985, 6392.488600912009, 6525.673716314071, 7512.0, 7541.472096953161, 7577.16651168382, 7595.08858936909, 7620.161782203842, 6802.93197068023, 6844.520883538304, 6873.896891546731, 6920.30796920304, 7156.534825236343, 6872.347127022925, 6907.965460172667, 6931.0, 6978.651067446709, 7017.2631873652535, 6391.96804015977, 6399.168108145911, 6465.579737317059, 6484.773032943825, 6523.054157147282, 4557.749323787223, 4690.906181876411, 4693.108309421199, 4738.028704115579, 4764.213904705684, 4665.836695715634, 4676.906461870675, 4700.412448443944, 4756.239001759702, 4774.427068751772], "value": 4150.064861260804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1641077296685, 310.59932686833986, 315.55664291670206, 316.0723277181473, 316.13064073797057, 4896.510348965102, 4898.559129678329, 4910.2634604809255, 4935.161022626153, 4937.925931111032, 4830.686005409646, 4847.830325938593, 4867.610591152708, 4881.4630390657, 4903.215485522317, 3632.3483856784496, 3698.6486283802997, 3708.128589781399, 3765.7363984521094, 3853.1715681128553, 3771.0, 3800.1069748609057, 3805.5243094613174, 3825.598312177223, 3831.731778775487, 3641.1625326174994, 3754.2866855297407, 3798.7274263121885, 3800.9619903800885, 3802.372608519605, 3681.4293784463453, 3818.3127037133304, 3824.7131465140224, 3842.0, 3843.2889915365745, 3387.5257463955068, 3392.0671815251003, 3398.3713013092656, 3410.5225268462436, 3411.624721280657, 4660.906781864378, 4675.298705194214, 4675.901163226639, 4685.8594242172785, 4704.223803072489, 4277.572242775728, 4385.539518350591, 4387.429634147572, 4397.1865204937185, 4406.700023493077, 5094.847154585368, 5125.79543807205, 5129.410117836459, 5136.280920671109, 5152.201408781645, 3699.315626609059, 3717.9814100929593, 3718.2935242303874, 3718.3864662330684, 3739.607341229186, 5107.565856902168, 5339.599530035263, 5351.491608297206, 5356.491133342326, 5357.4106848246665, 3753.0242137044565, 3774.6036666149657, 3777.490038844721, 3788.8484460621266, 3797.784708893183, 3833.6358045985585, 3849.2493963677375, 3865.1883104547796, 3870.5355357356734, 3873.3802591585213, 4395.428594282723, 4397.978010109929, 4401.119776044804, 4414.404055452473, 4429.247028005247, 4873.610111191097, 5102.923456148161, 5129.794808207705, 5138.3577052868395, 5140.820071297487, 1257.937103144839, 1286.1575667937516, 1292.9224246545236, 1301.271288078679, 1306.196689036236, 804.284187073505, 820.4912953968578, 848.245061894914, 867.3018220332567, 872.5680788009976, 4483.865484035419, 4498.100379924028, 4498.932516012263, 4501.122281155209, 4511.909761804745, 5232.816851410258, 5232.9738351308, 5245.344331958505, 5279.709615971158, 5285.757846905974, 4314.288142456522, 4399.186150562156, 4410.294352903584, 4470.128324976598, 4602.309653551927, 2811.9015834445695, 2812.54999200127, 2814.690384057752, 2839.872205750746, 2843.3744576193203, 4983.327250821165, 4983.775730092155, 4988.702937236272, 4990.72551009698, 4999.47505511916, 5033.7734801934, 5412.512873841373, 5433.701146436984, 5443.265159203536, 5483.616146869761, 4963.652544322007, 4972.0, 4992.301077849177, 5012.298278241049, 5025.246213067996, 5325.147976323769, 5331.813386531608, 5336.306280183707, 5338.626296159387, 5359.571234301325, 5010.799568017239, 5254.632175747661, 5255.237990491434, 5272.420033796203, 5276.997370499593, 4955.702657840541, 4980.800767969241, 4987.376577927759, 4988.852563910248, 4993.425756038102, 3732.384156614128, 3767.6420740029653, 3790.2040571479197, 3795.1650636859845, 3800.277947190025, 5122.743862806919, 5264.9736751315995, 5313.601479889101, 5321.951048846299, 5357.8300788179295, 5089.05852417304, 5101.260317253903, 5101.540861322499, 5153.922691159561, 5164.354455693038, 5120.846374608767, 5149.845504634867, 5159.2003239497935, 5192.701824543864, 5194.68831870089, 4823.252395878504, 4942.75286235694, 5070.340855688737, 5070.960453107031, 5100.132977393926, 5053.545180933734, 5142.228665700175, 5146.8970620588125, 5169.009931176449, 5182.663126896739, 5059.316992206005, 5059.974700126476, 5074.619403544675, 5074.6194035448225, 5079.87300317495], "value": 3869.8852221489237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.164015500649, 655.197383205573, 657.8651376467825, 697.3897839390534, 703.4829400390715, 10909.399983000932, 12137.089718271132, 12834.229946203222, 13027.088103832735, 13066.95464362851, 12639.494420223204, 12668.61994140175, 12727.618171454847, 12728.427220775064, 12752.936235318833, 635.6154526511464, 796.5539297993114, 808.4744915804745, 810.2059981218409, 810.2990912860392, 648.8540078482351, 654.7446495866616, 655.3021032600266, 783.8863364812099, 804.2962407893093, 843.4812590256978, 847.3560094328324, 848.516345682961, 852.497026754218, 853.0744142605281, 838.3502785341378, 840.684743221292, 840.7982084299786, 840.9621567029499, 841.4362377207286, 490.5045903637316, 599.2988203801519, 618.653554009756, 619.5601123202532, 621.3786213786213, 12558.183718058297, 12566.371681415892, 12580.559680411234, 12598.55905043319, 12655.93672031634, 11930.463129159121, 12349.19730217533, 12541.435635396429, 12641.557545485955, 12678.039912902772, 11045.502952367162, 11080.168987325902, 11239.550417983271, 11280.097592192606, 11290.604828830952, 4029.3553031514816, 4048.8582899598373, 4056.7363121397016, 4073.185362927397, 4195.202911446815, 43141.35287970683, 43461.13077738459, 43713.34429983553, 43853.780731096456, 44102.0, 9118.908810911938, 9361.157495825408, 9939.453330066915, 9979.101880830614, 10131.64539241123, 16999.830001700073, 17141.828581714024, 17190.656186876193, 17205.7419138713, 17209.91395043042, 6177.7837775677635, 6312.116303717483, 6455.548111632234, 6531.412172904462, 6594.934050659528, 3544.503769472276, 3576.3562558739154, 3641.9453708194396, 3712.6658600726064, 3820.7707537547835, 2824.1386377154754, 2884.4663737208684, 2893.030834670409, 2896.20354402541, 2896.8986085487327, 553.7867920850501, 582.5747204540625, 585.5374254339024, 593.7387549478216, 598.7814447726548, 523.2831021500492, 561.5535649158928, 616.3774587666489, 617.2438762515882, 633.2179757998867, 7874.72438464651, 7925.088614809255, 7957.7612671619945, 7987.400944929037, 8046.195380462024, 611.0711718188329, 613.1324176290589, 620.9844753881099, 622.9065640154013, 633.6958260035209, 3973.8609148679657, 4241.1941731071, 4241.491021077491, 4310.288802347577, 4312.654987600984, 57695.711521442965, 58162.127568086515, 58526.70736646289, 59591.702041489516, 59807.0, 51180.74409627928, 51365.48634513607, 52321.0, 52548.73725631424, 53194.468055319725, 47423.52576474191, 47549.5245047552, 47768.0, 47854.760726196146, 48248.27627585589, 7923.20767923203, 8078.111407745261, 8094.51432914027, 8110.432269741062, 8283.83432331362, 31957.36085278235, 32355.838220808746, 32387.0, 33196.0, 33221.0, 40543.79728101341, 42339.364909527, 42753.78623106865, 42928.141437171704, 43011.569884300756, 10951.178661600572, 10989.285696429706, 11028.669139925814, 11283.492242849255, 11474.082073434272, 12122.696932576757, 12284.692882677648, 12294.446749896097, 12388.0, 12621.368931553568, 10723.088537474401, 11242.269252498561, 11285.71785705364, 11522.769544608893, 11773.234739741889, 11160.497777599865, 11227.27022743519, 11767.176297659082, 11787.528498860293, 11820.940895295469, 10414.843777343194, 10555.261131720707, 10684.198685098494, 10805.135589152691, 11061.668149955514, 9409.153176214173, 9446.95276523613, 9534.380265282734, 9740.344141495822, 9812.0, 9136.543172841464, 9167.358284919992, 9173.40372875761, 9186.632534698805, 9282.767930801783], "value": 6085.6723932925415, "unit": "score"}], "name": "dromaeo_css", "value": 6419.388822779732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 112.0, 111.0, 113.0, 113.0, 112.0, 113.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 131.0, 132.0, 198.0, 132.0, 134.0, 158.0, 128.0, 170.0, 129.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 160.0, 163.0, 166.0, 161.0, 160.0, 163.0, 169.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 104.0, 76.0, 77.0, 77.0, 76.0, 106.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 84.0, 84.0, 86.0, 118.0, 84.0, 84.0, 131.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 68.0, 64.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 70.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 83.0, 89.0, 83.0, 86.0, 91.0, 91.0, 115.0, 90.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 133.0, 130.0, 147.0, 131.0, 134.0, 132.0, 134.0, 132.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 179.0, 170.0, 170.0, 170.0, 175.0, 171.0, 171.0, 168.0, 166.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 78.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1550.6000000000001, "alertThreshold": 2.0}]} 20:15:38 INFO - Return code: 0 20:15:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:15:38 ERROR - # TBPL SUCCESS # 20:15:38 INFO - Running post-action listener: _resource_record_post_action 20:15:38 INFO - ##### 20:15:38 INFO - ##### Finished run-tests step (success) 20:15:38 INFO - ##### 20:15:38 INFO - Running post-run listener: _resource_record_post_run 20:15:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522289152; Read time: 12; Write time: 442008 20:15:38 INFO - TinderboxPrint: CPU usage
13.1% 20:15:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:15:38 INFO - TinderboxPrint: I/O write bytes / time
522,289,152 / 442,008 20:15:38 INFO - TinderboxPrint: CPU idle
8,318.9 (86.9%) 20:15:38 INFO - TinderboxPrint: CPU user
1,208.7 (12.6%) 20:15:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:15:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 213233664; Read time: 0; Write time: 230824 20:15:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283889664; Read time: 12; Write time: 206312 20:15:39 INFO - Running post-run listener: _upload_blobber_files 20:15:39 INFO - Blob upload gear active. 20:15:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:15:39 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 20:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:15:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:15:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:44 INFO - (blobuploader) - INFO - Done attempting. 20:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:45 INFO - (blobuploader) - INFO - Done attempting. 20:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:15:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:46 INFO - (blobuploader) - INFO - Done attempting. 20:15:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:15:46 INFO - Return code: 0 20:15:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:15:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:15:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4933299627ca43ac9e25508d184e89e44cdec33b1ffe4068465f27014d6495def69358a9df3d7772b8f31e87a0414db3985ed5398bc7a529ebf73595ddead72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b9ab788a161a0d204455f15951b938b49e9084f4a3ab93fce9baa0f9bedd1d2e51e0edead76f68da0efb23174d35bb8b802edf5b39465f9cd6e2e1ce1dec7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/054d5d76fe8547190e4bc9ef3946238e376ab09bd963024bf979dfaf5d802e90f0ea9ce422d4f001b616df6208e676518d1d6224bd442465b753bcf1d782bc6c"} 20:15:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:15:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:15:46 INFO - Contents: 20:15:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4933299627ca43ac9e25508d184e89e44cdec33b1ffe4068465f27014d6495def69358a9df3d7772b8f31e87a0414db3985ed5398bc7a529ebf73595ddead72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b9ab788a161a0d204455f15951b938b49e9084f4a3ab93fce9baa0f9bedd1d2e51e0edead76f68da0efb23174d35bb8b802edf5b39465f9cd6e2e1ce1dec7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/054d5d76fe8547190e4bc9ef3946238e376ab09bd963024bf979dfaf5d802e90f0ea9ce422d4f001b616df6208e676518d1d6224bd442465b753bcf1d782bc6c"} 20:15:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:15:46 INFO - Copying logs to upload dir... 20:15:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:15:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.109917 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-26 20:15:46.029641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:15:46.033118) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4933299627ca43ac9e25508d184e89e44cdec33b1ffe4068465f27014d6495def69358a9df3d7772b8f31e87a0414db3985ed5398bc7a529ebf73595ddead72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b9ab788a161a0d204455f15951b938b49e9084f4a3ab93fce9baa0f9bedd1d2e51e0edead76f68da0efb23174d35bb8b802edf5b39465f9cd6e2e1ce1dec7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/054d5d76fe8547190e4bc9ef3946238e376ab09bd963024bf979dfaf5d802e90f0ea9ce422d4f001b616df6208e676518d1d6224bd442465b753bcf1d782bc6c"} build_url:https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/V4_Uwl-zSdeVp7hMeWMLbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4933299627ca43ac9e25508d184e89e44cdec33b1ffe4068465f27014d6495def69358a9df3d7772b8f31e87a0414db3985ed5398bc7a529ebf73595ddead72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53b9ab788a161a0d204455f15951b938b49e9084f4a3ab93fce9baa0f9bedd1d2e51e0edead76f68da0efb23174d35bb8b802edf5b39465f9cd6e2e1ce1dec7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/054d5d76fe8547190e4bc9ef3946238e376ab09bd963024bf979dfaf5d802e90f0ea9ce422d4f001b616df6208e676518d1d6224bd442465b753bcf1d782bc6c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 20:15:46.057938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:15:46.058257) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464315729.317197-464492683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:15:46.143508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:15:46.143828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 20:15:46.144110) ========= ========= Total master_lag: 0.20 =========