builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1470279996.11 results: success (0) buildid: 20160803185123 builduid: 7f324aac59984ae5b11bb7aec6601021 revision: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.106583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.107165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.107502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.123143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.123664) ========= 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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 20:06:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-08-03 20:06:36 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115482 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.302010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.302426) ========= 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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017918 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.333501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:36.333920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1576e7bc1bec7232e9e4ba78cce62526b1a6380b --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 1576e7bc1bec7232e9e4ba78cce62526b1a6380b --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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 20:06:36,726 truncating revision to first 12 chars 2016-08-03 20:06:36,726 Setting DEBUG logging. 2016-08-03 20:06:36,726 attempt 1/10 2016-08-03 20:06:36,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1576e7bc1bec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 20:06:37,082 unpacking tar archive at: mozilla-central-1576e7bc1bec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678570 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:37.070130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:37.070494) ========= script_repo_revision: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:37.070951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:37.071257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 20:06:37.081241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 20:06:37.081877) ========= /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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:37 INFO - MultiFileLogger online at 20160803 20:06:37 in /builds/slave/test 20:06:37 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 20:06:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:37 INFO - {'append_to_log': False, 20:06:37 INFO - 'base_work_dir': '/builds/slave/test', 20:06:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:06:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:37 INFO - 'branch': 'Firefox-Non-PGO', 20:06:37 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:37 INFO - 'config_files': ('talos/linux_config.py',), 20:06:37 INFO - 'default_actions': ('clobber', 20:06:37 INFO - 'read-buildbot-config', 20:06:37 INFO - 'download-and-extract', 20:06:37 INFO - 'populate-webroot', 20:06:37 INFO - 'create-virtualenv', 20:06:37 INFO - 'install', 20:06:37 INFO - 'run-tests'), 20:06:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:37 INFO - 'download_minidump_stackwalk': True, 20:06:37 INFO - 'download_symbols': 'ondemand', 20:06:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:37 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:37 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:37 INFO - 'installer_path': 'installer.exe', 20:06:37 INFO - 'log_level': 'info', 20:06:37 INFO - 'log_name': 'talos', 20:06:37 INFO - 'log_to_console': True, 20:06:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:37 INFO - 'opt_config_files': (), 20:06:37 INFO - 'pip_index': False, 20:06:37 INFO - 'sps_profile': False, 20:06:37 INFO - 'sps_profile_interval': 0, 20:06:37 INFO - 'suite': 'dromaeojs', 20:06:37 INFO - 'system_bits': '32', 20:06:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:37 INFO - 'title': 'talos-linux64-ix-065', 20:06:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:37 INFO - 'use_talos_json': True, 20:06:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:37 INFO - 'work_dir': 'build'} 20:06:37 INFO - [mozharness: 2016-08-04 03:06:37.529818Z] Running clobber step. 20:06:37 INFO - Running pre-action listener: _resource_record_pre_action 20:06:37 INFO - Running main action method: clobber 20:06:37 INFO - rmtree: /builds/slave/test/build 20:06:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:37 INFO - Running post-action listener: _resource_record_post_action 20:06:37 INFO - [mozharness: 2016-08-04 03:06:37.987711Z] Finished clobber step (success) 20:06:37 INFO - [mozharness: 2016-08-04 03:06:37.987812Z] Running read-buildbot-config step. 20:06:37 INFO - Running pre-action listener: _resource_record_pre_action 20:06:37 INFO - Running main action method: read_buildbot_config 20:06:37 INFO - Using buildbot properties: 20:06:37 INFO - { 20:06:37 INFO - "project": "", 20:06:37 INFO - "product": "firefox", 20:06:37 INFO - "script_repo_revision": "production", 20:06:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:06:37 INFO - "repository": "", 20:06:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:06:37 INFO - "buildid": "20160803185123", 20:06:37 INFO - "pgo_build": "False", 20:06:37 INFO - "basedir": "/builds/slave/test", 20:06:37 INFO - "buildnumber": 582, 20:06:37 INFO - "slavename": "talos-linux64-ix-065", 20:06:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:06:37 INFO - "platform": "ubuntu64_hw", 20:06:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:06:37 INFO - "branch": "mozilla-central", 20:06:37 INFO - "repo_path": "mozilla-central", 20:06:37 INFO - "revision": "1576e7bc1bec7232e9e4ba78cce62526b1a6380b", 20:06:37 INFO - "stage_platform": "linux64", 20:06:37 INFO - "builduid": "7f324aac59984ae5b11bb7aec6601021", 20:06:37 INFO - "slavebuilddir": "test" 20:06:37 INFO - } 20:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:06:37 INFO - Running post-action listener: _resource_record_post_action 20:06:37 INFO - [mozharness: 2016-08-04 03:06:37.990331Z] Finished read-buildbot-config step (success) 20:06:37 INFO - [mozharness: 2016-08-04 03:06:37.990420Z] Running download-and-extract step. 20:06:37 INFO - Running pre-action listener: _resource_record_pre_action 20:06:37 INFO - Running main action method: download_and_extract 20:06:37 INFO - mkdir: /builds/slave/test/build/tests 20:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:37 INFO - https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:06:38 INFO - Downloaded 1361 bytes. 20:06:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:38 INFO - Using the following test package requirements: 20:06:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'jsshell-linux-x86_64.zip'], 20:06:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:38 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')]} 20:06:38 INFO - https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:39 INFO - Downloaded 20241121 bytes. 20:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:06:40 INFO - Return code: 0 20:06:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:40 INFO - https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:42 INFO - Downloaded 20241121 bytes. 20:06:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:06:43 INFO - Return code: 0 20:06:43 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')]} 20:06:43 INFO - https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:06:44 INFO - Downloaded 14413723 bytes. 20:06:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:06:44 INFO - Return code: 0 20:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:44 INFO - https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:06:45 INFO - Downloaded 55581606 bytes. 20:06:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:45 INFO - mkdir: /builds/slave/test/properties 20:06:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:45 INFO - Contents: 20:06:45 INFO - build_url:https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:46 INFO - Running post-action listener: _resource_record_post_action 20:06:46 INFO - Running post-action listener: set_extra_try_arguments 20:06:46 INFO - [mozharness: 2016-08-04 03:06:46.570346Z] Finished download-and-extract step (success) 20:06:46 INFO - [mozharness: 2016-08-04 03:06:46.570577Z] Running populate-webroot step. 20:06:46 INFO - Running pre-action listener: _resource_record_pre_action 20:06:46 INFO - Running main action method: populate_webroot 20:06:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:46 INFO - '--tppagecycles', 20:06:46 INFO - '7'], 20:06:46 INFO - 'tests': ['tsvgm']}}, 20:06:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['damp', 'tps']}, 20:06:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'tests': ['damp', 'tps']}, 20:06:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['dromaeo_dom']}, 20:06:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['basic_compositor_video']}, 20:06:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['a11yr', 20:06:46 INFO - 'ts_paint', 20:06:46 INFO - 'tpaint', 20:06:46 INFO - 'sessionrestore', 20:06:46 INFO - 'sessionrestore_no_auto_restore', 20:06:46 INFO - 'tabpaint']}, 20:06:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['tsvgx', 20:06:46 INFO - 'tsvgr_opacity', 20:06:46 INFO - 'tart', 20:06:46 INFO - 'tscrollx', 20:06:46 INFO - 'cart']}, 20:06:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:46 INFO - 'tsvgr_opacity', 20:06:46 INFO - 'tart', 20:06:46 INFO - 'tscrollx', 20:06:46 INFO - 'cart']}, 20:06:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'talos_options': ['--disable-e10s'], 20:06:46 INFO - 'tests': ['tp5o']}, 20:06:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'tests': ['tp5o']}, 20:06:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'talos_options': ['--disable-e10s', 20:06:46 INFO - '--xperf_path', 20:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:46 INFO - 'tests': ['tp5n']}, 20:06:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:46 INFO - 'talos_options': ['--xperf_path', 20:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:46 INFO - 'tests': ['tp5n']}}, 20:06:46 INFO - 'talos.zip': {'path': '', 20:06:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:46 INFO - Running post-action listener: _resource_record_post_action 20:06:46 INFO - [mozharness: 2016-08-04 03:06:46.595952Z] Finished populate-webroot step (success) 20:06:46 INFO - [mozharness: 2016-08-04 03:06:46.596041Z] Running create-virtualenv step. 20:06:46 INFO - Running pre-action listener: _resource_record_pre_action 20:06:46 INFO - Running main action method: create_virtualenv 20:06:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:46 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 20:06:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:46 INFO - Using real prefix '/usr' 20:06:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:49 INFO - Installing pip.................done. 20:06:49 INFO - Return code: 0 20:06:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:49 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')]} 20:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:49 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')]} 20:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:49 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:49 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 20:06:49 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 20:06:49 INFO - Using env: {'DISPLAY': ':0', 20:06:49 INFO - 'HOME': '/home/cltbld', 20:06:49 INFO - 'LANG': 'en_US.UTF-8', 20:06:49 INFO - 'LANGUAGE': 'en_US:en', 20:06:49 INFO - 'LOGNAME': 'cltbld', 20:06:49 INFO - 'MAIL': '/var/mail/cltbld', 20:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:49 INFO - 'MOZ_NO_REMOTE': '1', 20:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:49 INFO - 'NO_EM_RESTART': '1', 20:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:49 INFO - 'PWD': '/builds/slave/test', 20:06:49 INFO - 'SHELL': '/bin/bash', 20:06:49 INFO - 'SHLVL': '1', 20:06:49 INFO - 'TERM': 'linux', 20:06:49 INFO - 'TMOUT': '86400', 20:06:49 INFO - 'USER': 'cltbld', 20:06:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:49 INFO - '_': '/tools/buildbot/bin/python'} 20:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:49 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 20:06:49 INFO - Cleaning up... 20:06:49 INFO - Return code: 0 20:06:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:49 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')]} 20:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:49 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')]} 20:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:49 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:49 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 20:06:49 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 20:06:49 INFO - Using env: {'DISPLAY': ':0', 20:06:49 INFO - 'HOME': '/home/cltbld', 20:06:49 INFO - 'LANG': 'en_US.UTF-8', 20:06:49 INFO - 'LANGUAGE': 'en_US:en', 20:06:49 INFO - 'LOGNAME': 'cltbld', 20:06:49 INFO - 'MAIL': '/var/mail/cltbld', 20:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:49 INFO - 'MOZ_NO_REMOTE': '1', 20:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:49 INFO - 'NO_EM_RESTART': '1', 20:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:49 INFO - 'PWD': '/builds/slave/test', 20:06:49 INFO - 'SHELL': '/bin/bash', 20:06:49 INFO - 'SHLVL': '1', 20:06:49 INFO - 'TERM': 'linux', 20:06:49 INFO - 'TMOUT': '86400', 20:06:49 INFO - 'USER': 'cltbld', 20:06:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:49 INFO - '_': '/tools/buildbot/bin/python'} 20:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:49 INFO - Downloading/unpacking psutil>=3.1.1 20:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:51 INFO - Installing collected packages: psutil 20:06:51 INFO - Running setup.py install for psutil 20:06:51 INFO - building 'psutil._psutil_linux' extension 20:06:51 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 20:06:51 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 20:06:51 INFO - building 'psutil._psutil_posix' extension 20:06:51 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 20:06:52 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 20:06:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:52 INFO - Successfully installed psutil 20:06:52 INFO - Cleaning up... 20:06:52 INFO - Return code: 0 20:06:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:52 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:52 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 20:06:52 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 20:06:52 INFO - Using env: {'DISPLAY': ':0', 20:06:52 INFO - 'HOME': '/home/cltbld', 20:06:52 INFO - 'LANG': 'en_US.UTF-8', 20:06:52 INFO - 'LANGUAGE': 'en_US:en', 20:06:52 INFO - 'LOGNAME': 'cltbld', 20:06:52 INFO - 'MAIL': '/var/mail/cltbld', 20:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:52 INFO - 'MOZ_NO_REMOTE': '1', 20:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:52 INFO - 'NO_EM_RESTART': '1', 20:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:52 INFO - 'PWD': '/builds/slave/test', 20:06:52 INFO - 'SHELL': '/bin/bash', 20:06:52 INFO - 'SHLVL': '1', 20:06:52 INFO - 'TERM': 'linux', 20:06:52 INFO - 'TMOUT': '86400', 20:06:52 INFO - 'USER': 'cltbld', 20:06:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:52 INFO - '_': '/tools/buildbot/bin/python'} 20:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:54 INFO - Installing collected packages: mozsystemmonitor 20:06:54 INFO - Running setup.py install for mozsystemmonitor 20:06:54 INFO - Successfully installed mozsystemmonitor 20:06:54 INFO - Cleaning up... 20:06:54 INFO - Return code: 0 20:06:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:54 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==2.5.1'] in /builds/slave/test/build 20:06:54 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==2.5.1 20:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:54 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:56 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:56 INFO - warning: no files found matching '*.txt' 20:06:56 INFO - no previously-included directories found matching 'build' 20:06:56 INFO - no previously-included directories found matching 'dist' 20:06:56 INFO - no previously-included directories found matching '.git*' 20:06:56 INFO - Installing collected packages: jsonschema, functools32 20:06:56 INFO - Running setup.py install for functools32 20:06:57 INFO - warning: no files found matching '*.txt' 20:06:57 INFO - no previously-included directories found matching 'build' 20:06:57 INFO - no previously-included directories found matching 'dist' 20:06:57 INFO - no previously-included directories found matching '.git*' 20:06:57 INFO - Successfully installed jsonschema functools32 20:06:57 INFO - Cleaning up... 20:06:57 INFO - Return code: 0 20:06:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:57 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')]} 20:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 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')]} 20:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:57 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:06:57 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 functools32==3.2.3-2 20:06:57 INFO - Using env: {'DISPLAY': ':0', 20:06:57 INFO - 'HOME': '/home/cltbld', 20:06:57 INFO - 'LANG': 'en_US.UTF-8', 20:06:57 INFO - 'LANGUAGE': 'en_US:en', 20:06:57 INFO - 'LOGNAME': 'cltbld', 20:06:57 INFO - 'MAIL': '/var/mail/cltbld', 20:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:57 INFO - 'MOZ_NO_REMOTE': '1', 20:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:57 INFO - 'NO_EM_RESTART': '1', 20:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:57 INFO - 'PWD': '/builds/slave/test', 20:06:57 INFO - 'SHELL': '/bin/bash', 20:06:57 INFO - 'SHLVL': '1', 20:06:57 INFO - 'TERM': 'linux', 20:06:57 INFO - 'TMOUT': '86400', 20:06:57 INFO - 'USER': 'cltbld', 20:06:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:57 INFO - '_': '/tools/buildbot/bin/python'} 20:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:57 INFO - Cleaning up... 20:06:57 INFO - Return code: 0 20:06:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:57 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')]} 20:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 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')]} 20:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:06:57 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 20:06:57 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 20:06:57 INFO - Using env: {'DISPLAY': ':0', 20:06:57 INFO - 'HOME': '/home/cltbld', 20:06:57 INFO - 'LANG': 'en_US.UTF-8', 20:06:57 INFO - 'LANGUAGE': 'en_US:en', 20:06:57 INFO - 'LOGNAME': 'cltbld', 20:06:57 INFO - 'MAIL': '/var/mail/cltbld', 20:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:57 INFO - 'MOZ_NO_REMOTE': '1', 20:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:57 INFO - 'NO_EM_RESTART': '1', 20:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:57 INFO - 'PWD': '/builds/slave/test', 20:06:57 INFO - 'SHELL': '/bin/bash', 20:06:57 INFO - 'SHLVL': '1', 20:06:57 INFO - 'TERM': 'linux', 20:06:57 INFO - 'TMOUT': '86400', 20:06:57 INFO - 'USER': 'cltbld', 20:06:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:57 INFO - '_': '/tools/buildbot/bin/python'} 20:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:57 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:59 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:06:59 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 20:07:00 INFO - Downloading docopt-0.6.1.tar.gz 20:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:00 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:00 INFO - Running setup.py install for blobuploader 20:07:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:00 INFO - Running setup.py install for requests 20:07:00 INFO - Running setup.py install for docopt 20:07:00 INFO - Successfully installed blobuploader requests docopt 20:07:00 INFO - Cleaning up... 20:07:00 INFO - Return code: 0 20:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:00 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:07:00 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 20:07:00 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 20:07:00 INFO - Using env: {'DISPLAY': ':0', 20:07:00 INFO - 'HOME': '/home/cltbld', 20:07:00 INFO - 'LANG': 'en_US.UTF-8', 20:07:00 INFO - 'LANGUAGE': 'en_US:en', 20:07:00 INFO - 'LOGNAME': 'cltbld', 20:07:00 INFO - 'MAIL': '/var/mail/cltbld', 20:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:00 INFO - 'MOZ_NO_REMOTE': '1', 20:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:00 INFO - 'NO_EM_RESTART': '1', 20:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:00 INFO - 'PWD': '/builds/slave/test', 20:07:00 INFO - 'SHELL': '/bin/bash', 20:07:00 INFO - 'SHLVL': '1', 20:07:00 INFO - 'TERM': 'linux', 20:07:00 INFO - 'TMOUT': '86400', 20:07:00 INFO - 'USER': 'cltbld', 20:07:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:00 INFO - '_': '/tools/buildbot/bin/python'} 20:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:01 INFO - Running setup.py (path:/tmp/pip-K52KxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:01 INFO - Running setup.py (path:/tmp/pip-MiBFur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:01 INFO - Running setup.py (path:/tmp/pip-d4enLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:01 INFO - Running setup.py (path:/tmp/pip-gIu1nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:01 INFO - Running setup.py (path:/tmp/pip-8_3oZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:01 INFO - Running setup.py (path:/tmp/pip-2NjSX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:01 INFO - Running setup.py (path:/tmp/pip-5owbMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:01 INFO - Running setup.py (path:/tmp/pip-q2uqCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:01 INFO - Running setup.py (path:/tmp/pip-CjXLfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:01 INFO - Running setup.py (path:/tmp/pip-p4a2nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:01 INFO - Running setup.py (path:/tmp/pip-ZdL6Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:01 INFO - Running setup.py (path:/tmp/pip-1XpykZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:01 INFO - Running setup.py (path:/tmp/pip-o_bK6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:02 INFO - Running setup.py (path:/tmp/pip-zlEZQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:02 INFO - Running setup.py (path:/tmp/pip-M2YaeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:02 INFO - Running setup.py (path:/tmp/pip-hVCgLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:02 INFO - Running setup.py (path:/tmp/pip-siXK6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:02 INFO - Running setup.py install for manifestparser 20:07:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:02 INFO - Running setup.py install for mozcrash 20:07:02 INFO - Running setup.py install for mozdebug 20:07:02 INFO - Running setup.py install for mozdevice 20:07:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:02 INFO - Running setup.py install for mozfile 20:07:02 INFO - Running setup.py install for mozhttpd 20:07:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:02 INFO - Running setup.py install for mozinfo 20:07:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for mozInstall 20:07:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for mozleak 20:07:03 INFO - Running setup.py install for mozlog 20:07:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for moznetwork 20:07:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for mozprocess 20:07:03 INFO - Running setup.py install for mozprofile 20:07:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for mozrunner 20:07:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:03 INFO - Running setup.py install for mozscreenshot 20:07:03 INFO - Running setup.py install for moztest 20:07:04 INFO - Running setup.py install for mozversion 20:07:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:04 INFO - Cleaning up... 20:07:04 INFO - Return code: 0 20:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:07:04 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 20:07:04 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 20:07:04 INFO - Using env: {'DISPLAY': ':0', 20:07:04 INFO - 'HOME': '/home/cltbld', 20:07:04 INFO - 'LANG': 'en_US.UTF-8', 20:07:04 INFO - 'LANGUAGE': 'en_US:en', 20:07:04 INFO - 'LOGNAME': 'cltbld', 20:07:04 INFO - 'MAIL': '/var/mail/cltbld', 20:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:04 INFO - 'MOZ_NO_REMOTE': '1', 20:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:04 INFO - 'NO_EM_RESTART': '1', 20:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:04 INFO - 'PWD': '/builds/slave/test', 20:07:04 INFO - 'SHELL': '/bin/bash', 20:07:04 INFO - 'SHLVL': '1', 20:07:04 INFO - 'TERM': 'linux', 20:07:04 INFO - 'TMOUT': '86400', 20:07:04 INFO - 'USER': 'cltbld', 20:07:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:04 INFO - '_': '/tools/buildbot/bin/python'} 20:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:04 INFO - Running setup.py (path:/tmp/pip-URCDw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:04 INFO - Running setup.py (path:/tmp/pip-LhRgYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:04 INFO - Running setup.py (path:/tmp/pip-kfSFxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:04 INFO - Running setup.py (path:/tmp/pip-kjCbux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:04 INFO - Running setup.py (path:/tmp/pip-hH9q65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:04 INFO - Running setup.py (path:/tmp/pip-HsUKMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:04 INFO - Running setup.py (path:/tmp/pip-JTykZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:04 INFO - Running setup.py (path:/tmp/pip-q1ShpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:04 INFO - Running setup.py (path:/tmp/pip-cmpWpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:04 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)) 20:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:04 INFO - Running setup.py (path:/tmp/pip-3AlrCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:05 INFO - Running setup.py (path:/tmp/pip-st0Yiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:05 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:05 INFO - Running setup.py (path:/tmp/pip-_WfccE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:05 INFO - Running setup.py (path:/tmp/pip-0e2jQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:05 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:05 INFO - Running setup.py (path:/tmp/pip-er8L3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:05 INFO - Running setup.py (path:/tmp/pip-9aB7ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:05 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:05 INFO - Running setup.py (path:/tmp/pip-IDP4iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:05 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)) 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:05 INFO - Running setup.py (path:/tmp/pip-9WnOb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:05 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)) 20:07:05 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)) 20:07:05 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)) 20:07:05 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)) 20:07:05 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)) 20:07:05 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)) 20:07:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:05 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 20:07:05 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 20:07:05 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 20:07:05 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 20:07:05 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 20:07:05 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 20:07:07 INFO - Downloading blessings-1.6.tar.gz 20:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:07 INFO - Installing collected packages: blessings 20:07:07 INFO - Running setup.py install for blessings 20:07:07 INFO - Successfully installed blessings 20:07:07 INFO - Cleaning up... 20:07:07 INFO - Return code: 0 20:07:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:07 INFO - Reading from file tmpfile_stdout 20:07:07 INFO - Current package versions: 20:07:07 INFO - argparse == 1.2.1 20:07:07 INFO - blessings == 1.6 20:07:07 INFO - blobuploader == 1.2.4 20:07:07 INFO - docopt == 0.6.1 20:07:07 INFO - functools32 == 3.2.3-2 20:07:07 INFO - jsonschema == 2.5.1 20:07:07 INFO - manifestparser == 1.1 20:07:07 INFO - mozInstall == 1.12 20:07:07 INFO - mozcrash == 0.17 20:07:07 INFO - mozdebug == 0.1 20:07:07 INFO - mozdevice == 0.48 20:07:07 INFO - mozfile == 1.2 20:07:07 INFO - mozhttpd == 0.7 20:07:07 INFO - mozinfo == 0.9 20:07:07 INFO - mozleak == 0.1 20:07:07 INFO - mozlog == 3.3 20:07:07 INFO - moznetwork == 0.27 20:07:07 INFO - mozprocess == 0.23 20:07:07 INFO - mozprofile == 0.28 20:07:07 INFO - mozrunner == 6.12 20:07:07 INFO - mozscreenshot == 0.1 20:07:07 INFO - mozsystemmonitor == 0.3 20:07:07 INFO - moztest == 0.7 20:07:07 INFO - mozversion == 1.4 20:07:07 INFO - psutil == 3.1.1 20:07:07 INFO - requests == 1.2.3 20:07:07 INFO - wsgiref == 0.1.2 20:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:07 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')]} 20:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:07 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')]} 20:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:07 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:07:07 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 20:07:07 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 20:07:07 INFO - Using env: {'DISPLAY': ':0', 20:07:07 INFO - 'HOME': '/home/cltbld', 20:07:07 INFO - 'LANG': 'en_US.UTF-8', 20:07:07 INFO - 'LANGUAGE': 'en_US:en', 20:07:07 INFO - 'LOGNAME': 'cltbld', 20:07:07 INFO - 'MAIL': '/var/mail/cltbld', 20:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:07 INFO - 'MOZ_NO_REMOTE': '1', 20:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:07 INFO - 'NO_EM_RESTART': '1', 20:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:07 INFO - 'PWD': '/builds/slave/test', 20:07:07 INFO - 'SHELL': '/bin/bash', 20:07:07 INFO - 'SHLVL': '1', 20:07:07 INFO - 'TERM': 'linux', 20:07:07 INFO - 'TMOUT': '86400', 20:07:07 INFO - 'USER': 'cltbld', 20:07:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:07 INFO - '_': '/tools/buildbot/bin/python'} 20:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 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)) 20:07:08 INFO - Cleaning up... 20:07:08 INFO - Return code: 0 20:07:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:08 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 0x131c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, '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': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', '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 20:07:08 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 20:07:08 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 20:07:08 INFO - Using env: {'DISPLAY': ':0', 20:07:08 INFO - 'HOME': '/home/cltbld', 20:07:08 INFO - 'LANG': 'en_US.UTF-8', 20:07:08 INFO - 'LANGUAGE': 'en_US:en', 20:07:08 INFO - 'LOGNAME': 'cltbld', 20:07:08 INFO - 'MAIL': '/var/mail/cltbld', 20:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:08 INFO - 'MOZ_NO_REMOTE': '1', 20:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:08 INFO - 'NO_EM_RESTART': '1', 20:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:08 INFO - 'PWD': '/builds/slave/test', 20:07:08 INFO - 'SHELL': '/bin/bash', 20:07:08 INFO - 'SHLVL': '1', 20:07:08 INFO - 'TERM': 'linux', 20:07:08 INFO - 'TMOUT': '86400', 20:07:08 INFO - 'USER': 'cltbld', 20:07:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:08 INFO - '_': '/tools/buildbot/bin/python'} 20:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:08 INFO - Cleaning up... 20:07:08 INFO - Return code: 0 20:07:08 INFO - Running post-action listener: _resource_record_post_action 20:07:08 INFO - Running post-action listener: _start_resource_monitoring 20:07:08 INFO - Starting resource monitoring. 20:07:08 INFO - [mozharness: 2016-08-04 03:07:08.437035Z] Finished create-virtualenv step (success) 20:07:08 INFO - [mozharness: 2016-08-04 03:07:08.437466Z] Running install step. 20:07:08 INFO - Running pre-action listener: _resource_record_pre_action 20:07:08 INFO - Running main action method: install 20:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:08 INFO - Reading from file tmpfile_stdout 20:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:08 INFO - Reading from file tmpfile_stdout 20:07:08 INFO - Output received: 20:07:08 INFO - Usage: mozinstall [options] installer 20:07:08 INFO - Options: 20:07:08 INFO - -h, --help show this help message and exit 20:07:08 INFO - -d DEST, --destination=DEST 20:07:08 INFO - Directory to install application into. [default: 20:07:08 INFO - "/builds/slave/test"] 20:07:08 INFO - --app=APP Application being installed. [default: firefox] 20:07:08 INFO - mkdir: /builds/slave/test/build/application 20:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:07:24 INFO - Reading from file tmpfile_stdout 20:07:24 INFO - Output received: 20:07:24 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:24 INFO - Running post-action listener: _resource_record_post_action 20:07:24 INFO - [mozharness: 2016-08-04 03:07:24.787352Z] Finished install step (success) 20:07:24 INFO - [mozharness: 2016-08-04 03:07:24.787626Z] Running run-tests step. 20:07:24 INFO - Running pre-action listener: _resource_record_pre_action 20:07:24 INFO - Running main action method: run_tests 20:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:24 INFO - Python 2.7.3 20:07:24 INFO - Return code: 0 20:07:24 INFO - grabbing minidump binary from tooltool 20:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:24 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 0x15db3b0>, '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 0x15dc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:24 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 20:07:24 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 20:07:24 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 20:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:24 INFO - Return code: 0 20:07:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:24 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/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 20:07:24 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/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 20:07:24 INFO - Using env: {'DISPLAY': ':0', 20:07:24 INFO - 'HOME': '/home/cltbld', 20:07:24 INFO - 'LANG': 'en_US.UTF-8', 20:07:24 INFO - 'LANGUAGE': 'en_US:en', 20:07:24 INFO - 'LOGNAME': 'cltbld', 20:07:24 INFO - 'MAIL': '/var/mail/cltbld', 20:07:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:24 INFO - 'MOZ_NO_REMOTE': '1', 20:07:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:24 INFO - 'NO_EM_RESTART': '1', 20:07:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:24 INFO - 'PWD': '/builds/slave/test', 20:07:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:24 INFO - 'SHELL': '/bin/bash', 20:07:24 INFO - 'SHLVL': '1', 20:07:24 INFO - 'TERM': 'linux', 20:07:24 INFO - 'TMOUT': '86400', 20:07:24 INFO - 'USER': 'cltbld', 20:07:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265', 20:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:24 INFO - '_': '/tools/buildbot/bin/python'} 20:07:24 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/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 20:07:25 INFO - mozversion application_buildid: 20160803185123 20:07:25 INFO - mozversion application_changeset: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b 20:07:25 INFO - mozversion application_display_name: Nightly 20:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:25 INFO - mozversion application_name: Firefox 20:07:25 INFO - mozversion application_remotingname: firefox 20:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:07:25 INFO - mozversion application_vendor: Mozilla 20:07:25 INFO - mozversion application_version: 51.0a1 20:07:25 INFO - mozversion platform_buildid: 20160803185123 20:07:25 INFO - mozversion platform_changeset: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b 20:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:07:25 INFO - mozversion platform_version: 51.0a1 20:07:25 INFO - using testdate: 1470280045 20:07:25 INFO - actual date: 1470280045 20:07:25 INFO - starting webserver on 'localhost:40373' 20:07:25 INFO - SUITE-START | Running 2 tests 20:07:25 INFO - TEST-START | dromaeo_css 20:07:25 INFO - operating with platform_type : linux_ 20:07:25 INFO - Initialising browser for dromaeo_css test... 20:07:25 INFO - TEST-INFO | started process 27115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0sZlC/profile http://localhost:40373/getInfo.html) 20:07:29 INFO - PROCESS | 27115 | __metrics Screen width/height:1600/1200 20:07:29 INFO - PROCESS | 27115 | colorDepth:24 20:07:29 INFO - PROCESS | 27115 | Browser inner width/height: 1024/697 20:07:29 INFO - PROCESS | 27115 | __metrics 20:07:30 INFO - PROCESS | 27115 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:07:30 INFO - PROCESS | 27115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:31 INFO - TEST-INFO | 27115: exit 0 20:07:31 INFO - Browser initialized. 20:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:31 INFO - TEST-INFO | started process 27195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0sZlC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:43 INFO - PROCESS | 27195 | RSS: Main: 158035968 20:07:43 INFO - PROCESS | 27195 | 20:08:34 INFO - PROCESS | 27195 | 1470280114477 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] 20:10:47 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40373/tests/dromaeo/cssquery-ext.html) 20:10:49 INFO - PROCESS | 27195 | RSS: Main: 248344576 20:10:49 INFO - PROCESS | 27195 | 20:13:51 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-ext.html (next: http://localhost:40373/tests/dromaeo/cssquery-jquery.html) 20:13:52 INFO - PROCESS | 27195 | RSS: Main: 239845376 20:13:52 INFO - PROCESS | 27195 | 20:16:54 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40373/tests/dromaeo/cssquery-mootools.html) 20:16:55 INFO - PROCESS | 27195 | RSS: Main: 187162624 20:16:55 INFO - PROCESS | 27195 | 20:19:57 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40373/tests/dromaeo/cssquery-prototype.html) 20:19:57 INFO - PROCESS | 27195 | RSS: Main: 189702144 20:19:57 INFO - PROCESS | 27195 | 20:23:00 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40373/tests/dromaeo/cssquery-yui.html) 20:23:01 INFO - PROCESS | 27195 | RSS: Main: 189919232 20:23:01 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-yui.html (next: http://localhost:40373/tests/dromaeo/cssquery-dojo.html) 20:26:04 INFO - PROCESS | 27195 | RSS: Main: 281350144 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | __start_tp_report 20:26:04 INFO - PROCESS | 27195 | _x_x_mozilla_page_load 20:26:04 INFO - PROCESS | 27195 | _x_x_mozilla_page_load_details 20:26:04 INFO - PROCESS | 27195 | |i|pagename|runs| 20:26:04 INFO - PROCESS | 27195 | |0;dojo.html;2686.7581917627417;2696.1776658119265;2722.795790315726;2730.590411438284;2736.2065001149667;4710.105080034791;4775.116603428364;4807.495213002628;4878.731669758166;4879.878003049921;4737.8815529611775;4793.32893394925;4818.445878723939;4823;4871.829485967992;4332.436783218177;4385.298352263639;4464.218761716703;4533.22935101032;4596.839110631128;4541.523140070294;4566.13243483737;4598.816047358102;4613.792379342921;4623.560761727647;4343.109662519176;4385.429894113745;4460.420145381079;4467.128909862578;4534.478534968488;4404.889877753049;4442.178197033559;4446.666500012512;4490.146872094291;4493.59557639814;4389.736615803062;4455.4207952966235;4479.574440428154;4481.35020422037;4528.977355113237;4746.715197088186;4925.827596034157;4946.431160416562;4976.02967421353;4985.850424487271;5111.463296353903;5174.922376164361;5186.377634683824;5251.737413129366;5259.921101183485;5203.765830537635;5249.265102885599;5250.606204534675;5266.183741520071;5287.920681189786;4652.441706995182;4758.452777930513;4906.730129842857;4913.06651736169;4920.384951881015;5242.68543887368;5245.554127899095;5300.416954135042;5321.600879934021;5324.281222034976;5072;5109.08036553424;5111.258867464197;5112.795488180431;5118.232265160255;4905.9264111038365;5012.899742005139;5199.714015729096;5213.556847667991;5214.530692237717;4958.652894297436;5036.7733451994745;5069.923951140736;5091;5093.821716239914;5012;5027.1705168647495;5030.89938201234;5036.546710796046;5085.74571271435;4172.958270417318;4251.489821221473;4263.062126332202;4264.1471705659;4311.116221174651;3704.9629503705155;3772.7924964127237;3820.331441997695;3868.1490072184074;3917.118648304109;4463.575960283768;4464.241079016575;4481.484629267611;4514.164879497303;4527.366168736379;5189.974050129726;5203.141481655484;5209.947900521022;5211.088059589557;5230.555402790806;4337.934930976038;4423;4486.618637415856;4487.64098872096;4544.318352247189;4653.511381304914;4681.461631912373;4682.906341873211;4685.297205419146;4730.030343779517;4860;4897.681650692693;4912.263160525949;4918.532739389752;4957.876053098701;4996.7001979881325;5189.221616757516;5251.579873610179;5263.421023687468;5265.894682106413;4869.050535145754;4901.779419926041;4905.558499734898;4907.631927605516;4954.5540901319055;5111.105556527667;5145.202493613496;5145.279660847559;5150.304708864405;5152.716600587004;4912.533309335608;5115.718635474936;5157.174852023658;5171.198464238049;5241.371035475768;5022.723750193774;5026.648134630541;5029.06962211992;5031.597472202142;5079.085764562415;5030.899382012412;5036.269740887624;5036.420811606712;5036.748162591929;5042.218456139304;4777.307290442797;4873.756312184448;4933.605311575137;4934.5805606523845;4996.050750357421;5034.84895453137;5048.217526283432;5050.696958182521;5052.216906379517;5108.233764935141;4895.877603059952;4927.18701414277;4935.851924442272;4946.62900282473;4992.750362481934 20:26:04 INFO - PROCESS | 27195 | |1;ext.html;558.3997203006768;584.8216294030321;587.905935050392;590.0912594604309;590.4420322794958;30008.84995575022;39493.407598886006;40964.38553421701;40977.38533921994;45173.54826451735;42196;42695;42755.572444275545;42762.786186069105;42797;7711.768646940601;7837.333826624744;7852;7855.253750893656;7856.9607151964165;7778.5721785301785;7858.09631892334;7862.764117076496;7864.567448790314;7869.449138560303;7896.881546776803;7935.365170786352;7944.404169687267;7948;7949.64226609804;7818.609069546556;7825.178356272595;7841.843163136706;7869.331106855924;7871.330936870373;7725.729599463992;7738.342240909529;7783.754599264091;7797.220277972214;7803.02462192226;39032.60967390318;39464.80267598644;39481.60518394808;39492;39541.60458395408;3106.7359274461696;3143.1199264206057;3199.488081906907;3275.4431746603136;3518.9472157917394;28841.711582884112;28963.42073158525;29501.704982950327;29521.409571808657;29632.851835740683;3331.6501767314567;3343.314620502791;3366.8989930301886;3398.7084907735148;3478.4260597001467;253357;255690;255930.72034639894;256035;256458;32407.837960810517;33477.83261083679;48864;48965.265521017216;54188.93582981292;34574.654253457644;34598;34835.477467838005;34846.825765871516;34864.651353486646;12249.877501224873;12421.31682757457;12425.19236249641;12434.937825310815;12435.937820311021;9986.700398988041;10023.69928902134;10126.139278161292;10145.594176233015;10150.543225554868;8002.039245479094;8027.678892844221;8055.7583272501915;8135.145809690016;8155.34757219421;3083.105899289226;3096.8606412711483;3128.2179455136215;3149.1812128846664;3161.4309424303847;860.9139086091341;910.1262787723726;912.7581190984395;966.9516524173763;983.8327484327682;28512.85743571269;28648.418947631548;29455.558166627517;29764;29948;836.5357226739218;918.2149262380568;942.4863449420083;950.1306304731094;969.8981606931312;15476.22618869052;15647.608809779847;15806;15848.44530441429;16136.354545818036;408710;411058;411100;411410;411489;48441.273380899314;51938.480615193366;52062.73968630133;52140;52144.478555213966;1093.4423444043596;1161.9535218591332;1188.7622475504934;1189.3161432176532;1208.5769980506752;28901.855490722413;29704;30046.399072018874;30977.69022309748;31027.224319392197;48171.277430837865;48849.267260990404;48851.26723099085;48914.35313645198;49193.75403122961;358641;361873;363102;363151;363511;26017.349566260997;26796;26872.462550748485;27895.234143390382;27954.301142471602;42309;42734.78632606817;42939.785301073294;43404.78297608492;43932.78033609811;35958;36535;36641.26717465689;36956.260874781816;37109.257814844095;36924;37037;37312.81343593264;37475.625243747214;37600.247995040496;35957.460638090975;36102;36861.81569092137;36883;37330.81334593309;31722.365552688356;33433.99698009063;33728;33851.15372115717;33966;25359.36601584975;25389.87305063463;25508.489830203664;25623.10319138821;25656.615150773127 20:26:04 INFO - PROCESS | 27195 | |2;jquery.html;344.40197483675763;363.7690066807576;372.6385406156029;374.4701247734455;388.20611848769266;12796.808047879278;13299.46802127915;14949.327280272386;16887.24007419666;16969.74545381817;15510.767338489932;16179.35282588695;16634.085125318103;16640.084795336283;16642;4856.417229932413;5013.398392192924;5016.974915125419;5019.723915184663;5025.497450254982;3691.2617476504806;5690.9146362804595;5911.586188966774;5992.670403127848;5997.130416089664;4903.313536104948;5956.285245770514;5957.1957785698805;5967.104934259853;5967.373425790294;5114.386273647149;5204.531592156686;5209.400918894337;5213.556847667953;5216.973915130438;4384.21084204843;4646.628269738413;4681.976590117061;4718.952810471886;5073.949260507385;11570.42147892602;11680.88319116815;11784.705382365424;11898.22661526998;11913.702157446047;1700.5578549577076;1810.4297146398974;1853.5551467647801;1878.6618408686431;1880.4170707080848;8667.4366166199;9069.727908162766;9107.726768196899;9115.270778337717;9145.131212534865;1727.9395221167324;1730.368415528323;1733.7052701040852;1760.111143872349;1853.527350525621;68131;69006.30993690049;70960;72107;73686;9779.266555008402;9937.503124843728;10128.34165779222;10308.07227349527;10433.373997560171;14018.158910465405;14111.576652700436;14284.428622855177;14312.85687143136;14316.498922537661;6772.356626120511;7028.824279393056;7037.2962703730245;7189.676464559107;7238.855222895512;6354.3645635437015;6506;6642.900356494656;6667.366600172976;6715.56348837324;4153.480814898137;4230.661547076226;4276.273033584298;4334.523202447728;4508.143452744033;1800.8469280111076;1811.9184636691116;1870.9532261693294;1897.354899334233;1920.4430715092747;796.2992566541407;800.7998000499875;820.7660816667221;851.527402291734;898.9011208767031;17009.064501452292;17372.47882563525;17613.7357939631;17693.026883521274;17989.100544972698;834.7120243515977;849.8427790858711;852.1720908650909;874.7375787263795;904.7738065483629;9630.32587718867;9889.554970026365;9980.37482584531;10020.749481262881;10103.09072183507;395777;397092;407059;408766;410402;48317.275240871415;64294.35705642977;75877;79198.62404127885;79870;886.2909672262293;896.5338024227365;905.9094090590888;932.3100905330142;956.1872408452898;15063;15300.540983770505;15798;15922.840771592137;16167.27247273899;37529.249415011;37945.177624695156;38977.80511097427;39253;39983.60016399799;53871.46128538821;53893.73053134709;54642.72678636581;55557;56384;6128.9693551531955;6592.967035164794;6836.829079273058;7145.1068616422945;7822.882656760267;9494.382865113745;12345.814812777995;12568.554616219251;12588.748225035632;12605.243685378906;8582.184692454206;10106.039926206999;10207.7448063799;10311.639092631722;10533.945880553218;10581.418022008556;10584.735381615214;10781.245312828027;10973.725656858323;11284.21010529255;10081.853558169678;10110.747231319276;10116.291859570054;10318.690439286833;10445.112165465716;6840.623765692934;6841.989524609156;6888.517803753689;7076.716931322895;7101.857962840818;9466.763330916507;9661.033896610283;9825.4104753715;9846.556904939152;10340.327878687862 20:26:04 INFO - PROCESS | 27195 | |3;mootools.html;1226.0559369285656;1357.721667058253;1408.9855304180992;1475.778633205019;1673.8409851064152;6342.175517182765;7116.110486189226;7432.814179645512;7452.776416707494;7463.253674632534;7283.890741638879;7333.6333183340885;7335.77992660221;7342.669579868905;7350.889736653954;2110.672845708914;2137.1237792505076;2138.9358319250446;2141.0365335598963;2142.3251675722177;2092.236333738182;2126.6065777831072;2149.3659370485666;2158.838087143463;2159.924402645908;2120.4698825293676;2138.080625331107;2148.559545293211;2152.0315857863948;2159.838012149095;2078.1687325069943;2083.1459101768355;2085.760137584182;2085.9061342239634;2087.0295312679523;2017.535966727661;2052.5894821035854;2054.414491869825;2057.1668474267944;2062.8143467087884;7299.817504562428;7374.483786134972;7499.100107987022;7596.962015189889;7609.048868891388;4221.071364299849;4378.43080399546;4393.758343291118;4400.493943196541;4408.625266852321;2704.945901081987;2844.160972513093;2878.928026799326;2882.6252587163535;2888.566714992768;923.736735030513;925.6343744221062;936.7587945971546;944.376711370499;951.7525443384701;10079.69760907174;10136.79726405475;10169.796604067951;10196.184305255561;10222.846657300146;3909.765414075108;3910.882673519799;4002.639762421396;4016.2971479990883;4104.91790164195;8403.201695838885;8772.473651580925;8772.824543509094;8780.912190878009;8790.120987901159;4412.779361031936;4420.491643460979;4439.334099885043;4446.666500012512;4449.777511124431;3400.1839558506276;3493.406120959443;3500.3524347995703;3993.5008123984503;3998.7400818946676;3407.0289967359186;3546.3261980224192;3572.517710109154;3576.9821150894077;3636.3454578176184;1189.916705830601;1206.2099324942176;1206.7284860906225;1215.0401183065455;1218.62831836289;808.7452452477451;812.4353574265947;814.0963530481162;836.7029704454952;852.1478521478522;4787.593054590329;4949.257611358253;5041.042201981685;5081.2632168335385;5199.376074871039;385.44880820427056;849.2526576612541;899.3749344205714;905.5336501701629;975.6097560975667;3284.523744057098;3313.4532802087388;3414.7438942079443;3423.1613254752747;3565.9286814264087;8975.461472311683;9315.906840931639;9332.4867132307;9337.253019758404;9361.953190234006;9179;9200.907990920005;9221.95389023064;9245.260379169651;9279.582418791171;6989.33601307875;6995.8600827983155;7003.684834182576;7077.752278670222;7078.398336141486;4730.787114579921;4772.689775164603;4815.686980346266;4838.854834354975;4934.753262336941;8463.915360846313;8504.404691671523;8526.616302266537;8553.786155346166;8582.957085214533;8393.328533717166;8634.611442484978;8752.081031491602;8779.341549383695;8780.912190878265;5530.419305972815;5963.194968679173;6042.093685947143;6125;6242.625442473284;7162.319579639926;7246.239144889922;7250.274972502708;7252.347288744038;7260.310270524292;6428.871422571616;6437.163168788027;6589.835254118685;6629.403353697998;6728.663566821737;6245.469135123383;6275.497960163268;6322.146510221061;6347.746090156342;6578.177727784027;6148.50811935053;6245.7189426476825;6248.750049998131;6248.937510624835;6249.281332646804;4205.432266643964;4258.616724494686;4259.318509038539;4422.955770442383;4428.623566996841;4328.502222244482;4454.5990860822685;4530.252508336088;4543.840965566189;4576.81692732287 20:26:04 INFO - PROCESS | 27195 | |4;prototype.html;278.9972100278997;283.83395713507605;284.85472409071366;294.2892913613625;294.7965903526565;4897.865366165657;4942.975285123578;4955.578775804056;4967.218357719679;4972.651914365996;4850.563449289563;4856.980034192824;4913.434954980178;4915.100090946341;4928.433230178531;3657.6708096271395;3769.5288088988877;3773.603771603983;3776.7545109567927;3783.6216378362083;3673.8897833065053;3767.227718317752;3815.882185387109;3823.5220597425323;3863.4011728182177;3764.2659681362147;3769.3403654360513;3780.206156707095;3795.235215624734;3811.7331786774935;3566.946495802565;3733.4773131761576;3766.510353654021;3791.090138366772;3792.374258247386;3250.089974807058;3250.1062207892783;3256.348730253959;3262.429074911881;3276.5249038889465;4676.830792301925;4692.272697731857;4704.976475117603;4711.505291944331;4747.6914000590195;4262.978685106555;4264.914701705949;4273.978630106861;4287.056847493546;4288.957110428887;4888;5008.1486147355035;5020.121478741242;5021.774020169101;5083.517065878736;3540.132667496454;3557.4130268505664;3564.518789963374;3574.8212589370687;3578.6779189873037;5298.602604804655;5321.5742740581045;5341.973290133564;5356.812511562116;5379.704116273564;3538.3100295442655;3604.5494313210847;3628.7097032237357;3629.364861149288;3650.6714395703984;3648.945265821015;3658.725595580342;3665.303592317451;3673.2837096765875;3679.889603311905;4195.853145139906;4196.559361267084;4209.221294060548;4222.704410691222;4241.406203131564;4932.90134197314;5055.7219352935945;5055.848324550269;5058;5088.313077734459;1253.7241806802672;1265.7784887644625;1269.162352847135;1270.805442883705;1271.3706715175863;785.4148659248896;796.3231253434534;810.0846043970275;810.9498199831232;812.6099472253352;4290.806913688892;4337.978310108492;4453.131639330364;4514.45826500822;4517.977410112929;5225.817096401684;5226.294450249244;5235.764390602432;5276.604254680914;5287.286216360819;4462.598366147063;4475.283954567253;4475.5300693426725;4487.596116349544;4488.214562451623;2623.921282361532;2741.588082137701;2758.5310497215523;2763.69599344072;2765;4884.194107972145;4910.779014944336;4916.7541622919425;4924.064427758714;4929.901401971941;5064.037832811754;5324.547413469899;5338.199270109515;5349.251104845324;5353.973230133903;4868.902621947541;4903.975480122576;4904.337914381513;4909.533594308535;4914.23087688439;5197.636165468381;5211.270422140828;5231.293775340432;5234.377343023675;5235.188545775411;4957.826476073465;5124.461931497139;5131.384233891957;5142.357205349332;5151.253068305;4821.228603423436;4864.975675121602;4883.267509873547;4890.24201248807;4906.386701662293;3632.9636703632627;3643.2349206666895;3651.4705367721;3656.0859785053735;3661.7436779425184;4994.625403094709;5254.238135470259;5273.918846636354;5277.973610131925;5280.260763493037;4931.580815630711;4998.300237966615;4998.400191976986;5004.799808007639;5008.248762685481;5003.499650035113;5006.49935006511;5013.222950442541;5019.598432125348;5030.37120359955;4828.5412885775795;4931.630127740362;4952.034353301072;4966.478519755518;4996.175631020987;4873.4639189689815;4952.826651067196;5049.469805670498;5052.72210028452;5059.924101138412;4959.330490383896;4966.5033496651495;4993.750312484434;5007.474215207497;5010.624203184703 20:26:04 INFO - PROCESS | 27195 | |5;yui.html;660.5541259649735;685.9794206173814;686.7356067913853;704.8132244955091;746.0562388578446;12577.245365278079;13758.17450952941;13788.310584470773;13791.241481718514;13836.584902452918;13545.864541354584;13629.114107583;13631.863681363184;13680.521181758615;13682.11066280691;629.4586655476287;643.5302229372561;764.3083009876071;768.404486522945;776.596169991604;773.7407968330588;774.6359211170741;777.0364747712852;777.2538363171362;777.2771322669914;834.4409245805325;835.9122292159327;836.1930736838949;836.523181786382;836.5440834745078;654.8362909272682;672.5225090185974;674.0193019157115;677.0352248046514;830.4228561150003;590.8463799412141;600.9098635204755;602.9668368239745;608.996955015222;609.34495417426;12638.873611263862;12649.43077561512;12654.557090501788;12655.746885062339;12663.746725065446;12656.36718164088;13153.736925261537;13516.864831351659;13526.188428694211;13682.589522314247;12025.398730063462;12159.696007599792;12239.755204895851;12393.256404615662;12608.432620532098;4150.398192262105;4184.560621134768;4198.181354635847;4219.620234178908;4270.957290427087;67070.66464667695;69204.3079569203;69429;69581;69732.99999999949;10388.065074143364;10456.372617642966;10545.420001899969;10560.419176945188;10704.839427408595;20152;20174.495637608885;20183.192672293237;20202.494937626383;20206.595868082557;6967.477439192081;7061.258567850405;7095.574265544084;7435.51669141504;7520.9623951880985;3795.7912314822397;3950.111224974358;3966.841326346914;3979.6617287530885;3986.740861843971;2658.853763043051;2751.7385848344375;3177.9841100794347;3381.9323613528086;3391.2878295557716;541.8916216756664;547.667443605664;550.4550495009992;551.5311984812957;557.6263903184876;553.7286729502515;580.6487075319455;615.5506480269339;628.7233617208414;641.2426565767275;8115.391345648982;8380.371472139492;8456.154384561618;8496.660133594587;8587.699430519902;559.5859064292475;579.39163877928;581.2734082397004;585.7920438244447;594.1058706646555;3852.5954774748247;3942.3495123304906;3993.820278087493;4049.190161967618;4196.769177695195;97248;102074;103204.48397757963;107093.46453267684;107219;70202.2979770206;71483.8516148381;71992.28007719856;82934;86633;47242;74605.25394746092;75496.86754698683;76504;77605.2239477598;8170.387220958333;8251;8308.14956663994;8337.791555211168;8441.66233350659;31965.520517192726;40765.388519172826;43121.56878431301;43951.560484394744;43999.78000110107;59017.704911475164;60941.39058609357;61625.38374616196;62135;64522.35477645163;11308.208425410472;11338.319700817978;11455.828162577402;11497.82753258685;11503;12442.875571244173;12530.310832904277;12734.044946629225;13057.608271751862;13490.460381585019;11932.701682458008;12294.81557776652;12299.69250768738;12738.936305318413;13113.278769667379;11546.711332216762;12256.571020014257;12431.44058517387;12952.870471295166;13051.804222936473;12177.878221217674;12345.814812777637;12705.936470317589;12925.28910909909;12942.741145177231;10188;10451;10641.840372394576;10913.181511386836;11013.944930275296;9259.907400925904;9851.704448866545;10299.227557933335;10511.159107271553;10728.356298622108 20:26:04 INFO - PROCESS | 27195 | __end_tp_report 20:26:04 INFO - PROCESS | 27195 | __start_cc_report 20:26:04 INFO - PROCESS | 27195 | _x_x_mozilla_cycle_collect,980 20:26:04 INFO - PROCESS | 27195 | __end_cc_report 20:26:04 INFO - PROCESS | 27195 | __startTimestamp1470281164780__endTimestamp 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | ------- Summary: start ------- 20:26:04 INFO - PROCESS | 27195 | Number of tests: 6 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#0] dojo.html Cycles:165 Average:4778.40 Median:4918.53 stddev:498.64 (10.1%) stddev-sans-first:472.40 20:26:04 INFO - PROCESS | 27195 | Values: 2686.8 2696.2 2722.8 2730.6 2736.2 4710.1 4775.1 4807.5 4878.7 4879.9 4737.9 4793.3 4818.4 4823.0 4871.8 4332.4 4385.3 4464.2 4533.2 4596.8 4541.5 4566.1 4598.8 4613.8 4623.6 4343.1 4385.4 4460.4 4467.1 4534.5 4404.9 4442.2 4446.7 4490.1 4493.6 4389.7 4455.4 4479.6 4481.4 4529.0 4746.7 4925.8 4946.4 4976.0 4985.9 5111.5 5174.9 5186.4 5251.7 5259.9 5203.8 5249.3 5250.6 5266.2 5287.9 4652.4 4758.5 4906.7 4913.1 4920.4 5242.7 5245.6 5300.4 5321.6 5324.3 5072.0 5109.1 5111.3 5112.8 5118.2 4905.9 5012.9 5199.7 5213.6 5214.5 4958.7 5036.8 5069.9 5091.0 5093.8 5012.0 5027.2 5030.9 5036.5 5085.7 4173.0 4251.5 4263.1 4264.1 4311.1 3705.0 3772.8 3820.3 3868.1 3917.1 4463.6 4464.2 4481.5 4514.2 4527.4 5190.0 5203.1 5209.9 5211.1 5230.6 4337.9 4423.0 4486.6 4487.6 4544.3 4653.5 4681.5 4682.9 4685.3 4730.0 4860.0 4897.7 4912.3 4918.5 4957.9 4996.7 5189.2 5251.6 5263.4 5265.9 4869.1 4901.8 4905.6 4907.6 4954.6 5111.1 5145.2 5145.3 5150.3 5152.7 4912.5 5115.7 5157.2 5171.2 5241.4 5022.7 5026.6 5029.1 5031.6 5079.1 5030.9 5036.3 5036.4 5036.7 5042.2 4777.3 4873.8 4933.6 4934.6 4996.1 5034.8 5048.2 5050.7 5052.2 5108.2 4895.9 4927.2 4935.9 4946.6 4992.8 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#1] ext.html Cycles:180 Average:48758.24 Median:36996.63 stddev:92242.52 (249.3%) stddev-sans-first:92430.29 20:26:04 INFO - PROCESS | 27195 | Values: 558.4 584.8 587.9 590.1 590.4 30008.8 39493.4 40964.4 40977.4 45173.5 42196.0 42695.0 42755.6 42762.8 42797.0 7711.8 7837.3 7852.0 7855.3 7857.0 7778.6 7858.1 7862.8 7864.6 7869.4 7896.9 7935.4 7944.4 7948.0 7949.6 7818.6 7825.2 7841.8 7869.3 7871.3 7725.7 7738.3 7783.8 7797.2 7803.0 39032.6 39464.8 39481.6 39492.0 39541.6 3106.7 3143.1 3199.5 3275.4 3518.9 28841.7 28963.4 29501.7 29521.4 29632.9 3331.7 3343.3 3366.9 3398.7 3478.4 253357.0 255690.0 255930.7 256035.0 256458.0 32407.8 33477.8 48864.0 48965.3 54188.9 34574.7 34598.0 34835.5 34846.8 34864.7 12249.9 12421.3 12425.2 12434.9 12435.9 9986.7 10023.7 10126.1 10145.6 10150.5 8002.0 8027.7 8055.8 8135.1 8155.3 3083.1 3096.9 3128.2 3149.2 3161.4 860.9 910.1 912.8 967.0 983.8 28512.9 28648.4 29455.6 29764.0 29948.0 836.5 918.2 942.5 950.1 969.9 15476.2 15647.6 15806.0 15848.4 16136.4 408710.0 411058.0 411100.0 411410.0 411489.0 48441.3 51938.5 52062.7 52140.0 52144.5 1093.4 1162.0 1188.8 1189.3 1208.6 28901.9 29704.0 30046.4 30977.7 31027.2 48171.3 48849.3 48851.3 48914.4 49193.8 358641.0 361873.0 363102.0 363151.0 363511.0 26017.3 26796.0 26872.5 27895.2 27954.3 42309.0 42734.8 42939.8 43404.8 43932.8 35958.0 36535.0 36641.3 36956.3 37109.3 36924.0 37037.0 37312.8 37475.6 37600.2 35957.5 36102.0 36861.8 36883.0 37330.8 31722.4 33434.0 33728.0 33851.2 33966.0 25359.4 25389.9 25508.5 25623.1 25656.6 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#2] jquery.html Cycles:180 Average:24341.61 Median:4577.39 stddev:66615.80 (1455.3%) stddev-sans-first:66778.31 20:26:04 INFO - PROCESS | 27195 | Values: 344.4 363.8 372.6 374.5 388.2 12796.8 13299.5 14949.3 16887.2 16969.7 15510.8 16179.4 16634.1 16640.1 16642.0 4856.4 5013.4 5017.0 5019.7 5025.5 3691.3 5690.9 5911.6 5992.7 5997.1 4903.3 5956.3 5957.2 5967.1 5967.4 5114.4 5204.5 5209.4 5213.6 5217.0 4384.2 4646.6 4682.0 4719.0 5073.9 11570.4 11680.9 11784.7 11898.2 11913.7 1700.6 1810.4 1853.6 1878.7 1880.4 8667.4 9069.7 9107.7 9115.3 9145.1 1727.9 1730.4 1733.7 1760.1 1853.5 68131.0 69006.3 70960.0 72107.0 73686.0 9779.3 9937.5 10128.3 10308.1 10433.4 14018.2 14111.6 14284.4 14312.9 14316.5 6772.4 7028.8 7037.3 7189.7 7238.9 6354.4 6506.0 6642.9 6667.4 6715.6 4153.5 4230.7 4276.3 4334.5 4508.1 1800.8 1811.9 1871.0 1897.4 1920.4 796.3 800.8 820.8 851.5 898.9 17009.1 17372.5 17613.7 17693.0 17989.1 834.7 849.8 852.2 874.7 904.8 9630.3 9889.6 9980.4 10020.7 10103.1 395777.0 397092.0 407059.0 408766.0 410402.0 48317.3 64294.4 75877.0 79198.6 79870.0 886.3 896.5 905.9 932.3 956.2 15063.0 15300.5 15798.0 15922.8 16167.3 37529.2 37945.2 38977.8 39253.0 39983.6 53871.5 53893.7 54642.7 55557.0 56384.0 6129.0 6593.0 6836.8 7145.1 7822.9 9494.4 12345.8 12568.6 12588.7 12605.2 8582.2 10106.0 10207.7 10311.6 10533.9 10581.4 10584.7 10781.2 10973.7 11284.2 10081.9 10110.7 10116.3 10318.7 10445.1 6840.6 6842.0 6888.5 7076.7 7101.9 9466.8 9661.0 9825.4 9846.6 10340.3 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#3] mootools.html Cycles:180 Average:4903.71 Median:4886.80 stddev:2739.55 (56.1%) stddev-sans-first:2733.29 20:26:04 INFO - PROCESS | 27195 | Values: 1226.1 1357.7 1409.0 1475.8 1673.8 6342.2 7116.1 7432.8 7452.8 7463.3 7283.9 7333.6 7335.8 7342.7 7350.9 2110.7 2137.1 2138.9 2141.0 2142.3 2092.2 2126.6 2149.4 2158.8 2159.9 2120.5 2138.1 2148.6 2152.0 2159.8 2078.2 2083.1 2085.8 2085.9 2087.0 2017.5 2052.6 2054.4 2057.2 2062.8 7299.8 7374.5 7499.1 7597.0 7609.0 4221.1 4378.4 4393.8 4400.5 4408.6 2704.9 2844.2 2878.9 2882.6 2888.6 923.7 925.6 936.8 944.4 951.8 10079.7 10136.8 10169.8 10196.2 10222.8 3909.8 3910.9 4002.6 4016.3 4104.9 8403.2 8772.5 8772.8 8780.9 8790.1 4412.8 4420.5 4439.3 4446.7 4449.8 3400.2 3493.4 3500.4 3993.5 3998.7 3407.0 3546.3 3572.5 3577.0 3636.3 1189.9 1206.2 1206.7 1215.0 1218.6 808.7 812.4 814.1 836.7 852.1 4787.6 4949.3 5041.0 5081.3 5199.4 385.4 849.3 899.4 905.5 975.6 3284.5 3313.5 3414.7 3423.2 3565.9 8975.5 9315.9 9332.5 9337.3 9362.0 9179.0 9200.9 9222.0 9245.3 9279.6 6989.3 6995.9 7003.7 7077.8 7078.4 4730.8 4772.7 4815.7 4838.9 4934.8 8463.9 8504.4 8526.6 8553.8 8583.0 8393.3 8634.6 8752.1 8779.3 8780.9 5530.4 5963.2 6042.1 6125.0 6242.6 7162.3 7246.2 7250.3 7252.3 7260.3 6428.9 6437.2 6589.8 6629.4 6728.7 6245.5 6275.5 6322.1 6347.7 6578.2 6148.5 6245.7 6248.8 6248.9 6249.3 4205.4 4258.6 4259.3 4423.0 4428.6 4328.5 4454.6 4530.3 4543.8 4576.8 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#4] prototype.html Cycles:180 Average:4191.48 Median:4871.18 stddev:1233.45 (25.3%) stddev-sans-first:1201.45 20:26:04 INFO - PROCESS | 27195 | Values: 279.0 283.8 284.9 294.3 294.8 4897.9 4943.0 4955.6 4967.2 4972.7 4850.6 4857.0 4913.4 4915.1 4928.4 3657.7 3769.5 3773.6 3776.8 3783.6 3673.9 3767.2 3815.9 3823.5 3863.4 3764.3 3769.3 3780.2 3795.2 3811.7 3566.9 3733.5 3766.5 3791.1 3792.4 3250.1 3250.1 3256.3 3262.4 3276.5 4676.8 4692.3 4705.0 4711.5 4747.7 4263.0 4264.9 4274.0 4287.1 4289.0 4888.0 5008.1 5020.1 5021.8 5083.5 3540.1 3557.4 3564.5 3574.8 3578.7 5298.6 5321.6 5342.0 5356.8 5379.7 3538.3 3604.5 3628.7 3629.4 3650.7 3648.9 3658.7 3665.3 3673.3 3679.9 4195.9 4196.6 4209.2 4222.7 4241.4 4932.9 5055.7 5055.8 5058.0 5088.3 1253.7 1265.8 1269.2 1270.8 1271.4 785.4 796.3 810.1 810.9 812.6 4290.8 4338.0 4453.1 4514.5 4518.0 5225.8 5226.3 5235.8 5276.6 5287.3 4462.6 4475.3 4475.5 4487.6 4488.2 2623.9 2741.6 2758.5 2763.7 2765.0 4884.2 4910.8 4916.8 4924.1 4929.9 5064.0 5324.5 5338.2 5349.3 5354.0 4868.9 4904.0 4904.3 4909.5 4914.2 5197.6 5211.3 5231.3 5234.4 5235.2 4957.8 5124.5 5131.4 5142.4 5151.3 4821.2 4865.0 4883.3 4890.2 4906.4 3633.0 3643.2 3651.5 3656.1 3661.7 4994.6 5254.2 5273.9 5278.0 5280.3 4931.6 4998.3 4998.4 5004.8 5008.2 5003.5 5006.5 5013.2 5019.6 5030.4 4828.5 4931.6 4952.0 4966.5 4996.2 4873.5 4952.8 5049.5 5052.7 5059.9 4959.3 4966.5 4993.8 5007.5 5010.6 20:26:04 INFO - PROCESS | 27195 | 20:26:04 INFO - PROCESS | 27195 | [#5] yui.html Cycles:180 Average:17934.98 Median:4197.48 stddev:25333.41 (603.5%) stddev-sans-first:25371.27 20:26:04 INFO - PROCESS | 27195 | Values: 660.6 686.0 686.7 704.8 746.1 12577.2 13758.2 13788.3 13791.2 13836.6 13545.9 13629.1 13631.9 13680.5 13682.1 629.5 643.5 764.3 768.4 776.6 773.7 774.6 777.0 777.3 777.3 834.4 835.9 836.2 836.5 836.5 654.8 672.5 674.0 677.0 830.4 590.8 600.9 603.0 609.0 609.3 12638.9 12649.4 12654.6 12655.7 12663.7 12656.4 13153.7 13516.9 13526.2 13682.6 12025.4 12159.7 12239.8 12393.3 12608.4 4150.4 4184.6 4198.2 4219.6 4271.0 67070.7 69204.3 69429.0 69581.0 69733.0 10388.1 10456.4 10545.4 10560.4 10704.8 20152.0 20174.5 20183.2 20202.5 20206.6 6967.5 7061.3 7095.6 7435.5 7521.0 3795.8 3950.1 3966.8 3979.7 3986.7 2658.9 2751.7 3178.0 3381.9 3391.3 541.9 547.7 550.5 551.5 557.6 553.7 580.6 615.6 628.7 641.2 8115.4 8380.4 8456.2 8496.7 8587.7 559.6 579.4 581.3 585.8 594.1 3852.6 3942.3 3993.8 4049.2 4196.8 97248.0 102074.0 103204.5 107093.5 107219.0 70202.3 71483.9 71992.3 82934.0 86633.0 47242.0 74605.3 75496.9 76504.0 77605.2 8170.4 8251.0 8308.1 8337.8 8441.7 31965.5 40765.4 43121.6 43951.6 43999.8 59017.7 60941.4 61625.4 62135.0 64522.4 11308.2 11338.3 11455.8 11497.8 11503.0 12442.9 12530.3 12734.0 13057.6 13490.5 11932.7 12294.8 12299.7 12738.9 13113.3 11546.7 12256.6 12431.4 12952.9 13051.8 12177.9 12345.8 12705.9 12925.3 12942.7 10188.0 10451.0 10641.8 10913.2 11013.9 9259.9 9851.7 10299.2 10511.2 10728.4 20:26:04 INFO - PROCESS | 27195 | -------- Summary: end -------- 20:26:04 INFO - PROCESS | 27195 | 20:26:05 INFO - TEST-INFO | 27195: exit 0 20:26:05 INFO - TEST-OK | dromaeo_css | took 1120550ms 20:26:05 INFO - TEST-START | kraken 20:26:05 INFO - operating with platform_type : linux_ 20:26:05 INFO - Initialising browser for kraken test... 20:26:05 INFO - TEST-INFO | started process 27387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0euzxC/profile http://localhost:40373/getInfo.html) 20:26:09 INFO - PROCESS | 27387 | __metrics Screen width/height:1600/1200 20:26:09 INFO - PROCESS | 27387 | colorDepth:24 20:26:09 INFO - PROCESS | 27387 | Browser inner width/height: 1024/697 20:26:09 INFO - PROCESS | 27387 | __metrics 20:26:10 INFO - PROCESS | 27387 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:26:10 INFO - PROCESS | 27387 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:26:11 INFO - TEST-INFO | 27387: exit 0 20:26:11 INFO - Browser initialized. 20:26:11 INFO - Running cycle 1/1 for kraken test... 20:26:11 INFO - TEST-INFO | started process 27467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0euzxC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:23 INFO - PROCESS | 27467 | RSS: Main: 157876224 20:26:23 INFO - PROCESS | 27467 | 20:26:26 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:27 INFO - PROCESS | 27467 | RSS: Main: 214663168 20:26:27 INFO - PROCESS | 27467 | 20:26:29 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-dft) 20:26:30 INFO - PROCESS | 27467 | RSS: Main: 191373312 20:26:30 INFO - PROCESS | 27467 | 20:26:33 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-fft) 20:26:34 INFO - PROCESS | 27467 | RSS: Main: 271908864 20:26:34 INFO - PROCESS | 27467 | 20:26:36 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-oscillator) 20:26:37 INFO - PROCESS | 27467 | RSS: Main: 180764672 20:26:37 INFO - PROCESS | 27467 | 20:26:39 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:40 INFO - PROCESS | 27467 | RSS: Main: 184520704 20:26:40 INFO - PROCESS | 27467 | 20:26:43 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:43 INFO - PROCESS | 27467 | RSS: Main: 221163520 20:26:43 INFO - PROCESS | 27467 | 20:26:47 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:47 INFO - PROCESS | 27467 | RSS: Main: 221020160 20:26:47 INFO - PROCESS | 27467 | 20:26:50 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40373/tests/kraken/driver.html?testName=json-parse-financial) 20:26:51 INFO - PROCESS | 27467 | RSS: Main: 220737536 20:26:51 INFO - PROCESS | 27467 | 20:26:53 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:53 INFO - PROCESS | 27467 | RSS: Main: 185495552 20:26:53 INFO - PROCESS | 27467 | 20:26:55 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:56 INFO - PROCESS | 27467 | RSS: Main: 192020480 20:26:56 INFO - PROCESS | 27467 | 20:26:58 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:59 INFO - PROCESS | 27467 | RSS: Main: 195522560 20:26:59 INFO - PROCESS | 27467 | 20:27:01 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:02 INFO - PROCESS | 27467 | RSS: Main: 191180800 20:27:02 INFO - PROCESS | 27467 | 20:27:05 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:06 INFO - PROCESS | 27467 | RSS: Main: 193536000 20:27:06 INFO - PROCESS | 27467 | 20:27:07 INFO - PROCESS | 27467 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40373/tests/kraken/driver.html?testName=ai-astar) 20:27:08 INFO - PROCESS | 27467 | RSS: Main: 244359168 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | __start_tp_report 20:27:08 INFO - PROCESS | 27467 | _x_x_mozilla_page_load 20:27:08 INFO - PROCESS | 27467 | _x_x_mozilla_page_load_details 20:27:08 INFO - PROCESS | 27467 | |i|pagename|runs| 20:27:08 INFO - PROCESS | 27467 | |0;ai-astar;104;115;115;116;114;116;114;116;115;114 20:27:08 INFO - PROCESS | 27467 | |1;audio-beat-detection;150;121;126;185;123;122;143;121;174;121 20:27:08 INFO - PROCESS | 27467 | |2;audio-dft;162;161;161;161;162;160;162;162;162;161 20:27:08 INFO - PROCESS | 27467 | |3;audio-fft;75;78;76;118;75;76;74;75;102;76 20:27:08 INFO - PROCESS | 27467 | |4;audio-oscillator;85;86;126;85;85;85;124;86;85;126 20:27:08 INFO - PROCESS | 27467 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 20:27:08 INFO - PROCESS | 27467 | |6;imaging-darkroom;147;146;146;146;146;146;145;146;146;145 20:27:08 INFO - PROCESS | 27467 | |7;imaging-desaturate;95;94;94;98;94;95;94;95;94;95 20:27:08 INFO - PROCESS | 27467 | |8;json-parse-financial;64;62;62;64;70;64;64;62;64;64 20:27:08 INFO - PROCESS | 27467 | |9;json-stringify-tinderbox;64;66;69;65;65;65;66;65;65;65 20:27:08 INFO - PROCESS | 27467 | |10;stanford-crypto-aes;79;79;79;79;89;88;78;79;83;83 20:27:08 INFO - PROCESS | 27467 | |11;stanford-crypto-ccm;133;134;138;133;128;130;126;144;163;139 20:27:08 INFO - PROCESS | 27467 | |12;stanford-crypto-pbkdf2;172;164;165;167;168;168;164;166;169;166 20:27:08 INFO - PROCESS | 27467 | |13;stanford-crypto-sha256-iterative;67;67;70;66;72;67;68;67;66;67 20:27:08 INFO - PROCESS | 27467 | __end_tp_report 20:27:08 INFO - PROCESS | 27467 | __start_cc_report 20:27:08 INFO - PROCESS | 27467 | _x_x_mozilla_cycle_collect,1979 20:27:08 INFO - PROCESS | 27467 | __end_cc_report 20:27:08 INFO - PROCESS | 27467 | __startTimestamp1470281228032__endTimestamp 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | ------- Summary: start ------- 20:27:08 INFO - PROCESS | 27467 | Number of tests: 14 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:3.57 (3.1%) stddev-sans-first:0.87 20:27:08 INFO - PROCESS | 27467 | Values: 104.0 115.0 115.0 116.0 114.0 116.0 114.0 116.0 115.0 114.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:134.50 stddev:23.95 (17.8%) stddev-sans-first:25.04 20:27:08 INFO - PROCESS | 27467 | Values: 150.0 121.0 126.0 185.0 123.0 122.0 143.0 121.0 174.0 121.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 20:27:08 INFO - PROCESS | 27467 | Values: 162.0 161.0 161.0 161.0 162.0 160.0 162.0 162.0 162.0 161.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:15.01 (19.9%) stddev-sans-first:15.68 20:27:08 INFO - PROCESS | 27467 | Values: 75.0 78.0 76.0 118.0 75.0 76.0 74.0 75.0 102.0 76.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:19.36 (22.8%) stddev-sans-first:20.01 20:27:08 INFO - PROCESS | 27467 | Values: 85.0 86.0 126.0 85.0 85.0 85.0 124.0 86.0 85.0 126.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:27:08 INFO - PROCESS | 27467 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 20:27:08 INFO - PROCESS | 27467 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 20:27:08 INFO - PROCESS | 27467 | Values: 95.0 94.0 94.0 98.0 94.0 95.0 94.0 95.0 94.0 95.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:2.45 20:27:08 INFO - PROCESS | 27467 | Values: 64.0 62.0 62.0 64.0 70.0 64.0 64.0 62.0 64.0 64.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 20:27:08 INFO - PROCESS | 27467 | Values: 64.0 66.0 69.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:4.03 (5.0%) stddev-sans-first:4.17 20:27:08 INFO - PROCESS | 27467 | Values: 79.0 79.0 79.0 79.0 89.0 88.0 78.0 79.0 83.0 83.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:10.65 (7.8%) stddev-sans-first:11.21 20:27:08 INFO - PROCESS | 27467 | Values: 133.0 134.0 138.0 133.0 128.0 130.0 126.0 144.0 163.0 139.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.50 stddev:2.47 (1.5%) stddev-sans-first:1.80 20:27:08 INFO - PROCESS | 27467 | Values: 172.0 164.0 165.0 167.0 168.0 168.0 164.0 166.0 169.0 166.0 20:27:08 INFO - PROCESS | 27467 | 20:27:08 INFO - PROCESS | 27467 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:1.89 (2.8%) stddev-sans-first:1.99 20:27:08 INFO - PROCESS | 27467 | Values: 67.0 67.0 70.0 66.0 72.0 67.0 68.0 67.0 66.0 67.0 20:27:08 INFO - PROCESS | 27467 | -------- Summary: end -------- 20:27:08 INFO - PROCESS | 27467 | 20:27:09 INFO - TEST-INFO | 27467: exit 0 20:27:09 INFO - TEST-OK | kraken | took 63503ms 20:27:09 INFO - SUITE-END | took 1184s 20:27:09 INFO - Completed test suite (00:19:44) 20:27:09 INFO - javascript benchmark 20:27:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.7581917627417, 2696.1776658119265, 2722.795790315726, 2730.590411438284, 2736.2065001149667, 4710.105080034791, 4775.116603428364, 4807.495213002628, 4878.731669758166, 4879.878003049921, 4737.8815529611775, 4793.32893394925, 4818.445878723939, 4823.0, 4871.829485967992, 4332.436783218177, 4385.298352263639, 4464.218761716703, 4533.22935101032, 4596.839110631128, 4541.523140070294, 4566.13243483737, 4598.816047358102, 4613.792379342921, 4623.560761727647, 4343.109662519176, 4385.429894113745, 4460.420145381079, 4467.128909862578, 4534.478534968488, 4404.889877753049, 4442.178197033559, 4446.666500012512, 4490.146872094291, 4493.59557639814, 4389.736615803062, 4455.4207952966235, 4479.574440428154, 4481.35020422037, 4528.977355113237, 4746.715197088186, 4925.827596034157, 4946.431160416562, 4976.02967421353, 4985.850424487271, 5111.463296353903, 5174.922376164361, 5186.377634683824, 5251.737413129366, 5259.921101183485, 5203.765830537635, 5249.265102885599, 5250.606204534675, 5266.183741520071, 5287.920681189786, 4652.441706995182, 4758.452777930513, 4906.730129842857, 4913.06651736169, 4920.384951881015, 5242.68543887368, 5245.554127899095, 5300.416954135042, 5321.600879934021, 5324.281222034976, 5072.0, 5109.08036553424, 5111.258867464197, 5112.795488180431, 5118.232265160255, 4905.9264111038365, 5012.899742005139, 5199.714015729096, 5213.556847667991, 5214.530692237717, 4958.652894297436, 5036.7733451994745, 5069.923951140736, 5091.0, 5093.821716239914, 5012.0, 5027.1705168647495, 5030.89938201234, 5036.546710796046, 5085.74571271435, 4172.958270417318, 4251.489821221473, 4263.062126332202, 4264.1471705659, 4311.116221174651, 3704.9629503705155, 3772.7924964127237, 3820.331441997695, 3868.1490072184074, 3917.118648304109, 4463.575960283768, 4464.241079016575, 4481.484629267611, 4514.164879497303, 4527.366168736379, 5189.974050129726, 5203.141481655484, 5209.947900521022, 5211.088059589557, 5230.555402790806, 4337.934930976038, 4423.0, 4486.618637415856, 4487.64098872096, 4544.318352247189, 4653.511381304914, 4681.461631912373, 4682.906341873211, 4685.297205419146, 4730.030343779517, 4860.0, 4897.681650692693, 4912.263160525949, 4918.532739389752, 4957.876053098701, 4996.7001979881325, 5189.221616757516, 5251.579873610179, 5263.421023687468, 5265.894682106413, 4869.050535145754, 4901.779419926041, 4905.558499734898, 4907.631927605516, 4954.5540901319055, 5111.105556527667, 5145.202493613496, 5145.279660847559, 5150.304708864405, 5152.716600587004, 4912.533309335608, 5115.718635474936, 5157.174852023658, 5171.198464238049, 5241.371035475768, 5022.723750193774, 5026.648134630541, 5029.06962211992, 5031.597472202142, 5079.085764562415, 5030.899382012412, 5036.269740887624, 5036.420811606712, 5036.748162591929, 5042.218456139304, 4777.307290442797, 4873.756312184448, 4933.605311575137, 4934.5805606523845, 4996.050750357421, 5034.84895453137, 5048.217526283432, 5050.696958182521, 5052.216906379517, 5108.233764935141, 4895.877603059952, 4927.18701414277, 4935.851924442272, 4946.62900282473, 4992.750362481934], "value": 4746.8599262680855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3997203006768, 584.8216294030321, 587.905935050392, 590.0912594604309, 590.4420322794958, 30008.84995575022, 39493.407598886006, 40964.38553421701, 40977.38533921994, 45173.54826451735, 42196.0, 42695.0, 42755.572444275545, 42762.786186069105, 42797.0, 7711.768646940601, 7837.333826624744, 7852.0, 7855.253750893656, 7856.9607151964165, 7778.5721785301785, 7858.09631892334, 7862.764117076496, 7864.567448790314, 7869.449138560303, 7896.881546776803, 7935.365170786352, 7944.404169687267, 7948.0, 7949.64226609804, 7818.609069546556, 7825.178356272595, 7841.843163136706, 7869.331106855924, 7871.330936870373, 7725.729599463992, 7738.342240909529, 7783.754599264091, 7797.220277972214, 7803.02462192226, 39032.60967390318, 39464.80267598644, 39481.60518394808, 39492.0, 39541.60458395408, 3106.7359274461696, 3143.1199264206057, 3199.488081906907, 3275.4431746603136, 3518.9472157917394, 28841.711582884112, 28963.42073158525, 29501.704982950327, 29521.409571808657, 29632.851835740683, 3331.6501767314567, 3343.314620502791, 3366.8989930301886, 3398.7084907735148, 3478.4260597001467, 253357.0, 255690.0, 255930.72034639894, 256035.0, 256458.0, 32407.837960810517, 33477.83261083679, 48864.0, 48965.265521017216, 54188.93582981292, 34574.654253457644, 34598.0, 34835.477467838005, 34846.825765871516, 34864.651353486646, 12249.877501224873, 12421.31682757457, 12425.19236249641, 12434.937825310815, 12435.937820311021, 9986.700398988041, 10023.69928902134, 10126.139278161292, 10145.594176233015, 10150.543225554868, 8002.039245479094, 8027.678892844221, 8055.7583272501915, 8135.145809690016, 8155.34757219421, 3083.105899289226, 3096.8606412711483, 3128.2179455136215, 3149.1812128846664, 3161.4309424303847, 860.9139086091341, 910.1262787723726, 912.7581190984395, 966.9516524173763, 983.8327484327682, 28512.85743571269, 28648.418947631548, 29455.558166627517, 29764.0, 29948.0, 836.5357226739218, 918.2149262380568, 942.4863449420083, 950.1306304731094, 969.8981606931312, 15476.22618869052, 15647.608809779847, 15806.0, 15848.44530441429, 16136.354545818036, 408710.0, 411058.0, 411100.0, 411410.0, 411489.0, 48441.273380899314, 51938.480615193366, 52062.73968630133, 52140.0, 52144.478555213966, 1093.4423444043596, 1161.9535218591332, 1188.7622475504934, 1189.3161432176532, 1208.5769980506752, 28901.855490722413, 29704.0, 30046.399072018874, 30977.69022309748, 31027.224319392197, 48171.277430837865, 48849.267260990404, 48851.26723099085, 48914.35313645198, 49193.75403122961, 358641.0, 361873.0, 363102.0, 363151.0, 363511.0, 26017.349566260997, 26796.0, 26872.462550748485, 27895.234143390382, 27954.301142471602, 42309.0, 42734.78632606817, 42939.785301073294, 43404.78297608492, 43932.78033609811, 35958.0, 36535.0, 36641.26717465689, 36956.260874781816, 37109.257814844095, 36924.0, 37037.0, 37312.81343593264, 37475.625243747214, 37600.247995040496, 35957.460638090975, 36102.0, 36861.81569092137, 36883.0, 37330.81334593309, 31722.365552688356, 33433.99698009063, 33728.0, 33851.15372115717, 33966.0, 25359.36601584975, 25389.87305063463, 25508.489830203664, 25623.10319138821, 25656.615150773127], "value": 16750.43472422311, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.40197483675763, 363.7690066807576, 372.6385406156029, 374.4701247734455, 388.20611848769266, 12796.808047879278, 13299.46802127915, 14949.327280272386, 16887.24007419666, 16969.74545381817, 15510.767338489932, 16179.35282588695, 16634.085125318103, 16640.084795336283, 16642.0, 4856.417229932413, 5013.398392192924, 5016.974915125419, 5019.723915184663, 5025.497450254982, 3691.2617476504806, 5690.9146362804595, 5911.586188966774, 5992.670403127848, 5997.130416089664, 4903.313536104948, 5956.285245770514, 5957.1957785698805, 5967.104934259853, 5967.373425790294, 5114.386273647149, 5204.531592156686, 5209.400918894337, 5213.556847667953, 5216.973915130438, 4384.21084204843, 4646.628269738413, 4681.976590117061, 4718.952810471886, 5073.949260507385, 11570.42147892602, 11680.88319116815, 11784.705382365424, 11898.22661526998, 11913.702157446047, 1700.5578549577076, 1810.4297146398974, 1853.5551467647801, 1878.6618408686431, 1880.4170707080848, 8667.4366166199, 9069.727908162766, 9107.726768196899, 9115.270778337717, 9145.131212534865, 1727.9395221167324, 1730.368415528323, 1733.7052701040852, 1760.111143872349, 1853.527350525621, 68131.0, 69006.30993690049, 70960.0, 72107.0, 73686.0, 9779.266555008402, 9937.503124843728, 10128.34165779222, 10308.07227349527, 10433.373997560171, 14018.158910465405, 14111.576652700436, 14284.428622855177, 14312.85687143136, 14316.498922537661, 6772.356626120511, 7028.824279393056, 7037.2962703730245, 7189.676464559107, 7238.855222895512, 6354.3645635437015, 6506.0, 6642.900356494656, 6667.366600172976, 6715.56348837324, 4153.480814898137, 4230.661547076226, 4276.273033584298, 4334.523202447728, 4508.143452744033, 1800.8469280111076, 1811.9184636691116, 1870.9532261693294, 1897.354899334233, 1920.4430715092747, 796.2992566541407, 800.7998000499875, 820.7660816667221, 851.527402291734, 898.9011208767031, 17009.064501452292, 17372.47882563525, 17613.7357939631, 17693.026883521274, 17989.100544972698, 834.7120243515977, 849.8427790858711, 852.1720908650909, 874.7375787263795, 904.7738065483629, 9630.32587718867, 9889.554970026365, 9980.37482584531, 10020.749481262881, 10103.09072183507, 395777.0, 397092.0, 407059.0, 408766.0, 410402.0, 48317.275240871415, 64294.35705642977, 75877.0, 79198.62404127885, 79870.0, 886.2909672262293, 896.5338024227365, 905.9094090590888, 932.3100905330142, 956.1872408452898, 15063.0, 15300.540983770505, 15798.0, 15922.840771592137, 16167.27247273899, 37529.249415011, 37945.177624695156, 38977.80511097427, 39253.0, 39983.60016399799, 53871.46128538821, 53893.73053134709, 54642.72678636581, 55557.0, 56384.0, 6128.9693551531955, 6592.967035164794, 6836.829079273058, 7145.1068616422945, 7822.882656760267, 9494.382865113745, 12345.814812777995, 12568.554616219251, 12588.748225035632, 12605.243685378906, 8582.184692454206, 10106.039926206999, 10207.7448063799, 10311.639092631722, 10533.945880553218, 10581.418022008556, 10584.735381615214, 10781.245312828027, 10973.725656858323, 11284.21010529255, 10081.853558169678, 10110.747231319276, 10116.291859570054, 10318.690439286833, 10445.112165465716, 6840.623765692934, 6841.989524609156, 6888.517803753689, 7076.716931322895, 7101.857962840818, 9466.763330916507, 9661.033896610283, 9825.4104753715, 9846.556904939152, 10340.327878687862], "value": 7979.595975411668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.0559369285656, 1357.721667058253, 1408.9855304180992, 1475.778633205019, 1673.8409851064152, 6342.175517182765, 7116.110486189226, 7432.814179645512, 7452.776416707494, 7463.253674632534, 7283.890741638879, 7333.6333183340885, 7335.77992660221, 7342.669579868905, 7350.889736653954, 2110.672845708914, 2137.1237792505076, 2138.9358319250446, 2141.0365335598963, 2142.3251675722177, 2092.236333738182, 2126.6065777831072, 2149.3659370485666, 2158.838087143463, 2159.924402645908, 2120.4698825293676, 2138.080625331107, 2148.559545293211, 2152.0315857863948, 2159.838012149095, 2078.1687325069943, 2083.1459101768355, 2085.760137584182, 2085.9061342239634, 2087.0295312679523, 2017.535966727661, 2052.5894821035854, 2054.414491869825, 2057.1668474267944, 2062.8143467087884, 7299.817504562428, 7374.483786134972, 7499.100107987022, 7596.962015189889, 7609.048868891388, 4221.071364299849, 4378.43080399546, 4393.758343291118, 4400.493943196541, 4408.625266852321, 2704.945901081987, 2844.160972513093, 2878.928026799326, 2882.6252587163535, 2888.566714992768, 923.736735030513, 925.6343744221062, 936.7587945971546, 944.376711370499, 951.7525443384701, 10079.69760907174, 10136.79726405475, 10169.796604067951, 10196.184305255561, 10222.846657300146, 3909.765414075108, 3910.882673519799, 4002.639762421396, 4016.2971479990883, 4104.91790164195, 8403.201695838885, 8772.473651580925, 8772.824543509094, 8780.912190878009, 8790.120987901159, 4412.779361031936, 4420.491643460979, 4439.334099885043, 4446.666500012512, 4449.777511124431, 3400.1839558506276, 3493.406120959443, 3500.3524347995703, 3993.5008123984503, 3998.7400818946676, 3407.0289967359186, 3546.3261980224192, 3572.517710109154, 3576.9821150894077, 3636.3454578176184, 1189.916705830601, 1206.2099324942176, 1206.7284860906225, 1215.0401183065455, 1218.62831836289, 808.7452452477451, 812.4353574265947, 814.0963530481162, 836.7029704454952, 852.1478521478522, 4787.593054590329, 4949.257611358253, 5041.042201981685, 5081.2632168335385, 5199.376074871039, 385.44880820427056, 849.2526576612541, 899.3749344205714, 905.5336501701629, 975.6097560975667, 3284.523744057098, 3313.4532802087388, 3414.7438942079443, 3423.1613254752747, 3565.9286814264087, 8975.461472311683, 9315.906840931639, 9332.4867132307, 9337.253019758404, 9361.953190234006, 9179.0, 9200.907990920005, 9221.95389023064, 9245.260379169651, 9279.582418791171, 6989.33601307875, 6995.8600827983155, 7003.684834182576, 7077.752278670222, 7078.398336141486, 4730.787114579921, 4772.689775164603, 4815.686980346266, 4838.854834354975, 4934.753262336941, 8463.915360846313, 8504.404691671523, 8526.616302266537, 8553.786155346166, 8582.957085214533, 8393.328533717166, 8634.611442484978, 8752.081031491602, 8779.341549383695, 8780.912190878265, 5530.419305972815, 5963.194968679173, 6042.093685947143, 6125.0, 6242.625442473284, 7162.319579639926, 7246.239144889922, 7250.274972502708, 7252.347288744038, 7260.310270524292, 6428.871422571616, 6437.163168788027, 6589.835254118685, 6629.403353697998, 6728.663566821737, 6245.469135123383, 6275.497960163268, 6322.146510221061, 6347.746090156342, 6578.177727784027, 6148.50811935053, 6245.7189426476825, 6248.750049998131, 6248.937510624835, 6249.281332646804, 4205.432266643964, 4258.616724494686, 4259.318509038539, 4422.955770442383, 4428.623566996841, 4328.502222244482, 4454.5990860822685, 4530.252508336088, 4543.840965566189, 4576.81692732287], "value": 3967.6001322880484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.9972100278997, 283.83395713507605, 284.85472409071366, 294.2892913613625, 294.7965903526565, 4897.865366165657, 4942.975285123578, 4955.578775804056, 4967.218357719679, 4972.651914365996, 4850.563449289563, 4856.980034192824, 4913.434954980178, 4915.100090946341, 4928.433230178531, 3657.6708096271395, 3769.5288088988877, 3773.603771603983, 3776.7545109567927, 3783.6216378362083, 3673.8897833065053, 3767.227718317752, 3815.882185387109, 3823.5220597425323, 3863.4011728182177, 3764.2659681362147, 3769.3403654360513, 3780.206156707095, 3795.235215624734, 3811.7331786774935, 3566.946495802565, 3733.4773131761576, 3766.510353654021, 3791.090138366772, 3792.374258247386, 3250.089974807058, 3250.1062207892783, 3256.348730253959, 3262.429074911881, 3276.5249038889465, 4676.830792301925, 4692.272697731857, 4704.976475117603, 4711.505291944331, 4747.6914000590195, 4262.978685106555, 4264.914701705949, 4273.978630106861, 4287.056847493546, 4288.957110428887, 4888.0, 5008.1486147355035, 5020.121478741242, 5021.774020169101, 5083.517065878736, 3540.132667496454, 3557.4130268505664, 3564.518789963374, 3574.8212589370687, 3578.6779189873037, 5298.602604804655, 5321.5742740581045, 5341.973290133564, 5356.812511562116, 5379.704116273564, 3538.3100295442655, 3604.5494313210847, 3628.7097032237357, 3629.364861149288, 3650.6714395703984, 3648.945265821015, 3658.725595580342, 3665.303592317451, 3673.2837096765875, 3679.889603311905, 4195.853145139906, 4196.559361267084, 4209.221294060548, 4222.704410691222, 4241.406203131564, 4932.90134197314, 5055.7219352935945, 5055.848324550269, 5058.0, 5088.313077734459, 1253.7241806802672, 1265.7784887644625, 1269.162352847135, 1270.805442883705, 1271.3706715175863, 785.4148659248896, 796.3231253434534, 810.0846043970275, 810.9498199831232, 812.6099472253352, 4290.806913688892, 4337.978310108492, 4453.131639330364, 4514.45826500822, 4517.977410112929, 5225.817096401684, 5226.294450249244, 5235.764390602432, 5276.604254680914, 5287.286216360819, 4462.598366147063, 4475.283954567253, 4475.5300693426725, 4487.596116349544, 4488.214562451623, 2623.921282361532, 2741.588082137701, 2758.5310497215523, 2763.69599344072, 2765.0, 4884.194107972145, 4910.779014944336, 4916.7541622919425, 4924.064427758714, 4929.901401971941, 5064.037832811754, 5324.547413469899, 5338.199270109515, 5349.251104845324, 5353.973230133903, 4868.902621947541, 4903.975480122576, 4904.337914381513, 4909.533594308535, 4914.23087688439, 5197.636165468381, 5211.270422140828, 5231.293775340432, 5234.377343023675, 5235.188545775411, 4957.826476073465, 5124.461931497139, 5131.384233891957, 5142.357205349332, 5151.253068305, 4821.228603423436, 4864.975675121602, 4883.267509873547, 4890.24201248807, 4906.386701662293, 3632.9636703632627, 3643.2349206666895, 3651.4705367721, 3656.0859785053735, 3661.7436779425184, 4994.625403094709, 5254.238135470259, 5273.918846636354, 5277.973610131925, 5280.260763493037, 4931.580815630711, 4998.300237966615, 4998.400191976986, 5004.799808007639, 5008.248762685481, 5003.499650035113, 5006.49935006511, 5013.222950442541, 5019.598432125348, 5030.37120359955, 4828.5412885775795, 4931.630127740362, 4952.034353301072, 4966.478519755518, 4996.175631020987, 4873.4639189689815, 4952.826651067196, 5049.469805670498, 5052.72210028452, 5059.924101138412, 4959.330490383896, 4966.5033496651495, 4993.750312484434, 5007.474215207497, 5010.624203184703], "value": 3791.3463845127153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.5541259649735, 685.9794206173814, 686.7356067913853, 704.8132244955091, 746.0562388578446, 12577.245365278079, 13758.17450952941, 13788.310584470773, 13791.241481718514, 13836.584902452918, 13545.864541354584, 13629.114107583, 13631.863681363184, 13680.521181758615, 13682.11066280691, 629.4586655476287, 643.5302229372561, 764.3083009876071, 768.404486522945, 776.596169991604, 773.7407968330588, 774.6359211170741, 777.0364747712852, 777.2538363171362, 777.2771322669914, 834.4409245805325, 835.9122292159327, 836.1930736838949, 836.523181786382, 836.5440834745078, 654.8362909272682, 672.5225090185974, 674.0193019157115, 677.0352248046514, 830.4228561150003, 590.8463799412141, 600.9098635204755, 602.9668368239745, 608.996955015222, 609.34495417426, 12638.873611263862, 12649.43077561512, 12654.557090501788, 12655.746885062339, 12663.746725065446, 12656.36718164088, 13153.736925261537, 13516.864831351659, 13526.188428694211, 13682.589522314247, 12025.398730063462, 12159.696007599792, 12239.755204895851, 12393.256404615662, 12608.432620532098, 4150.398192262105, 4184.560621134768, 4198.181354635847, 4219.620234178908, 4270.957290427087, 67070.66464667695, 69204.3079569203, 69429.0, 69581.0, 69732.99999999949, 10388.065074143364, 10456.372617642966, 10545.420001899969, 10560.419176945188, 10704.839427408595, 20152.0, 20174.495637608885, 20183.192672293237, 20202.494937626383, 20206.595868082557, 6967.477439192081, 7061.258567850405, 7095.574265544084, 7435.51669141504, 7520.9623951880985, 3795.7912314822397, 3950.111224974358, 3966.841326346914, 3979.6617287530885, 3986.740861843971, 2658.853763043051, 2751.7385848344375, 3177.9841100794347, 3381.9323613528086, 3391.2878295557716, 541.8916216756664, 547.667443605664, 550.4550495009992, 551.5311984812957, 557.6263903184876, 553.7286729502515, 580.6487075319455, 615.5506480269339, 628.7233617208414, 641.2426565767275, 8115.391345648982, 8380.371472139492, 8456.154384561618, 8496.660133594587, 8587.699430519902, 559.5859064292475, 579.39163877928, 581.2734082397004, 585.7920438244447, 594.1058706646555, 3852.5954774748247, 3942.3495123304906, 3993.820278087493, 4049.190161967618, 4196.769177695195, 97248.0, 102074.0, 103204.48397757963, 107093.46453267684, 107219.0, 70202.2979770206, 71483.8516148381, 71992.28007719856, 82934.0, 86633.0, 47242.0, 74605.25394746092, 75496.86754698683, 76504.0, 77605.2239477598, 8170.387220958333, 8251.0, 8308.14956663994, 8337.791555211168, 8441.66233350659, 31965.520517192726, 40765.388519172826, 43121.56878431301, 43951.560484394744, 43999.78000110107, 59017.704911475164, 60941.39058609357, 61625.38374616196, 62135.0, 64522.35477645163, 11308.208425410472, 11338.319700817978, 11455.828162577402, 11497.82753258685, 11503.0, 12442.875571244173, 12530.310832904277, 12734.044946629225, 13057.608271751862, 13490.460381585019, 11932.701682458008, 12294.81557776652, 12299.69250768738, 12738.936305318413, 13113.278769667379, 11546.711332216762, 12256.571020014257, 12431.44058517387, 12952.870471295166, 13051.804222936473, 12177.878221217674, 12345.814812777637, 12705.936470317589, 12925.28910909909, 12942.741145177231, 10188.0, 10451.0, 10641.840372394576, 10913.181511386836, 11013.944930275296, 9259.907400925904, 9851.704448866545, 10299.227557933335, 10511.159107271553, 10728.356298622108], "value": 6736.302261799424, "unit": "score"}], "name": "dromaeo_css", "value": 6329.472123874008, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 116.0, 114.0, 116.0, 114.0, 116.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 126.0, 185.0, 123.0, 122.0, 143.0, 121.0, 174.0, 121.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 118.0, 75.0, 76.0, 74.0, 75.0, 102.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 126.0, 85.0, 85.0, 85.0, 124.0, 86.0, 85.0, 126.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 98.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 64.0, 70.0, 64.0, 64.0, 62.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 69.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 89.0, 88.0, 78.0, 79.0, 83.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 138.0, 133.0, 128.0, 130.0, 126.0, 144.0, 163.0, 139.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 164.0, 165.0, 167.0, 168.0, 168.0, 164.0, 166.0, 169.0, 166.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 66.0, 72.0, 67.0, 68.0, 67.0, 66.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1533.7999999999997, "alertThreshold": 2.0}]} 20:27:09 INFO - Return code: 0 20:27:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:09 INFO - # TBPL SUCCESS # 20:27:09 INFO - Running post-action listener: _resource_record_post_action 20:27:09 INFO - [mozharness: 2016-08-04 03:27:09.333819Z] Finished run-tests step (success) 20:27:09 INFO - Running post-run listener: _resource_record_post_run 20:27:09 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522514432; Read time: 4; Write time: 396068 20:27:09 INFO - TinderboxPrint: CPU usage
13.0% 20:27:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 20:27:09 INFO - TinderboxPrint: I/O write bytes / time
522,514,432 / 396,068 20:27:09 INFO - TinderboxPrint: CPU idle
8,333.2 (87.0%) 20:27:09 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 20:27:09 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237596672; Read time: 0; Write time: 229904 20:27:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 284917760; Read time: 0; Write time: 166164 20:27:09 INFO - Running post-run listener: _upload_blobber_files 20:27:09 INFO - Blob upload gear active. 20:27:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:10 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:13 INFO - (blobuploader) - INFO - Done attempting. 20:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:15 INFO - (blobuploader) - INFO - Done attempting. 20:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:15 INFO - (blobuploader) - INFO - Done attempting. 20:27:15 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:15 INFO - Return code: 0 20:27:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84ffaa3cfebb7c8f30ffe4b69bbc7758a850fcd2e0d43246cc625534af7be841012baa16ba4520bc824ac6c22e1fd78baa1bd4d18bb4654c4ef1ce0c9d16f83e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5108bb173a0aca72ff485d51d8354035c7140cd82419801ca2ec72181263dc8f3bb8d2b59472deb75197e0a2724f378df0e8dd6ac1c1b812f760ac9c387de2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2886457ff6983cc6249127c67b7d848808bb0d00de91a1edfc10ce6b722f2fe72c922d932a0a5e6711b461c186d4a96ef012368b6d6e2513571f0cc2dbb7403"} 20:27:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:15 INFO - Contents: 20:27:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84ffaa3cfebb7c8f30ffe4b69bbc7758a850fcd2e0d43246cc625534af7be841012baa16ba4520bc824ac6c22e1fd78baa1bd4d18bb4654c4ef1ce0c9d16f83e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5108bb173a0aca72ff485d51d8354035c7140cd82419801ca2ec72181263dc8f3bb8d2b59472deb75197e0a2724f378df0e8dd6ac1c1b812f760ac9c387de2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2886457ff6983cc6249127c67b7d848808bb0d00de91a1edfc10ce6b722f2fe72c922d932a0a5e6711b461c186d4a96ef012368b6d6e2513571f0cc2dbb7403"} 20:27:15 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:15 INFO - Copying logs to upload dir... 20:27:15 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.607093 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 20:27:15.691957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 20:27:15.695363) ========= 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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 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/84ffaa3cfebb7c8f30ffe4b69bbc7758a850fcd2e0d43246cc625534af7be841012baa16ba4520bc824ac6c22e1fd78baa1bd4d18bb4654c4ef1ce0c9d16f83e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5108bb173a0aca72ff485d51d8354035c7140cd82419801ca2ec72181263dc8f3bb8d2b59472deb75197e0a2724f378df0e8dd6ac1c1b812f760ac9c387de2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2886457ff6983cc6249127c67b7d848808bb0d00de91a1edfc10ce6b722f2fe72c922d932a0a5e6711b461c186d4a96ef012368b6d6e2513571f0cc2dbb7403"} build_url:https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/L5D7WFL9R0m4jMfEDKvnQA/artifacts/public/build/firefox-51.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/84ffaa3cfebb7c8f30ffe4b69bbc7758a850fcd2e0d43246cc625534af7be841012baa16ba4520bc824ac6c22e1fd78baa1bd4d18bb4654c4ef1ce0c9d16f83e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5108bb173a0aca72ff485d51d8354035c7140cd82419801ca2ec72181263dc8f3bb8d2b59472deb75197e0a2724f378df0e8dd6ac1c1b812f760ac9c387de2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2886457ff6983cc6249127c67b7d848808bb0d00de91a1edfc10ce6b722f2fe72c922d932a0a5e6711b461c186d4a96ef012368b6d6e2513571f0cc2dbb7403"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 20:27:15.721023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:27:15.721381) ========= 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=523ca41ca1e0623de333ad52000001bf-1470279995.404650-1067477265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 20:27:15.806918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 20:27:15.807242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 20:27:15.807612) ========= ========= Total master_lag: 0.23 =========