builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1470179894.37 results: success (0) buildid: 20160802161810 builduid: d6a6c1c5a807430b9fd3d64e3dc4a502 revision: 73a57814a495b29244ef5377e73488a3f3fabb15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.371206) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.371867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.372367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.391961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.392242) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 16:18:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-08-02 16:18:14 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.521019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.521384) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015392 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.574624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:14.575234) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 73a57814a495b29244ef5377e73488a3f3fabb15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 73a57814a495b29244ef5377e73488a3f3fabb15 --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=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 16:18:14,913 truncating revision to first 12 chars 2016-08-02 16:18:14,914 Setting DEBUG logging. 2016-08-02 16:18:14,914 attempt 1/10 2016-08-02 16:18:14,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/73a57814a495?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 16:18:15,248 unpacking tar archive at: mozilla-inbound-73a57814a495/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:15.250358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:15.250668) ========= script_repo_revision: 73a57814a495b29244ef5377e73488a3f3fabb15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:15.251078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:15.251347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 16:18:15.261413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-02 16:18:15.261763) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:18:15 INFO - MultiFileLogger online at 20160802 16:18:15 in /builds/slave/test 16:18:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:18:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:15 INFO - {'append_to_log': False, 16:18:15 INFO - 'base_work_dir': '/builds/slave/test', 16:18:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:18:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:15 INFO - 'branch': 'Mozilla-Inbound', 16:18:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:15 INFO - 'config_files': ('talos/linux_config.py',), 16:18:15 INFO - 'default_actions': ('clobber', 16:18:15 INFO - 'read-buildbot-config', 16:18:15 INFO - 'download-and-extract', 16:18:15 INFO - 'populate-webroot', 16:18:15 INFO - 'create-virtualenv', 16:18:15 INFO - 'install', 16:18:15 INFO - 'run-tests'), 16:18:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:15 INFO - 'download_minidump_stackwalk': True, 16:18:15 INFO - 'download_symbols': 'ondemand', 16:18:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:15 INFO - 'installer_path': 'installer.exe', 16:18:15 INFO - 'log_level': 'info', 16:18:15 INFO - 'log_name': 'talos', 16:18:15 INFO - 'log_to_console': True, 16:18:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:18:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:18:15 INFO - 'opt_config_files': (), 16:18:15 INFO - 'pip_index': False, 16:18:15 INFO - 'sps_profile': False, 16:18:15 INFO - 'sps_profile_interval': 0, 16:18:15 INFO - 'suite': 'dromaeojs-e10s', 16:18:15 INFO - 'system_bits': '32', 16:18:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:15 INFO - 'title': 'talos-linux64-ix-061', 16:18:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:15 INFO - 'use_talos_json': True, 16:18:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:15 INFO - 'work_dir': 'build'} 16:18:15 INFO - [mozharness: 2016-08-02 23:18:15.688949Z] Running clobber step. 16:18:15 INFO - Running pre-action listener: _resource_record_pre_action 16:18:15 INFO - Running main action method: clobber 16:18:15 INFO - rmtree: /builds/slave/test/build 16:18:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:16 INFO - Running post-action listener: _resource_record_post_action 16:18:16 INFO - [mozharness: 2016-08-02 23:18:16.154626Z] Finished clobber step (success) 16:18:16 INFO - [mozharness: 2016-08-02 23:18:16.154726Z] Running read-buildbot-config step. 16:18:16 INFO - Running pre-action listener: _resource_record_pre_action 16:18:16 INFO - Running main action method: read_buildbot_config 16:18:16 INFO - Using buildbot properties: 16:18:16 INFO - { 16:18:16 INFO - "project": "", 16:18:16 INFO - "product": "firefox", 16:18:16 INFO - "script_repo_revision": "production", 16:18:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:18:16 INFO - "repository": "", 16:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:18:16 INFO - "buildid": "20160802161810", 16:18:16 INFO - "stage_platform": "linux64-pgo", 16:18:16 INFO - "basedir": "/builds/slave/test", 16:18:16 INFO - "buildnumber": 1115, 16:18:16 INFO - "platform": "ubuntu64_hw", 16:18:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:18:16 INFO - "slavebuilddir": "test", 16:18:16 INFO - "branch": "mozilla-inbound", 16:18:16 INFO - "revision": "73a57814a495b29244ef5377e73488a3f3fabb15", 16:18:16 INFO - "slavename": "talos-linux64-ix-061", 16:18:16 INFO - "builduid": "d6a6c1c5a807430b9fd3d64e3dc4a502", 16:18:16 INFO - "repo_path": "integration/mozilla-inbound" 16:18:16 INFO - } 16:18:16 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:18:16 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 16:18:16 INFO - Running post-action listener: _resource_record_post_action 16:18:16 INFO - [mozharness: 2016-08-02 23:18:16.157094Z] Finished read-buildbot-config step (success) 16:18:16 INFO - [mozharness: 2016-08-02 23:18:16.157201Z] Running download-and-extract step. 16:18:16 INFO - Running pre-action listener: _resource_record_pre_action 16:18:16 INFO - Running main action method: download_and_extract 16:18:16 INFO - mkdir: /builds/slave/test/build/tests 16:18:16 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')]} 16:18:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:18:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:16 INFO - Downloaded 1361 bytes. 16:18:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:18:16 INFO - Using the following test package requirements: 16:18:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:18:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:18:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'jsshell-linux-x86_64.zip'], 16:18:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:18:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:18:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:18:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:18:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:18:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:18:16 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')]} 16:18:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:18:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:22 INFO - Downloaded 21811128 bytes. 16:18:22 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'] 16:18:22 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 16:18:23 INFO - Return code: 0 16:18:23 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 16:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:18:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:23 INFO - Downloaded 21811128 bytes. 16:18:23 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'] 16:18:23 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 16:18:25 INFO - Return code: 0 16:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:31 INFO - Downloaded 14413723 bytes. 16:18:31 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'] 16:18:31 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 16:18:31 INFO - Return code: 0 16:18:31 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')]} 16:18:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:18:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/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 16:18:44 INFO - Downloaded 59398441 bytes. 16:18:44 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:18:44 INFO - mkdir: /builds/slave/test/properties 16:18:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:44 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:44 INFO - Contents: 16:18:44 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:18:44 INFO - Running post-action listener: _resource_record_post_action 16:18:44 INFO - Running post-action listener: set_extra_try_arguments 16:18:44 INFO - [mozharness: 2016-08-02 23:18:44.299527Z] Finished download-and-extract step (success) 16:18:44 INFO - [mozharness: 2016-08-02 23:18:44.299760Z] Running populate-webroot step. 16:18:44 INFO - Running pre-action listener: _resource_record_pre_action 16:18:44 INFO - Running main action method: populate_webroot 16:18:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:44 INFO - '--tppagecycles', 16:18:44 INFO - '7'], 16:18:44 INFO - 'tests': ['tsvgm']}}, 16:18:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['damp', 'tps']}, 16:18:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'tests': ['damp', 'tps']}, 16:18:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['dromaeo_dom']}, 16:18:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['basic_compositor_video']}, 16:18:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:18:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['a11yr', 16:18:44 INFO - 'ts_paint', 16:18:44 INFO - 'tpaint', 16:18:44 INFO - 'sessionrestore', 16:18:44 INFO - 'sessionrestore_no_auto_restore', 16:18:44 INFO - 'tabpaint']}, 16:18:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['tsvgx', 16:18:44 INFO - 'tsvgr_opacity', 16:18:44 INFO - 'tart', 16:18:44 INFO - 'tscrollx', 16:18:44 INFO - 'cart']}, 16:18:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:44 INFO - 'tsvgr_opacity', 16:18:44 INFO - 'tart', 16:18:44 INFO - 'tscrollx', 16:18:44 INFO - 'cart']}, 16:18:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'talos_options': ['--disable-e10s'], 16:18:44 INFO - 'tests': ['tp5o']}, 16:18:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'tests': ['tp5o']}, 16:18:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'talos_options': ['--disable-e10s', 16:18:44 INFO - '--xperf_path', 16:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:44 INFO - 'tests': ['tp5n']}, 16:18:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:44 INFO - 'talos_options': ['--xperf_path', 16:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:44 INFO - 'tests': ['tp5n']}}, 16:18:44 INFO - 'talos.zip': {'path': '', 16:18:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:44 INFO - Running post-action listener: _resource_record_post_action 16:18:44 INFO - [mozharness: 2016-08-02 23:18:44.318952Z] Finished populate-webroot step (success) 16:18:44 INFO - [mozharness: 2016-08-02 23:18:44.319042Z] Running create-virtualenv step. 16:18:44 INFO - Running pre-action listener: _resource_record_pre_action 16:18:44 INFO - Running main action method: create_virtualenv 16:18:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:44 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 16:18:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:44 INFO - Using real prefix '/usr' 16:18:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:46 INFO - Installing pip.................done. 16:18:46 INFO - Return code: 0 16:18:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:46 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')]} 16:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:46 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')]} 16:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:46 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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18:46 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 16:18:46 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 16:18:46 INFO - Using env: {'DISPLAY': ':0', 16:18:46 INFO - 'HOME': '/home/cltbld', 16:18:46 INFO - 'LANG': 'en_US.UTF-8', 16:18:46 INFO - 'LANGUAGE': 'en_US:en', 16:18:46 INFO - 'LOGNAME': 'cltbld', 16:18:46 INFO - 'MAIL': '/var/mail/cltbld', 16:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:46 INFO - 'MOZ_NO_REMOTE': '1', 16:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:46 INFO - 'NO_EM_RESTART': '1', 16:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:46 INFO - 'PWD': '/builds/slave/test', 16:18:46 INFO - 'SHELL': '/bin/bash', 16:18:46 INFO - 'SHLVL': '1', 16:18:46 INFO - 'TERM': 'linux', 16:18:46 INFO - 'TMOUT': '86400', 16:18:46 INFO - 'USER': 'cltbld', 16:18:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:46 INFO - '_': '/tools/buildbot/bin/python'} 16:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:47 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 16:18:47 INFO - Cleaning up... 16:18:47 INFO - Return code: 0 16:18:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:18:47 INFO - Using env: {'DISPLAY': ':0', 16:18:47 INFO - 'HOME': '/home/cltbld', 16:18:47 INFO - 'LANG': 'en_US.UTF-8', 16:18:47 INFO - 'LANGUAGE': 'en_US:en', 16:18:47 INFO - 'LOGNAME': 'cltbld', 16:18:47 INFO - 'MAIL': '/var/mail/cltbld', 16:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:47 INFO - 'MOZ_NO_REMOTE': '1', 16:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:47 INFO - 'NO_EM_RESTART': '1', 16:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:47 INFO - 'PWD': '/builds/slave/test', 16:18:47 INFO - 'SHELL': '/bin/bash', 16:18:47 INFO - 'SHLVL': '1', 16:18:47 INFO - 'TERM': 'linux', 16:18:47 INFO - 'TMOUT': '86400', 16:18:47 INFO - 'USER': 'cltbld', 16:18:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:47 INFO - '_': '/tools/buildbot/bin/python'} 16:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:47 INFO - Downloading/unpacking psutil>=3.1.1 16:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:49 INFO - Installing collected packages: psutil 16:18:49 INFO - Running setup.py install for psutil 16:18:49 INFO - building 'psutil._psutil_linux' extension 16:18:49 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 16:18:49 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 16:18:49 INFO - building 'psutil._psutil_posix' extension 16:18:49 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 16:18:49 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 16:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:49 INFO - Successfully installed psutil 16:18:49 INFO - Cleaning up... 16:18:49 INFO - Return code: 0 16:18:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:18: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 mozsystemmonitor==0.3 16:18:49 INFO - Using env: {'DISPLAY': ':0', 16:18:49 INFO - 'HOME': '/home/cltbld', 16:18:49 INFO - 'LANG': 'en_US.UTF-8', 16:18:49 INFO - 'LANGUAGE': 'en_US:en', 16:18:49 INFO - 'LOGNAME': 'cltbld', 16:18:49 INFO - 'MAIL': '/var/mail/cltbld', 16:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:49 INFO - 'MOZ_NO_REMOTE': '1', 16:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:49 INFO - 'NO_EM_RESTART': '1', 16:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:49 INFO - 'PWD': '/builds/slave/test', 16:18:49 INFO - 'SHELL': '/bin/bash', 16:18:49 INFO - 'SHLVL': '1', 16:18:49 INFO - 'TERM': 'linux', 16:18:49 INFO - 'TMOUT': '86400', 16:18:49 INFO - 'USER': 'cltbld', 16:18:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:49 INFO - '_': '/tools/buildbot/bin/python'} 16:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:18:51 INFO - Installing collected packages: mozsystemmonitor 16:18:51 INFO - Running setup.py install for mozsystemmonitor 16:18:52 INFO - Successfully installed mozsystemmonitor 16:18:52 INFO - Cleaning up... 16:18:52 INFO - Return code: 0 16:18:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', '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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:18: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 jsonschema==2.5.1 16:18:52 INFO - Using env: {'DISPLAY': ':0', 16:18:52 INFO - 'HOME': '/home/cltbld', 16:18:52 INFO - 'LANG': 'en_US.UTF-8', 16:18:52 INFO - 'LANGUAGE': 'en_US:en', 16:18:52 INFO - 'LOGNAME': 'cltbld', 16:18:52 INFO - 'MAIL': '/var/mail/cltbld', 16:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:52 INFO - 'MOZ_NO_REMOTE': '1', 16:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:52 INFO - 'NO_EM_RESTART': '1', 16:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:52 INFO - 'PWD': '/builds/slave/test', 16:18:52 INFO - 'SHELL': '/bin/bash', 16:18:52 INFO - 'SHLVL': '1', 16:18:52 INFO - 'TERM': 'linux', 16:18:52 INFO - 'TMOUT': '86400', 16:18:52 INFO - 'USER': 'cltbld', 16:18:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:52 INFO - '_': '/tools/buildbot/bin/python'} 16:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:18:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:18:54 INFO - warning: no files found matching '*.txt' 16:18:54 INFO - no previously-included directories found matching 'build' 16:18:54 INFO - no previously-included directories found matching 'dist' 16:18:54 INFO - no previously-included directories found matching '.git*' 16:18:54 INFO - Installing collected packages: jsonschema, functools32 16:18:54 INFO - Running setup.py install for functools32 16:18:54 INFO - warning: no files found matching '*.txt' 16:18:54 INFO - no previously-included directories found matching 'build' 16:18:54 INFO - no previously-included directories found matching 'dist' 16:18:54 INFO - no previously-included directories found matching '.git*' 16:18:54 INFO - Successfully installed jsonschema functools32 16:18:54 INFO - Cleaning up... 16:18:54 INFO - Return code: 0 16:18:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', '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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:18: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 functools32==3.2.3-2 16:18:54 INFO - Using env: {'DISPLAY': ':0', 16:18:54 INFO - 'HOME': '/home/cltbld', 16:18:54 INFO - 'LANG': 'en_US.UTF-8', 16:18:54 INFO - 'LANGUAGE': 'en_US:en', 16:18:54 INFO - 'LOGNAME': 'cltbld', 16:18:54 INFO - 'MAIL': '/var/mail/cltbld', 16:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:54 INFO - 'MOZ_NO_REMOTE': '1', 16:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:54 INFO - 'NO_EM_RESTART': '1', 16:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:54 INFO - 'PWD': '/builds/slave/test', 16:18:54 INFO - 'SHELL': '/bin/bash', 16:18:54 INFO - 'SHLVL': '1', 16:18:54 INFO - 'TERM': 'linux', 16:18:54 INFO - 'TMOUT': '86400', 16:18:54 INFO - 'USER': 'cltbld', 16:18:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:54 INFO - '_': '/tools/buildbot/bin/python'} 16:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:18:54 INFO - Cleaning up... 16:18:54 INFO - Return code: 0 16:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', '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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:18: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 blobuploader==1.2.4 16:18:54 INFO - Using env: {'DISPLAY': ':0', 16:18:54 INFO - 'HOME': '/home/cltbld', 16:18:54 INFO - 'LANG': 'en_US.UTF-8', 16:18:54 INFO - 'LANGUAGE': 'en_US:en', 16:18:54 INFO - 'LOGNAME': 'cltbld', 16:18:54 INFO - 'MAIL': '/var/mail/cltbld', 16:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:54 INFO - 'MOZ_NO_REMOTE': '1', 16:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:54 INFO - 'NO_EM_RESTART': '1', 16:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:54 INFO - 'PWD': '/builds/slave/test', 16:18:54 INFO - 'SHELL': '/bin/bash', 16:18:54 INFO - 'SHLVL': '1', 16:18:54 INFO - 'TERM': 'linux', 16:18:54 INFO - 'TMOUT': '86400', 16:18:54 INFO - 'USER': 'cltbld', 16:18:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:54 INFO - '_': '/tools/buildbot/bin/python'} 16:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:18:55 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 16:18:55 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 16:18:55 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 16:18:55 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 16:18:55 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 16:18:55 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 16:18:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:57 INFO - Downloading docopt-0.6.1.tar.gz 16:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:57 INFO - Running setup.py install for blobuploader 16:18:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:57 INFO - Running setup.py install for requests 16:18:58 INFO - Running setup.py install for docopt 16:18:58 INFO - Successfully installed blobuploader requests docopt 16:18:58 INFO - Cleaning up... 16:18:58 INFO - Return code: 0 16:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:58 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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:18:58 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 16:18:58 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 16:18:58 INFO - Using env: {'DISPLAY': ':0', 16:18:58 INFO - 'HOME': '/home/cltbld', 16:18:58 INFO - 'LANG': 'en_US.UTF-8', 16:18:58 INFO - 'LANGUAGE': 'en_US:en', 16:18:58 INFO - 'LOGNAME': 'cltbld', 16:18:58 INFO - 'MAIL': '/var/mail/cltbld', 16:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:58 INFO - 'MOZ_NO_REMOTE': '1', 16:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:58 INFO - 'NO_EM_RESTART': '1', 16:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:58 INFO - 'PWD': '/builds/slave/test', 16:18:58 INFO - 'SHELL': '/bin/bash', 16:18:58 INFO - 'SHLVL': '1', 16:18:58 INFO - 'TERM': 'linux', 16:18:58 INFO - 'TMOUT': '86400', 16:18:58 INFO - 'USER': 'cltbld', 16:18:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:58 INFO - '_': '/tools/buildbot/bin/python'} 16:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:58 INFO - Running setup.py (path:/tmp/pip-VGgoku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:58 INFO - Running setup.py (path:/tmp/pip-WteMha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:58 INFO - Running setup.py (path:/tmp/pip-KwSKI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:58 INFO - Running setup.py (path:/tmp/pip-uLvVbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:58 INFO - Running setup.py (path:/tmp/pip-rUCdUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:58 INFO - Running setup.py (path:/tmp/pip-xLsIck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:58 INFO - Running setup.py (path:/tmp/pip-bxJoWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:59 INFO - Running setup.py (path:/tmp/pip-kICHyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:59 INFO - Running setup.py (path:/tmp/pip-O86gQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:59 INFO - Running setup.py (path:/tmp/pip-gu9gUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:59 INFO - Running setup.py (path:/tmp/pip-sVShnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:59 INFO - Running setup.py (path:/tmp/pip-8rTjnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:59 INFO - Running setup.py (path:/tmp/pip-8712AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:59 INFO - Running setup.py (path:/tmp/pip-r5Mu2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:59 INFO - Running setup.py (path:/tmp/pip-4oqjs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:59 INFO - Running setup.py (path:/tmp/pip-CL73ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:59 INFO - Running setup.py (path:/tmp/pip-FI9rzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:59 INFO - Running setup.py install for manifestparser 16:18:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:59 INFO - Running setup.py install for mozcrash 16:18:59 INFO - Running setup.py install for mozdebug 16:19:00 INFO - Running setup.py install for mozdevice 16:19:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for mozfile 16:19:00 INFO - Running setup.py install for mozhttpd 16:19:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for mozinfo 16:19:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for mozInstall 16:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for mozleak 16:19:00 INFO - Running setup.py install for mozlog 16:19:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for moznetwork 16:19:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:00 INFO - Running setup.py install for mozprocess 16:19:01 INFO - Running setup.py install for mozprofile 16:19:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:01 INFO - Running setup.py install for mozrunner 16:19:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:01 INFO - Running setup.py install for mozscreenshot 16:19:01 INFO - Running setup.py install for moztest 16:19:01 INFO - Running setup.py install for mozversion 16:19:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:01 INFO - Cleaning up... 16:19:01 INFO - Return code: 0 16:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:19:01 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 16:19:01 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 16:19:01 INFO - Using env: {'DISPLAY': ':0', 16:19:01 INFO - 'HOME': '/home/cltbld', 16:19:01 INFO - 'LANG': 'en_US.UTF-8', 16:19:01 INFO - 'LANGUAGE': 'en_US:en', 16:19:01 INFO - 'LOGNAME': 'cltbld', 16:19:01 INFO - 'MAIL': '/var/mail/cltbld', 16:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:01 INFO - 'MOZ_NO_REMOTE': '1', 16:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:01 INFO - 'NO_EM_RESTART': '1', 16:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:01 INFO - 'PWD': '/builds/slave/test', 16:19:01 INFO - 'SHELL': '/bin/bash', 16:19:01 INFO - 'SHLVL': '1', 16:19:01 INFO - 'TERM': 'linux', 16:19:01 INFO - 'TMOUT': '86400', 16:19:01 INFO - 'USER': 'cltbld', 16:19:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:01 INFO - '_': '/tools/buildbot/bin/python'} 16:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:01 INFO - Running setup.py (path:/tmp/pip-wbgPbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:01 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)) 16:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:01 INFO - Running setup.py (path:/tmp/pip-iBWCWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:01 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)) 16:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:01 INFO - Running setup.py (path:/tmp/pip-WbTlsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:02 INFO - Running setup.py (path:/tmp/pip-GDHTBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:02 INFO - Running setup.py (path:/tmp/pip-vBPSJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:02 INFO - Running setup.py (path:/tmp/pip-U8XoCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:02 INFO - Running setup.py (path:/tmp/pip-uZD0Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:02 INFO - Running setup.py (path:/tmp/pip-7mArCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:02 INFO - Running setup.py (path:/tmp/pip-9K_NOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:02 INFO - Running setup.py (path:/tmp/pip-gHKm82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:02 INFO - Running setup.py (path:/tmp/pip-uoLLmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:02 INFO - Running setup.py (path:/tmp/pip-zfocJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:02 INFO - Running setup.py (path:/tmp/pip-DGShzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:02 INFO - Running setup.py (path:/tmp/pip-_zxZHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:02 INFO - Running setup.py (path:/tmp/pip-m1xfuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:02 INFO - Running setup.py (path:/tmp/pip-PPbKb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:02 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)) 16:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:02 INFO - Running setup.py (path:/tmp/pip-nTXeKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:03 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)) 16:19:03 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)) 16:19:03 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)) 16:19:03 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)) 16:19:03 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)) 16:19:03 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)) 16:19:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:03 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 16:19:03 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 16:19:03 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 16:19:03 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 16:19:03 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 16:19:03 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 16:19:04 INFO - Downloading blessings-1.6.tar.gz 16:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:04 INFO - Installing collected packages: blessings 16:19:04 INFO - Running setup.py install for blessings 16:19:05 INFO - Successfully installed blessings 16:19:05 INFO - Cleaning up... 16:19:05 INFO - Return code: 0 16:19:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:05 INFO - Reading from file tmpfile_stdout 16:19:05 INFO - Current package versions: 16:19:05 INFO - argparse == 1.2.1 16:19:05 INFO - blessings == 1.6 16:19:05 INFO - blobuploader == 1.2.4 16:19:05 INFO - docopt == 0.6.1 16:19:05 INFO - functools32 == 3.2.3-2 16:19:05 INFO - jsonschema == 2.5.1 16:19:05 INFO - manifestparser == 1.1 16:19:05 INFO - mozInstall == 1.12 16:19:05 INFO - mozcrash == 0.17 16:19:05 INFO - mozdebug == 0.1 16:19:05 INFO - mozdevice == 0.48 16:19:05 INFO - mozfile == 1.2 16:19:05 INFO - mozhttpd == 0.7 16:19:05 INFO - mozinfo == 0.9 16:19:05 INFO - mozleak == 0.1 16:19:05 INFO - mozlog == 3.3 16:19:05 INFO - moznetwork == 0.27 16:19:05 INFO - mozprocess == 0.23 16:19:05 INFO - mozprofile == 0.28 16:19:05 INFO - mozrunner == 6.12 16:19:05 INFO - mozscreenshot == 0.1 16:19:05 INFO - mozsystemmonitor == 0.3 16:19:05 INFO - moztest == 0.7 16:19:05 INFO - mozversion == 1.4 16:19:05 INFO - psutil == 3.1.1 16:19:05 INFO - requests == 1.2.3 16:19:05 INFO - wsgiref == 0.1.2 16:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:05 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')]} 16:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:05 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')]} 16:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:05 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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:19:05 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 16:19:05 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 16:19:05 INFO - Using env: {'DISPLAY': ':0', 16:19:05 INFO - 'HOME': '/home/cltbld', 16:19:05 INFO - 'LANG': 'en_US.UTF-8', 16:19:05 INFO - 'LANGUAGE': 'en_US:en', 16:19:05 INFO - 'LOGNAME': 'cltbld', 16:19:05 INFO - 'MAIL': '/var/mail/cltbld', 16:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:05 INFO - 'MOZ_NO_REMOTE': '1', 16:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:05 INFO - 'NO_EM_RESTART': '1', 16:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:05 INFO - 'PWD': '/builds/slave/test', 16:19:05 INFO - 'SHELL': '/bin/bash', 16:19:05 INFO - 'SHLVL': '1', 16:19:05 INFO - 'TERM': 'linux', 16:19:05 INFO - 'TMOUT': '86400', 16:19:05 INFO - 'USER': 'cltbld', 16:19:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:05 INFO - '_': '/tools/buildbot/bin/python'} 16:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 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)) 16:19:05 INFO - Cleaning up... 16:19:05 INFO - Return code: 0 16:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:05 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')]} 16:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:05 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')]} 16:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:05 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 0x11a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', '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 16:19:05 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 16:19:05 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 16:19:05 INFO - Using env: {'DISPLAY': ':0', 16:19:05 INFO - 'HOME': '/home/cltbld', 16:19:05 INFO - 'LANG': 'en_US.UTF-8', 16:19:05 INFO - 'LANGUAGE': 'en_US:en', 16:19:05 INFO - 'LOGNAME': 'cltbld', 16:19:05 INFO - 'MAIL': '/var/mail/cltbld', 16:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:05 INFO - 'MOZ_NO_REMOTE': '1', 16:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:05 INFO - 'NO_EM_RESTART': '1', 16:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:05 INFO - 'PWD': '/builds/slave/test', 16:19:05 INFO - 'SHELL': '/bin/bash', 16:19:05 INFO - 'SHLVL': '1', 16:19:05 INFO - 'TERM': 'linux', 16:19:05 INFO - 'TMOUT': '86400', 16:19:05 INFO - 'USER': 'cltbld', 16:19:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:05 INFO - '_': '/tools/buildbot/bin/python'} 16:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:19:05 INFO - Cleaning up... 16:19:05 INFO - Return code: 0 16:19:05 INFO - Running post-action listener: _resource_record_post_action 16:19:05 INFO - Running post-action listener: _start_resource_monitoring 16:19:05 INFO - Starting resource monitoring. 16:19:05 INFO - [mozharness: 2016-08-02 23:19:05.839678Z] Finished create-virtualenv step (success) 16:19:05 INFO - [mozharness: 2016-08-02 23:19:05.840117Z] Running install step. 16:19:05 INFO - Running pre-action listener: _resource_record_pre_action 16:19:05 INFO - Running main action method: install 16:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:06 INFO - Reading from file tmpfile_stdout 16:19:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:06 INFO - Reading from file tmpfile_stdout 16:19:06 INFO - Output received: 16:19:06 INFO - Usage: mozinstall [options] installer 16:19:06 INFO - Options: 16:19:06 INFO - -h, --help show this help message and exit 16:19:06 INFO - -d DEST, --destination=DEST 16:19:06 INFO - Directory to install application into. [default: 16:19:06 INFO - "/builds/slave/test"] 16:19:06 INFO - --app=APP Application being installed. [default: firefox] 16:19:06 INFO - mkdir: /builds/slave/test/build/application 16:19:06 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'] 16:19:06 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 16:19:23 INFO - Reading from file tmpfile_stdout 16:19:23 INFO - Output received: 16:19:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:19:23 INFO - Running post-action listener: _resource_record_post_action 16:19:23 INFO - [mozharness: 2016-08-02 23:19:23.028774Z] Finished install step (success) 16:19:23 INFO - [mozharness: 2016-08-02 23:19:23.029051Z] Running run-tests step. 16:19:23 INFO - Running pre-action listener: _resource_record_pre_action 16:19:23 INFO - Running main action method: run_tests 16:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:23 INFO - Python 2.7.3 16:19:23 INFO - Return code: 0 16:19:23 INFO - grabbing minidump binary from tooltool 16:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:23 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 0x1462570>, '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 0x1463470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1463900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:23 INFO - Return code: 0 16:19:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:19:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:19:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:19:23 INFO - Using env: {'DISPLAY': ':0', 16:19:23 INFO - 'HOME': '/home/cltbld', 16:19:23 INFO - 'LANG': 'en_US.UTF-8', 16:19:23 INFO - 'LANGUAGE': 'en_US:en', 16:19:23 INFO - 'LOGNAME': 'cltbld', 16:19:23 INFO - 'MAIL': '/var/mail/cltbld', 16:19:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:23 INFO - 'MOZ_NO_REMOTE': '1', 16:19:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:23 INFO - 'NO_EM_RESTART': '1', 16:19:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:23 INFO - 'PWD': '/builds/slave/test', 16:19:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:23 INFO - 'SHELL': '/bin/bash', 16:19:23 INFO - 'SHLVL': '1', 16:19:23 INFO - 'TERM': 'linux', 16:19:23 INFO - 'TMOUT': '86400', 16:19:23 INFO - 'USER': 'cltbld', 16:19:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928', 16:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:23 INFO - '_': '/tools/buildbot/bin/python'} 16:19:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:19:23 INFO - mozversion application_buildid: 20160802133030 16:19:23 INFO - mozversion application_changeset: 73a57814a495b29244ef5377e73488a3f3fabb15 16:19:23 INFO - mozversion application_display_name: Nightly 16:19:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:23 INFO - mozversion application_name: Firefox 16:19:23 INFO - mozversion application_remotingname: firefox 16:19:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:19:23 INFO - mozversion application_vendor: Mozilla 16:19:23 INFO - mozversion application_version: 51.0a1 16:19:23 INFO - mozversion platform_buildid: 20160802133030 16:19:23 INFO - mozversion platform_changeset: 73a57814a495b29244ef5377e73488a3f3fabb15 16:19:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:19:23 INFO - mozversion platform_version: 51.0a1 16:19:23 INFO - using testdate: 1470179963 16:19:23 INFO - actual date: 1470179963 16:19:23 INFO - starting webserver on 'localhost:33093' 16:19:23 INFO - SUITE-START | Running 2 tests 16:19:23 INFO - TEST-START | dromaeo_css 16:19:23 INFO - operating with platform_type : linux_ 16:19:23 INFO - Initialising browser for dromaeo_css test... 16:19:23 INFO - TEST-INFO | started process 21272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3dn8M/profile http://localhost:33093/getInfo.html) 16:19:28 INFO - PROCESS | 21272 | __metrics Screen width/height:1600/1200 16:19:28 INFO - PROCESS | 21272 | colorDepth:24 16:19:28 INFO - PROCESS | 21272 | Browser inner width/height: 1024/697 16:19:28 INFO - PROCESS | 21272 | __metrics 16:19:28 ERROR - PROCESS | 21272 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:19:29 INFO - TEST-INFO | 21272: exit 0 16:19:29 INFO - Browser initialized. 16:19:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:19:29 INFO - TEST-INFO | started process 21391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3dn8M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:41 INFO - PROCESS | 21391 | RSS: Main: 163172352 16:19:41 INFO - PROCESS | 21391 | 16:20:31 INFO - PROCESS | 21391 | 1470180031314 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] 16:22:40 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33093/tests/dromaeo/cssquery-ext.html) 16:22:42 INFO - PROCESS | 21391 | RSS: Main: 165937152 16:22:42 INFO - PROCESS | 21391 | 16:25:44 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-ext.html (next: http://localhost:33093/tests/dromaeo/cssquery-jquery.html) 16:25:44 INFO - PROCESS | 21391 | RSS: Main: 165031936 16:25:44 INFO - PROCESS | 21391 | 16:28:46 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33093/tests/dromaeo/cssquery-mootools.html) 16:28:47 INFO - PROCESS | 21391 | RSS: Main: 169197568 16:28:47 INFO - PROCESS | 21391 | 16:31:49 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33093/tests/dromaeo/cssquery-prototype.html) 16:31:49 INFO - PROCESS | 21391 | RSS: Main: 163835904 16:31:49 INFO - PROCESS | 21391 | 16:34:52 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33093/tests/dromaeo/cssquery-yui.html) 16:34:52 INFO - PROCESS | 21391 | RSS: Main: 166178816 16:34:52 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | Cycle 1(1): loaded http://localhost:33093/tests/dromaeo/cssquery-yui.html (next: http://localhost:33093/tests/dromaeo/cssquery-dojo.html) 16:37:55 INFO - PROCESS | 21391 | RSS: Main: 169177088 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | __start_tp_report 16:37:55 INFO - PROCESS | 21391 | _x_x_mozilla_page_load 16:37:55 INFO - PROCESS | 21391 | _x_x_mozilla_page_load_details 16:37:55 INFO - PROCESS | 21391 | |i|pagename|runs| 16:37:55 INFO - PROCESS | 21391 | |0;dojo.html;3071.0172744721685;3091.4126315999943;3115.610548681415;3120.1107684309977;3120.9063728088167;5293.100172970595;5393.4067252602235;5437.238786569878;5449.783569146049;5487.670739755617;5421.593380496469;5481.287432633752;5486.506214440699;5500.862478438041;5503.9174412383845;4921.212605983043;4954.355933728611;4975.626827987898;5010.248462730601;5051.7726702298305;4932.630052746041;4968.875778105558;5027.944131732341;5032.57223136032;5072.797088116489;5079.695218286896;5081.84754457365;5092.108880945838;5094.337736094302;5097.311862898517;4870.439899411542;4881.072596206709;4905.828296009622;4943.777530011158;4947.356843610343;4852.102361063215;4869.172240719086;4876.512348765095;4936.333594964705;4948.257761335828;5359.303290572239;5380.058489764276;5392;5402.216678581623;5404.32445944257;5689.260396148474;5791.65250084992;5800.7679692812235;5816.069428891399;5843.824685259449;5870.7945221917025;5901.940980590182;5916.290045194604;5939.613925094855;5994.430529099728;5480.671159730429;5483.451654834525;5485;5487.314085739283;5501.037318469252;5749.482546570829;5847.327557330961;5889.469947704727;5904.114382842608;6027.517798576104;5676.489115979582;5680.914786278209;5687.061634830289;5694.288213973254;5722.227499287626;5745.368009518949;5755.482006619424;5758.88482230353;5762.88474230513;5771.278590176228;5615.213870058195;5723.313202415654;5724.570657200727;5779.046457334577;5807.448292412214;5638.238837756932;5784.88430231393;5837.649741015468;5852.678102704393;5895.204147440127;4456.175607512556;4500.482444518922;4512.842050528216;4519.118771839526;4555.2711566149255;3916.8433262669173;3943.4873466449753;3989.740666856645;4035.757854528738;4053.452783874139;5557.638753481011;5569.415211402745;5598.328200615871;5654.236678048411;5654.264945557134;5832.825015249549;5869.706514674249;5871.412858714094;5882.941170588239;5887.911681324784;5439.864003399946;5482.2873026506295;5579.944200557942;5598.356189038232;5607.607467477237;4947.628927830355;4984.127777638899;4986.326845875833;5032.72320022395;5033.471485494044;6007.729652165663;6024.277086749618;6025.66858822769;6033.879322413527;6048.727807248684;5693.715314234355;5819.272590926134;5826.650400975955;5838.503727183237;5843.474087332161;6029.57792954489;6095.952232173902;6096.738354098959;6119.533019689948;6132.176708110278;5755.395683453177;5788.507976821849;5803.970980145241;5806.1000544915605;5826.300843898759;5745.540356771532;5840.883182336244;5862.501687356623;5905.084711869667;5925.1704761332585;5674.546036317002;5780.971095144498;5784.190213370048;5827.737751801094;5834.94165058361;5686.2607860977805;5727.570432217517;5737.942620573741;5760.740766665594;5761.8764340954785;5422.6475279106735;5492.0663487206475;5679.318481782213;5695.686737229492;5704.172894930295;5710.114932185518;5809.680467574155;5828.0966450200285;5833.387494313036;5868.94131058701;5577.581681373832;5629.943700562942;5671.716414179192;5673.035583950656;5689.886202276014 16:37:55 INFO - PROCESS | 21391 | |1;ext.html;549.8506348020912;579.7941730685607;581.5522048023022;597.0715537339438;632.9936700632992;39392.60607393925;43215.78392108039;43249.56750432499;43261.56738432615;43428.3485747714;43853.56146438535;44450;44497.55502444974;44624.776876115575;44752.77623611886;8785.297176225902;8830.735077947671;8866.157715017063;8906.688265910694;8910.50992195429;8874.911250887473;8898.466092034467;8899.95550022249;8902.931648202224;8948.642054317852;8891.911080889206;8912.509811960339;8953.641854325819;8954.686585969492;8991.685291014815;8894.421862578944;8910.376273660846;8925.19673229406;8968.730938071803;8976.775580610505;8761.56192190388;8767.254783343424;8791.956040219759;8826.646934122627;8834.86747698785;35186.296274074375;35387.469187962204;35411.82294088539;35441.82279088588;35569.82215088908;3397.159962396705;3500.7199424046016;3502.614712381636;3601.963980360189;3630.2557975614936;31850.840745796122;33057.33885322304;34539.82730086359;34543.13642158941;34583.4812477813;4129.339305711072;4328.935065974013;4336.544662810391;4353.717008394444;4467.352233926095;391766;394951;396988;397219;397248;64695.67652161709;65024.674876625315;65201.34798652048;65553.34446655567;65716.67141664261;69354.65322673354;69465;69491;69636.6518167416;69778.65110674415;14432.639184020274;14737;14751.77872331916;14988.100713957198;15027.924860375628;11154.386508741934;11292.322460652387;11293.491792869341;11295.943520282346;11333.603323883624;20865.47836304074;20894.37316880496;20942.37172884816;20952.580948380946;21215.36353909385;7786.7663970080985;7952.522848629101;8005.919940800634;8070.354371650254;8350.415470916978;976.941383516977;1041.3335465302212;1079.9514021868877;1136.1308598921833;1142.5886680794906;34051;34102;34132;34199.82900085534;34644.48033279503;1048.9423081730579;1079.3918499962735;1175.7413369058793;1195.246994393544;1243.9004879609608;16323.34706611746;17335.65328693419;17468.301267949395;17483.56291092733;17522;600033;604265;605410;606407;607754;60419.35387107415;60880.391196088356;60956.695216523636;61146.38853611496;61227.69386153041;1310.6592286005707;1328.7807511760645;1374.5120482228665;1377.125525291427;1377.5247539599022;31321.216969575944;32106.35787284288;32646.34707305888;32773.31482692629;33117.503237450976;49884.25173622471;49891.25163122629;49906;50012.74993625009;50350;491416;491671;493396;493442;493957;30060.09819705412;30131;30513;30530.84734576313;30604.234894127825;49660.25509617286;50185.49814501954;50313;51184.48815511797;51318.230226545886;41701.58298416977;42609.78695106505;43454;43706.78146609246;44760.552394475635;42218.36672449977;43151.53686179682;43242.783786080865;43287;43688.56311436972;42740.78629606832;43024.78487607542;43239.35140972825;43785;45604;34061.82969085139;37289.44065839069;38558.42162367511;39237.8038109819;40336.39495407513;28075.859620702584;29431.26421839471;29486.705132948395;29649.25876853096;30152 16:37:55 INFO - PROCESS | 21391 | |2;jquery.html;378.7897716767195;392.6976228304206;394.964453199212;397.0807580451257;419.0738467985751;13910.791338129937;18469.35357262496;19472.12375443105;20278.69581956272;20290.39128826136;19282.421527354167;19356.3225287115;19516.51208719783;19833.801661983376;19945.401637950883;5547.223388725582;5729.3411257705375;5782.884342313151;5854.707264636772;5953.821385358425;5822.7088645567765;5851;5852.12218167274;5882.5588080893895;5886.970565147169;5759.3376761672525;5817.8836423271505;5835.649861008353;5876.882462350751;5881.3530511643685;5916.3787802280785;6828.453723702117;7116.43068554517;7123.679434425463;7173.6413179340825;6645.269020407752;6900.689468973908;7059.8588028239665;7108.644567771643;7171.820704482378;24878.253652390456;26350.209493715218;26647.733522664912;27119.593206101923;27393.178204653894;2547.5796493578537;2724.2372135802007;2837.3474100956687;2872.0091568409075;2888.3645597968625;15743.370265189378;15932.681346373007;16018.5995350116;16254.918725406416;17032.82967170325;2026.3211824038817;2065.8450616203695;2071.7099606055162;2076.512019675375;2176.945576360604;93428;93739.53130234373;93779;95621.5218923901;95994.52002739941;16894;17016.149192540324;17737.556561085818;17829.375971840924;18045.819541804678;32021.679783202337;32081.839590801897;32096;32123.51814722781;32136.678633213836;8955.955220223857;9114.407563508483;9160;9344.906550934404;9450.33847630673;7526.811829704192;7603.429742769204;7788.766337009899;7818.530888146729;7831.804204894923;8746.157498812783;9175;9240.722778316662;9306.767330816783;9417.233106757214;3191.792533485316;3402.8128452935325;3516.5933626549586;3632.2372301816913;3651.744377893522;954.3844220477753;1047.120418848156;1068.3589846092282;1069;1102.8420158833194;20112.698309525367;20422.489437764176;20619.58760824805;20653.690194647093;20768.68846967297;1019.6533178719271;1038.678009816959;1057.5558265528343;1062.3201151263197;1072.8766191888033;10701.83947240792;11580.420978951019;11627.360495172847;11644.602647682332;11666.416679166008;457552;464774;465416;467525;467689.9846502305;55862;78650.21349786544;94799;95182.52408737912;98651;933.4306073295285;980.3235767320526;983.0759086458706;996.7956568903357;1009.3842755918884;17082.829171708123;17601.647967040844;18270.543236419195;18408.63182736311;18477.53806154857;40554.79722601368;41838.79080604578;42461.57538424576;44320;44382.77808610936;58694;60380.69809651099;60682.39317606767;60917;61552.69223653853;8379.203975622306;8578.227959483676;8725.21473067427;8727.301815854844;8914.28685705155;13444.932775336061;13577.932110339385;13720.176789392668;13889.097208681404;14127.293635318398;11863.58477453285;12008.579699710468;12083.154179207722;12219.75560488803;12269.325187114437;11380.089592832719;11689.649310520697;12023.939880300542;12064.939675301568;12435.253884766942;11525.942370288094;11539.307641541534;12136.878631213927;12184.147109702235;12314.322712250554;8630.482171069756;8668.252080856273;8772.210501054935;8798.296136309207;8939.955300223457;10595.311304765166;11673.766524669629;11718.824217636913;11731;12601.936990314989 16:37:55 INFO - PROCESS | 21391 | |3;mootools.html;1474;1482.733108040553;1619.9514014579559;1759.780027496563;1762.4272111563737;8127.065387480441;8758.12418758124;8839.823203535925;9502.52487375632;9521.904780952196;8875;9212.49331286779;9248.4913329767;9251.44491330519;9280.4431734096;2353.6940197774265;2398.1726304424947;2404.230646193219;2407.16952651335;2419.0323870451784;2355.634876594122;2358.1039205102124;2446.3517167950417;2447.9265622031367;2456.668349772776;2386.809055275574;2400.987995060022;2413.553492603874;2448.375664205634;2458.397692565315;2379.1791831817995;2388.6775285336516;2393.784559389663;2397.0292031727176;2423.563758523465;2344.5193735284224;2358.092134528219;2361.8582885026954;2376.7266764322153;2399.940001499959;9128.863067053999;9253;9277.304202184863;9322.347435679505;9357.76605584859;5243.2659427680155;5373.865653358658;5377.892442151174;5381.704006279653;5382.542483888874;3590.138366791977;3601.2617413430185;3626.7823930563986;3689.520362352877;3689.9262014759825;1224.369449733388;1250.9874901251053;1253.1165528302524;1294.1911305434103;1305.673581604599;13149.737005259936;13204.801927971088;13228.603141905662;13230.933845330808;13250.337483125708;4653.951661661617;4831.347768051339;4843.854684359475;4913.238448040559;4982.526659967298;10870.18473614482;10929.071028962468;10959.671209863716;10977.176711746652;10986.725331866768;5570.637908535932;5576.6096373254295;5585.944140558624;5614.775408983595;5616;4291.74249545022;4861.80552777892;4868.172410690191;4890.706557606555;5033.748312584356;4130.791867441449;4155.397467367276;4164.937525937114;4201.451139507057;4418.116376724668;1334.2728213123871;1356.4438580182077;1357.8981576381811;1365.706373129782;1379.827521559805;875.4747151708924;995.8307087795092;1011.2971484817981;1024.702836177515;1028.3572767020612;6179.3202747697715;6189.783357582463;6289.685515724195;6355.5551111421755;6674.2658307586125;992.0823238504355;1048.397171626318;1113.2763703592568;1117.5138814615668;1127.5454663484177;4289.549597292239;4300.80646370914;4464.598186163196;4507.729536227836;4556.70381425213;11366.261193022427;11614.535418583162;11677.591284305008;11700.06399488056;11756.823647645293;11547.884521154849;11596.652100437;11611.6516504505;11635.709107272385;11636.069114470822;8206.548639824867;8470.872936905827;8503.532305723245;8591.226789588967;8779.078196789245;6249.687515624291;6253.937460625336;6373.3945275198785;6396.232452105777;6450.709718062604;10608;10686.625968091079;10721.927807219216;10776.67669969902;10802.783944320912;10645.201609879136;10680.412577308012;10719.678409647411;10733.624323148651;10792.784144316913;8180.263776260165;8228.50628962264;8333.2916702081;8385.916140838757;8408.117147699404;8990.056044115274;9002.054784247559;9025.503597302211;9039.819203616022;9064.456132632064;7921.762347129596;8049.557274349967;8116.472429292077;8186.54973976437;8374.790630234049;8075.273225409741;8111.553864537507;8112.391570632344;8144.714934977247;8242;7309.013283206912;7385.630718463948;7417.332440080419;7536.811579710551;7626.54240745557;5558.91661625084;5647.943520564741;5655.406182350958;5680.744366503434;5807.0998995155815;5604.439556044363;5617.185508101385;5763.020286551213;5913.852153696192;5920.052791553331 16:37:55 INFO - PROCESS | 21391 | |4;prototype.html;322.0884895745042;327.2685547800665;330.3508605590015;333.62967106511775;333.8063922924704;5481.397046324901;5524.696141712204;5606.523445507137;5616.663000219979;5622.971885140573;5495.093309603911;5495.368032676243;5499.1476321170185;5504.834854954348;5540.3628582713;4135.751854888709;4205.453291072156;4299.140171965604;4299.50555686097;4312.417823593806;4269.146170765859;4277.465316835395;4306.310990241562;4319.911263446635;4321.913561728764;4260.3822445745345;4290.54949230331;4292.270314046619;4296.505901821283;4317.352397140438;4065.451164092854;4218.936715949263;4251.6173544380845;4286.914261714779;4306.846576711644;3716.6097559756377;3731.738778285521;3741.120836603396;3741.345264578715;3748.9437658435145;5464.754086066137;5476.26070480484;5487.560995120421;5492.945070549284;5498.532624726903;4787.593054590364;4804.23132298834;4845.3216549683075;4847.781849816767;4868.537488938545;5696.658200507983;5701.74780961522;5747.626404283708;5765.913511297334;5795.913061304083;4024.9195016099807;4030.7984600769846;4034.4150098235887;4037.7375470594316;4039.5354534228354;5851.61964472308;5989.903533763191;6013.428724271231;6016.127661489103;6029.216201893726;4162.313218319004;4181.644560212355;4198.732684350417;4210.915781684349;4224.197402493516;4246.808893599796;4266.978665106654;4267.274563324242;4269.765162916007;4271.654428854901;4712.764361781898;4849.975750121227;4875.000624871893;4906;4926.679765815282;5744.712764361765;5764.625299355528;5775.209684997664;5842.415758424208;5880.206172166788;1463.0270869871629;1465.5090544667441;1473.4990103364694;1476.468471350313;1479.9556013319402;916.0884919505135;931.9813603727888;934.5654270764128;936.5879013234292;941.6892425499568;4850.660453768202;4881.389826271716;4951.72765497901;4988.775505102279;5005.9749701251985;5183.134071734173;5218.895622087537;5253.816116435906;5277.129273669878;5305.628605997543;4960.751962401938;4991.900161996739;5013.623978201649;5209.322788037531;5641.915371269434;3154.022253101546;3155.495120780664;3191.68083191679;3191.9361612767616;3192.56900318454;6038.826022631849;6092.3603021682975;6221.36050410515;6230.352100357421;6256.280527739368;5990.9101363479585;6022.09668549721;6037.6679282639;6111.51107911366;6142.232220972379;6263.592866463757;6272.18461599989;6280.277768056732;6283.6858157091965;6288.9056664150075;5806.129080637938;5891.764329426775;5910.970445147918;5946.851328716643;5949.66132620157;5872.500837428866;5892.587518873637;5906.320773111147;5914.4381283777975;5937;6068.362821903813;6190.442860142609;6195.31851496326;6213.813585592258;6229.875402492015;4134.772587507596;4144;4160.105577300895;4165.854195103157;4185.953511622094;5896.793612223723;5912.586118971631;5937.34689184198;5999.730012149376;6024.969875150597;5601.103823388238;5629.296337957755;5780.190773291826;5791.681457519877;5853;5760.308762948473;5797.304323481209;5828.475437210502;5849.3858144894175;5859.414058594107;5502.944970550243;5634.295713035871;5682.460166284196;5781.537477001913;5816.563757718103;5763.538916886723;5775.27809023872;5782.537397008314;5833.212516310244;5891.469767720926;5708.286464191976;5728.651252986422;5732.598718089694;5760.222369979999;5776.740046697824 16:37:55 INFO - PROCESS | 21391 | |5;yui.html;734.4454936522924;742.0687037767605;744.0699126092385;745.0277388008647;776.763087258386;16015;16793.412230571932;17087.57281067974;17289.30842766288;17297.308107675693;15705.450309239179;15924.12417317047;15925.681486370266;15980;16023.519294421187;801.8396320735861;814.8411059843332;815.0463957170095;816.4285000499644;821.2198411509061;790.9169537198597;799.9280064794167;806.4919100966383;808.737160422862;838.7986883148061;847.9152084791502;853.8164294676643;855.2260204514924;856.1181982557976;856.7001549457702;849.227203245044;849.5667209723055;850.8978922529274;851.6167724523958;852.2457625001856;617.7065893700501;618.4773866083152;619.1115748900297;619.8419403052238;620.6090163197202;16164.353425862952;16169.676606467923;16177.83822161775;16191;16200.43298484559;15335.30991105403;15493.147876866768;15633.218339083;15686.607834804106;15859.286332115082;12703.364831758468;12812.231266124063;12930.48278068876;13149.60551183466;13395.933020334933;3880.204558065618;3888.591697871739;3970.325044742372;4044.2315959967514;4046;84377.57811210904;85908;85945.57027214886;86411.13588864157;86469;10647.414392208348;11739.765204695857;11905.226160299553;11952.701182470333;12100.757984840255;20411.387658370273;21836;21875.234366797085;21910.671339929915;21919.561608767734;8289.4197406181;8303.667853285922;8509.914900851036;8678.262347700516;8737.475751454933;4835.419749630067;4873.415190177201;4908.730019848943;5009.423916249678;5087.516685914832;3539.2036791721657;3663.8351274192723;3666.8533258669886;3672.081979505124;3690.2619476104887;582.5368831778746;585.2012003615035;598.6587645042284;599.7541008186622;613.0773186354508;643.2281262485037;652.1587152573222;669.8626781509779;680.3570625758709;697.8081027717418;10047.899521004843;10189.082982531607;10532.526036328383;10618.309809862334;10640.148788097089;556.8023351710166;565.9727594416122;618.3653516890842;705.9682314295869;710.7903168565285;4719.811207551728;4930.926036109461;5040.571551418097;5106.897862042812;5149.2791009258735;74287;74414.62792686002;117586.41206793912;127435;127689.36155319349;65254.34745652578;92123;104899.475502622;107692.46153769181;110361;54550.454495455335;54920.72539637276;56642.150367744514;74935.62532187304;85491.57254213688;10188.541515631963;10990.835137473105;11000.449977500934;11112.111031117653;11155.442227888736;40275.194496109325;48252;50230.246546302566;53927.730361347945;54724.45275547194;69578.65210674117;76177.61911190409;76562;77112.2288777105;78577;12820.871791281968;12966.938174535077;13021.869781302066;13482.258475783927;13581.524646637321;14942.248696058869;15001.699966000837;15103.54689359321;15156.393744250106;15855;14439.398988366815;14811.703765924836;14960.551183464513;14983.40066397332;15232.466863659718;14241.928790355982;14596.782584138742;14658.560243192722;14825.332860021541;15292;13306.401211945293;13602.319884005958;13842.584722458343;13901.791473128114;14205.928970355495;10847.457627118454;10873.293235939638;11062.336259824437;11357.886421135683;11758.823617645914;10383.428911409945;10805.405702686114;12108.878911210775;12327.630171094881;12714.11001229942 16:37:55 INFO - PROCESS | 21391 | __end_tp_report 16:37:55 INFO - PROCESS | 21391 | __start_cc_report 16:37:55 INFO - PROCESS | 21391 | _x_x_mozilla_cycle_collect,339 16:37:55 INFO - PROCESS | 21391 | __end_cc_report 16:37:55 INFO - PROCESS | 21391 | __startTimestamp1470181075897__endTimestamp 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | ------- Summary: start ------- 16:37:55 INFO - PROCESS | 21391 | Number of tests: 6 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#0] dojo.html Cycles:165 Average:5424.13 Median:5673.04 stddev:619.24 (10.9%) stddev-sans-first:592.99 16:37:55 INFO - PROCESS | 21391 | Values: 3071.0 3091.4 3115.6 3120.1 3120.9 5293.1 5393.4 5437.2 5449.8 5487.7 5421.6 5481.3 5486.5 5500.9 5503.9 4921.2 4954.4 4975.6 5010.2 5051.8 4932.6 4968.9 5027.9 5032.6 5072.8 5079.7 5081.8 5092.1 5094.3 5097.3 4870.4 4881.1 4905.8 4943.8 4947.4 4852.1 4869.2 4876.5 4936.3 4948.3 5359.3 5380.1 5392.0 5402.2 5404.3 5689.3 5791.7 5800.8 5816.1 5843.8 5870.8 5901.9 5916.3 5939.6 5994.4 5480.7 5483.5 5485.0 5487.3 5501.0 5749.5 5847.3 5889.5 5904.1 6027.5 5676.5 5680.9 5687.1 5694.3 5722.2 5745.4 5755.5 5758.9 5762.9 5771.3 5615.2 5723.3 5724.6 5779.0 5807.4 5638.2 5784.9 5837.6 5852.7 5895.2 4456.2 4500.5 4512.8 4519.1 4555.3 3916.8 3943.5 3989.7 4035.8 4053.5 5557.6 5569.4 5598.3 5654.2 5654.3 5832.8 5869.7 5871.4 5882.9 5887.9 5439.9 5482.3 5579.9 5598.4 5607.6 4947.6 4984.1 4986.3 5032.7 5033.5 6007.7 6024.3 6025.7 6033.9 6048.7 5693.7 5819.3 5826.7 5838.5 5843.5 6029.6 6096.0 6096.7 6119.5 6132.2 5755.4 5788.5 5804.0 5806.1 5826.3 5745.5 5840.9 5862.5 5905.1 5925.2 5674.5 5781.0 5784.2 5827.7 5834.9 5686.3 5727.6 5737.9 5760.7 5761.9 5422.6 5492.1 5679.3 5695.7 5704.2 5710.1 5809.7 5828.1 5833.4 5868.9 5577.6 5629.9 5671.7 5673.0 5689.9 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#1] ext.html Cycles:180 Average:65792.47 Median:43255.57 stddev:134329.15 (310.5%) stddev-sans-first:134616.67 16:37:55 INFO - PROCESS | 21391 | Values: 549.9 579.8 581.6 597.1 633.0 39392.6 43215.8 43249.6 43261.6 43428.3 43853.6 44450.0 44497.6 44624.8 44752.8 8785.3 8830.7 8866.2 8906.7 8910.5 8874.9 8898.5 8900.0 8902.9 8948.6 8891.9 8912.5 8953.6 8954.7 8991.7 8894.4 8910.4 8925.2 8968.7 8976.8 8761.6 8767.3 8792.0 8826.6 8834.9 35186.3 35387.5 35411.8 35441.8 35569.8 3397.2 3500.7 3502.6 3602.0 3630.3 31850.8 33057.3 34539.8 34543.1 34583.5 4129.3 4328.9 4336.5 4353.7 4467.4 391766.0 394951.0 396988.0 397219.0 397248.0 64695.7 65024.7 65201.3 65553.3 65716.7 69354.7 69465.0 69491.0 69636.7 69778.7 14432.6 14737.0 14751.8 14988.1 15027.9 11154.4 11292.3 11293.5 11295.9 11333.6 20865.5 20894.4 20942.4 20952.6 21215.4 7786.8 7952.5 8005.9 8070.4 8350.4 976.9 1041.3 1080.0 1136.1 1142.6 34051.0 34102.0 34132.0 34199.8 34644.5 1048.9 1079.4 1175.7 1195.2 1243.9 16323.3 17335.7 17468.3 17483.6 17522.0 600033.0 604265.0 605410.0 606407.0 607754.0 60419.4 60880.4 60956.7 61146.4 61227.7 1310.7 1328.8 1374.5 1377.1 1377.5 31321.2 32106.4 32646.3 32773.3 33117.5 49884.3 49891.3 49906.0 50012.7 50350.0 491416.0 491671.0 493396.0 493442.0 493957.0 30060.1 30131.0 30513.0 30530.8 30604.2 49660.3 50185.5 50313.0 51184.5 51318.2 41701.6 42609.8 43454.0 43706.8 44760.6 42218.4 43151.5 43242.8 43287.0 43688.6 42740.8 43024.8 43239.4 43785.0 45604.0 34061.8 37289.4 38558.4 39237.8 40336.4 28075.9 29431.3 29486.7 29649.3 30152.0 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#2] jquery.html Cycles:180 Average:29864.84 Median:17769.75 stddev:76744.34 (431.9%) stddev-sans-first:76927.69 16:37:55 INFO - PROCESS | 21391 | Values: 378.8 392.7 395.0 397.1 419.1 13910.8 18469.4 19472.1 20278.7 20290.4 19282.4 19356.3 19516.5 19833.8 19945.4 5547.2 5729.3 5782.9 5854.7 5953.8 5822.7 5851.0 5852.1 5882.6 5887.0 5759.3 5817.9 5835.6 5876.9 5881.4 5916.4 6828.5 7116.4 7123.7 7173.6 6645.3 6900.7 7059.9 7108.6 7171.8 24878.3 26350.2 26647.7 27119.6 27393.2 2547.6 2724.2 2837.3 2872.0 2888.4 15743.4 15932.7 16018.6 16254.9 17032.8 2026.3 2065.8 2071.7 2076.5 2176.9 93428.0 93739.5 93779.0 95621.5 95994.5 16894.0 17016.1 17737.6 17829.4 18045.8 32021.7 32081.8 32096.0 32123.5 32136.7 8956.0 9114.4 9160.0 9344.9 9450.3 7526.8 7603.4 7788.8 7818.5 7831.8 8746.2 9175.0 9240.7 9306.8 9417.2 3191.8 3402.8 3516.6 3632.2 3651.7 954.4 1047.1 1068.4 1069.0 1102.8 20112.7 20422.5 20619.6 20653.7 20768.7 1019.7 1038.7 1057.6 1062.3 1072.9 10701.8 11580.4 11627.4 11644.6 11666.4 457552.0 464774.0 465416.0 467525.0 467690.0 55862.0 78650.2 94799.0 95182.5 98651.0 933.4 980.3 983.1 996.8 1009.4 17082.8 17601.6 18270.5 18408.6 18477.5 40554.8 41838.8 42461.6 44320.0 44382.8 58694.0 60380.7 60682.4 60917.0 61552.7 8379.2 8578.2 8725.2 8727.3 8914.3 13444.9 13577.9 13720.2 13889.1 14127.3 11863.6 12008.6 12083.2 12219.8 12269.3 11380.1 11689.6 12023.9 12064.9 12435.3 11525.9 11539.3 12136.9 12184.1 12314.3 8630.5 8668.3 8772.2 8798.3 8940.0 10595.3 11673.8 11718.8 11731.0 12601.9 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#3] mootools.html Cycles:180 Average:6140.40 Median:4486.16 stddev:3496.59 (77.9%) stddev-sans-first:3488.81 16:37:55 INFO - PROCESS | 21391 | Values: 1474.0 1482.7 1620.0 1759.8 1762.4 8127.1 8758.1 8839.8 9502.5 9521.9 8875.0 9212.5 9248.5 9251.4 9280.4 2353.7 2398.2 2404.2 2407.2 2419.0 2355.6 2358.1 2446.4 2447.9 2456.7 2386.8 2401.0 2413.6 2448.4 2458.4 2379.2 2388.7 2393.8 2397.0 2423.6 2344.5 2358.1 2361.9 2376.7 2399.9 9128.9 9253.0 9277.3 9322.3 9357.8 5243.3 5373.9 5377.9 5381.7 5382.5 3590.1 3601.3 3626.8 3689.5 3689.9 1224.4 1251.0 1253.1 1294.2 1305.7 13149.7 13204.8 13228.6 13230.9 13250.3 4654.0 4831.3 4843.9 4913.2 4982.5 10870.2 10929.1 10959.7 10977.2 10986.7 5570.6 5576.6 5585.9 5614.8 5616.0 4291.7 4861.8 4868.2 4890.7 5033.7 4130.8 4155.4 4164.9 4201.5 4418.1 1334.3 1356.4 1357.9 1365.7 1379.8 875.5 995.8 1011.3 1024.7 1028.4 6179.3 6189.8 6289.7 6355.6 6674.3 992.1 1048.4 1113.3 1117.5 1127.5 4289.5 4300.8 4464.6 4507.7 4556.7 11366.3 11614.5 11677.6 11700.1 11756.8 11547.9 11596.7 11611.7 11635.7 11636.1 8206.5 8470.9 8503.5 8591.2 8779.1 6249.7 6253.9 6373.4 6396.2 6450.7 10608.0 10686.6 10721.9 10776.7 10802.8 10645.2 10680.4 10719.7 10733.6 10792.8 8180.3 8228.5 8333.3 8385.9 8408.1 8990.1 9002.1 9025.5 9039.8 9064.5 7921.8 8049.6 8116.5 8186.5 8374.8 8075.3 8111.6 8112.4 8144.7 8242.0 7309.0 7385.6 7417.3 7536.8 7626.5 5558.9 5647.9 5655.4 5680.7 5807.1 5604.4 5617.2 5763.0 5913.9 5920.1 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#4] prototype.html Cycles:180 Average:4825.31 Median:5496.95 stddev:1435.87 (26.1%) stddev-sans-first:1399.55 16:37:55 INFO - PROCESS | 21391 | Values: 322.1 327.3 330.4 333.6 333.8 5481.4 5524.7 5606.5 5616.7 5623.0 5495.1 5495.4 5499.1 5504.8 5540.4 4135.8 4205.5 4299.1 4299.5 4312.4 4269.1 4277.5 4306.3 4319.9 4321.9 4260.4 4290.5 4292.3 4296.5 4317.4 4065.5 4218.9 4251.6 4286.9 4306.8 3716.6 3731.7 3741.1 3741.3 3748.9 5464.8 5476.3 5487.6 5492.9 5498.5 4787.6 4804.2 4845.3 4847.8 4868.5 5696.7 5701.7 5747.6 5765.9 5795.9 4024.9 4030.8 4034.4 4037.7 4039.5 5851.6 5989.9 6013.4 6016.1 6029.2 4162.3 4181.6 4198.7 4210.9 4224.2 4246.8 4267.0 4267.3 4269.8 4271.7 4712.8 4850.0 4875.0 4906.0 4926.7 5744.7 5764.6 5775.2 5842.4 5880.2 1463.0 1465.5 1473.5 1476.5 1480.0 916.1 932.0 934.6 936.6 941.7 4850.7 4881.4 4951.7 4988.8 5006.0 5183.1 5218.9 5253.8 5277.1 5305.6 4960.8 4991.9 5013.6 5209.3 5641.9 3154.0 3155.5 3191.7 3191.9 3192.6 6038.8 6092.4 6221.4 6230.4 6256.3 5990.9 6022.1 6037.7 6111.5 6142.2 6263.6 6272.2 6280.3 6283.7 6288.9 5806.1 5891.8 5911.0 5946.9 5949.7 5872.5 5892.6 5906.3 5914.4 5937.0 6068.4 6190.4 6195.3 6213.8 6229.9 4134.8 4144.0 4160.1 4165.9 4186.0 5896.8 5912.6 5937.3 5999.7 6025.0 5601.1 5629.3 5780.2 5791.7 5853.0 5760.3 5797.3 5828.5 5849.4 5859.4 5502.9 5634.3 5682.5 5781.5 5816.6 5763.5 5775.3 5782.5 5833.2 5891.5 5708.3 5728.7 5732.6 5760.2 5776.7 16:37:55 INFO - PROCESS | 21391 | 16:37:55 INFO - PROCESS | 21391 | [#5] yui.html Cycles:180 Average:20443.34 Median:3785.23 stddev:28672.19 (757.5%) stddev-sans-first:28714.43 16:37:55 INFO - PROCESS | 21391 | Values: 734.4 742.1 744.1 745.0 776.8 16015.0 16793.4 17087.6 17289.3 17297.3 15705.5 15924.1 15925.7 15980.0 16023.5 801.8 814.8 815.0 816.4 821.2 790.9 799.9 806.5 808.7 838.8 847.9 853.8 855.2 856.1 856.7 849.2 849.6 850.9 851.6 852.2 617.7 618.5 619.1 619.8 620.6 16164.4 16169.7 16177.8 16191.0 16200.4 15335.3 15493.1 15633.2 15686.6 15859.3 12703.4 12812.2 12930.5 13149.6 13395.9 3880.2 3888.6 3970.3 4044.2 4046.0 84377.6 85908.0 85945.6 86411.1 86469.0 10647.4 11739.8 11905.2 11952.7 12100.8 20411.4 21836.0 21875.2 21910.7 21919.6 8289.4 8303.7 8509.9 8678.3 8737.5 4835.4 4873.4 4908.7 5009.4 5087.5 3539.2 3663.8 3666.9 3672.1 3690.3 582.5 585.2 598.7 599.8 613.1 643.2 652.2 669.9 680.4 697.8 10047.9 10189.1 10532.5 10618.3 10640.1 556.8 566.0 618.4 706.0 710.8 4719.8 4930.9 5040.6 5106.9 5149.3 74287.0 74414.6 117586.4 127435.0 127689.4 65254.3 92123.0 104899.5 107692.5 110361.0 54550.5 54920.7 56642.2 74935.6 85491.6 10188.5 10990.8 11000.4 11112.1 11155.4 40275.2 48252.0 50230.2 53927.7 54724.5 69578.7 76177.6 76562.0 77112.2 78577.0 12820.9 12966.9 13021.9 13482.3 13581.5 14942.2 15001.7 15103.5 15156.4 15855.0 14439.4 14811.7 14960.6 14983.4 15232.5 14241.9 14596.8 14658.6 14825.3 15292.0 13306.4 13602.3 13842.6 13901.8 14205.9 10847.5 10873.3 11062.3 11357.9 11758.8 10383.4 10805.4 12108.9 12327.6 12714.1 16:37:55 INFO - PROCESS | 21391 | -------- Summary: end -------- 16:37:55 INFO - PROCESS | 21391 | 16:37:56 INFO - TEST-INFO | 21391: exit 0 16:37:56 INFO - TEST-OK | dromaeo_css | took 1113332ms 16:37:56 INFO - TEST-START | kraken 16:37:56 INFO - operating with platform_type : linux_ 16:37:56 INFO - Initialising browser for kraken test... 16:37:56 INFO - TEST-INFO | started process 21633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5jtnb/profile http://localhost:33093/getInfo.html) 16:38:01 INFO - PROCESS | 21633 | __metrics Screen width/height:1600/1200 16:38:01 INFO - PROCESS | 21633 | colorDepth:24 16:38:01 INFO - PROCESS | 21633 | Browser inner width/height: 1024/697 16:38:01 INFO - PROCESS | 21633 | __metrics 16:38:02 ERROR - PROCESS | 21633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:38:02 INFO - TEST-INFO | 21633: exit 0 16:38:02 INFO - Browser initialized. 16:38:02 INFO - Running cycle 1/1 for kraken test... 16:38:02 INFO - TEST-INFO | started process 21753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5jtnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:14 INFO - PROCESS | 21753 | RSS: Main: 163295232 16:38:14 INFO - PROCESS | 21753 | 16:38:17 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:18 INFO - PROCESS | 21753 | RSS: Main: 169000960 16:38:18 INFO - PROCESS | 21753 | 16:38:20 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-dft) 16:38:21 INFO - PROCESS | 21753 | RSS: Main: 168284160 16:38:21 INFO - PROCESS | 21753 | 16:38:24 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-fft) 16:38:24 INFO - PROCESS | 21753 | RSS: Main: 164790272 16:38:24 INFO - PROCESS | 21753 | 16:38:27 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33093/tests/kraken/driver.html?testName=audio-oscillator) 16:38:27 INFO - PROCESS | 21753 | RSS: Main: 165453824 16:38:27 INFO - PROCESS | 21753 | 16:38:29 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:30 INFO - PROCESS | 21753 | RSS: Main: 165793792 16:38:30 INFO - PROCESS | 21753 | 16:38:33 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:34 INFO - PROCESS | 21753 | RSS: Main: 165982208 16:38:34 INFO - PROCESS | 21753 | 16:38:37 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33093/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:38 INFO - PROCESS | 21753 | RSS: Main: 162553856 16:38:38 INFO - PROCESS | 21753 | 16:38:41 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33093/tests/kraken/driver.html?testName=json-parse-financial) 16:38:41 INFO - PROCESS | 21753 | RSS: Main: 164671488 16:38:41 INFO - PROCESS | 21753 | 16:38:43 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:43 INFO - PROCESS | 21753 | RSS: Main: 165138432 16:38:43 INFO - PROCESS | 21753 | 16:38:45 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:46 INFO - PROCESS | 21753 | RSS: Main: 165564416 16:38:46 INFO - PROCESS | 21753 | 16:38:48 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:49 INFO - PROCESS | 21753 | RSS: Main: 165797888 16:38:49 INFO - PROCESS | 21753 | 16:38:51 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:38:52 INFO - PROCESS | 21753 | RSS: Main: 165863424 16:38:52 INFO - PROCESS | 21753 | 16:38:55 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:38:55 INFO - PROCESS | 21753 | RSS: Main: 166043648 16:38:55 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | Cycle 1(1): loaded http://localhost:33093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33093/tests/kraken/driver.html?testName=ai-astar) 16:38:57 INFO - PROCESS | 21753 | RSS: Main: 166711296 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | __start_tp_report 16:38:57 INFO - PROCESS | 21753 | _x_x_mozilla_page_load 16:38:57 INFO - PROCESS | 21753 | _x_x_mozilla_page_load_details 16:38:57 INFO - PROCESS | 21753 | |i|pagename|runs| 16:38:57 INFO - PROCESS | 21753 | |0;ai-astar;103;116;107;112;113;114;114;112;111;112 16:38:57 INFO - PROCESS | 21753 | |1;audio-beat-detection;153;124;147;177;122;142;152;126;179;120 16:38:57 INFO - PROCESS | 21753 | |2;audio-dft;162;163;164;161;162;167;168;164;162;162 16:38:57 INFO - PROCESS | 21753 | |3;audio-fft;76;76;75;184;76;76;77;76;194;75 16:38:57 INFO - PROCESS | 21753 | |4;audio-oscillator;85;84;153;84;85;85;144;84;85;137 16:38:57 INFO - PROCESS | 21753 | |5;imaging-gaussian-blur;117;117;118;117;119;117;118;119;117;117 16:38:57 INFO - PROCESS | 21753 | |6;imaging-darkroom;147;147;148;146;148;147;148;148;148;146 16:38:57 INFO - PROCESS | 21753 | |7;imaging-desaturate;96;97;96;96;95;95;96;96;96;95 16:38:57 INFO - PROCESS | 21753 | |8;json-parse-financial;51;51;52;57;51;52;53;57;51;50 16:38:57 INFO - PROCESS | 21753 | |9;json-stringify-tinderbox;62;65;63;63;64;63;63;63;63;64 16:38:57 INFO - PROCESS | 21753 | |10;stanford-crypto-aes;80;75;76;82;77;84;76;80;77;76 16:38:57 INFO - PROCESS | 21753 | |11;stanford-crypto-ccm;127;125;125;125;133;122;125;123;164;122 16:38:57 INFO - PROCESS | 21753 | |12;stanford-crypto-pbkdf2;162;166;159;162;162;172;163;162;159;160 16:38:57 INFO - PROCESS | 21753 | |13;stanford-crypto-sha256-iterative;65;65;66;64;67;65;64;66;67;64 16:38:57 INFO - PROCESS | 21753 | __end_tp_report 16:38:57 INFO - PROCESS | 21753 | __start_cc_report 16:38:57 INFO - PROCESS | 21753 | _x_x_mozilla_cycle_collect,854 16:38:57 INFO - PROCESS | 21753 | __end_cc_report 16:38:57 INFO - PROCESS | 21753 | __startTimestamp1470181137723__endTimestamp 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | ------- Summary: start ------- 16:38:57 INFO - PROCESS | 21753 | Number of tests: 14 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.78 (3.4%) stddev-sans-first:2.50 16:38:57 INFO - PROCESS | 21753 | Values: 103.0 116.0 107.0 112.0 113.0 114.0 114.0 112.0 111.0 112.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:149.50 stddev:21.74 (14.5%) stddev-sans-first:22.83 16:38:57 INFO - PROCESS | 21753 | Values: 153.0 124.0 147.0 177.0 122.0 142.0 152.0 126.0 179.0 120.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.32 (1.4%) stddev-sans-first:2.40 16:38:57 INFO - PROCESS | 21753 | Values: 162.0 163.0 164.0 161.0 162.0 167.0 168.0 164.0 162.0 162.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#3] audio-fft Cycles:10 Average:98.50 Median:76.00 stddev:47.76 (62.8%) stddev-sans-first:49.96 16:38:57 INFO - PROCESS | 21753 | Values: 76.0 76.0 75.0 184.0 76.0 76.0 77.0 76.0 194.0 75.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.50 stddev:29.28 (34.6%) stddev-sans-first:30.35 16:38:57 INFO - PROCESS | 21753 | Values: 85.0 84.0 153.0 84.0 85.0 85.0 144.0 84.0 85.0 137.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 16:38:57 INFO - PROCESS | 21753 | Values: 117.0 117.0 118.0 117.0 119.0 117.0 118.0 119.0 117.0 117.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:38:57 INFO - PROCESS | 21753 | Values: 147.0 147.0 148.0 146.0 148.0 147.0 148.0 148.0 148.0 146.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:38:57 INFO - PROCESS | 21753 | Values: 96.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:2.51 (4.8%) stddev-sans-first:2.60 16:38:57 INFO - PROCESS | 21753 | Values: 51.0 51.0 52.0 57.0 51.0 52.0 53.0 57.0 51.0 50.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 16:38:57 INFO - PROCESS | 21753 | Values: 62.0 65.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:3.02 (3.8%) stddev-sans-first:3.14 16:38:57 INFO - PROCESS | 21753 | Values: 80.0 75.0 76.0 82.0 77.0 84.0 76.0 80.0 77.0 76.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:125.00 stddev:12.66 (10.1%) stddev-sans-first:13.41 16:38:57 INFO - PROCESS | 21753 | Values: 127.0 125.0 125.0 125.0 133.0 122.0 125.0 123.0 164.0 122.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.00 stddev:3.86 (2.4%) stddev-sans-first:4.09 16:38:57 INFO - PROCESS | 21753 | Values: 162.0 166.0 159.0 162.0 162.0 172.0 163.0 162.0 159.0 160.0 16:38:57 INFO - PROCESS | 21753 | 16:38:57 INFO - PROCESS | 21753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.16 (1.8%) stddev-sans-first:1.22 16:38:57 INFO - PROCESS | 21753 | Values: 65.0 65.0 66.0 64.0 67.0 65.0 64.0 66.0 67.0 64.0 16:38:57 INFO - PROCESS | 21753 | -------- Summary: end -------- 16:38:57 INFO - PROCESS | 21753 | 16:38:58 INFO - TEST-INFO | 21753: exit 0 16:38:58 INFO - TEST-OK | kraken | took 62073ms 16:38:58 INFO - SUITE-END | took 1175s 16:38:58 INFO - Completed test suite (00:19:35) 16:38:58 INFO - javascript benchmark 16:38:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7583.009600377762, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.0172744721685, 3091.4126315999943, 3115.610548681415, 3120.1107684309977, 3120.9063728088167, 5293.100172970595, 5393.4067252602235, 5437.238786569878, 5449.783569146049, 5487.670739755617, 5421.593380496469, 5481.287432633752, 5486.506214440699, 5500.862478438041, 5503.9174412383845, 4921.212605983043, 4954.355933728611, 4975.626827987898, 5010.248462730601, 5051.7726702298305, 4932.630052746041, 4968.875778105558, 5027.944131732341, 5032.57223136032, 5072.797088116489, 5079.695218286896, 5081.84754457365, 5092.108880945838, 5094.337736094302, 5097.311862898517, 4870.439899411542, 4881.072596206709, 4905.828296009622, 4943.777530011158, 4947.356843610343, 4852.102361063215, 4869.172240719086, 4876.512348765095, 4936.333594964705, 4948.257761335828, 5359.303290572239, 5380.058489764276, 5392.0, 5402.216678581623, 5404.32445944257, 5689.260396148474, 5791.65250084992, 5800.7679692812235, 5816.069428891399, 5843.824685259449, 5870.7945221917025, 5901.940980590182, 5916.290045194604, 5939.613925094855, 5994.430529099728, 5480.671159730429, 5483.451654834525, 5485.0, 5487.314085739283, 5501.037318469252, 5749.482546570829, 5847.327557330961, 5889.469947704727, 5904.114382842608, 6027.517798576104, 5676.489115979582, 5680.914786278209, 5687.061634830289, 5694.288213973254, 5722.227499287626, 5745.368009518949, 5755.482006619424, 5758.88482230353, 5762.88474230513, 5771.278590176228, 5615.213870058195, 5723.313202415654, 5724.570657200727, 5779.046457334577, 5807.448292412214, 5638.238837756932, 5784.88430231393, 5837.649741015468, 5852.678102704393, 5895.204147440127, 4456.175607512556, 4500.482444518922, 4512.842050528216, 4519.118771839526, 4555.2711566149255, 3916.8433262669173, 3943.4873466449753, 3989.740666856645, 4035.757854528738, 4053.452783874139, 5557.638753481011, 5569.415211402745, 5598.328200615871, 5654.236678048411, 5654.264945557134, 5832.825015249549, 5869.706514674249, 5871.412858714094, 5882.941170588239, 5887.911681324784, 5439.864003399946, 5482.2873026506295, 5579.944200557942, 5598.356189038232, 5607.607467477237, 4947.628927830355, 4984.127777638899, 4986.326845875833, 5032.72320022395, 5033.471485494044, 6007.729652165663, 6024.277086749618, 6025.66858822769, 6033.879322413527, 6048.727807248684, 5693.715314234355, 5819.272590926134, 5826.650400975955, 5838.503727183237, 5843.474087332161, 6029.57792954489, 6095.952232173902, 6096.738354098959, 6119.533019689948, 6132.176708110278, 5755.395683453177, 5788.507976821849, 5803.970980145241, 5806.1000544915605, 5826.300843898759, 5745.540356771532, 5840.883182336244, 5862.501687356623, 5905.084711869667, 5925.1704761332585, 5674.546036317002, 5780.971095144498, 5784.190213370048, 5827.737751801094, 5834.94165058361, 5686.2607860977805, 5727.570432217517, 5737.942620573741, 5760.740766665594, 5761.8764340954785, 5422.6475279106735, 5492.0663487206475, 5679.318481782213, 5695.686737229492, 5704.172894930295, 5710.114932185518, 5809.680467574155, 5828.0966450200285, 5833.387494313036, 5868.94131058701, 5577.581681373832, 5629.943700562942, 5671.716414179192, 5673.035583950656, 5689.886202276014], "value": 5381.66084348916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8506348020912, 579.7941730685607, 581.5522048023022, 597.0715537339438, 632.9936700632992, 39392.60607393925, 43215.78392108039, 43249.56750432499, 43261.56738432615, 43428.3485747714, 43853.56146438535, 44450.0, 44497.55502444974, 44624.776876115575, 44752.77623611886, 8785.297176225902, 8830.735077947671, 8866.157715017063, 8906.688265910694, 8910.50992195429, 8874.911250887473, 8898.466092034467, 8899.95550022249, 8902.931648202224, 8948.642054317852, 8891.911080889206, 8912.509811960339, 8953.641854325819, 8954.686585969492, 8991.685291014815, 8894.421862578944, 8910.376273660846, 8925.19673229406, 8968.730938071803, 8976.775580610505, 8761.56192190388, 8767.254783343424, 8791.956040219759, 8826.646934122627, 8834.86747698785, 35186.296274074375, 35387.469187962204, 35411.82294088539, 35441.82279088588, 35569.82215088908, 3397.159962396705, 3500.7199424046016, 3502.614712381636, 3601.963980360189, 3630.2557975614936, 31850.840745796122, 33057.33885322304, 34539.82730086359, 34543.13642158941, 34583.4812477813, 4129.339305711072, 4328.935065974013, 4336.544662810391, 4353.717008394444, 4467.352233926095, 391766.0, 394951.0, 396988.0, 397219.0, 397248.0, 64695.67652161709, 65024.674876625315, 65201.34798652048, 65553.34446655567, 65716.67141664261, 69354.65322673354, 69465.0, 69491.0, 69636.6518167416, 69778.65110674415, 14432.639184020274, 14737.0, 14751.77872331916, 14988.100713957198, 15027.924860375628, 11154.386508741934, 11292.322460652387, 11293.491792869341, 11295.943520282346, 11333.603323883624, 20865.47836304074, 20894.37316880496, 20942.37172884816, 20952.580948380946, 21215.36353909385, 7786.7663970080985, 7952.522848629101, 8005.919940800634, 8070.354371650254, 8350.415470916978, 976.941383516977, 1041.3335465302212, 1079.9514021868877, 1136.1308598921833, 1142.5886680794906, 34051.0, 34102.0, 34132.0, 34199.82900085534, 34644.48033279503, 1048.9423081730579, 1079.3918499962735, 1175.7413369058793, 1195.246994393544, 1243.9004879609608, 16323.34706611746, 17335.65328693419, 17468.301267949395, 17483.56291092733, 17522.0, 600033.0, 604265.0, 605410.0, 606407.0, 607754.0, 60419.35387107415, 60880.391196088356, 60956.695216523636, 61146.38853611496, 61227.69386153041, 1310.6592286005707, 1328.7807511760645, 1374.5120482228665, 1377.125525291427, 1377.5247539599022, 31321.216969575944, 32106.35787284288, 32646.34707305888, 32773.31482692629, 33117.503237450976, 49884.25173622471, 49891.25163122629, 49906.0, 50012.74993625009, 50350.0, 491416.0, 491671.0, 493396.0, 493442.0, 493957.0, 30060.09819705412, 30131.0, 30513.0, 30530.84734576313, 30604.234894127825, 49660.25509617286, 50185.49814501954, 50313.0, 51184.48815511797, 51318.230226545886, 41701.58298416977, 42609.78695106505, 43454.0, 43706.78146609246, 44760.552394475635, 42218.36672449977, 43151.53686179682, 43242.783786080865, 43287.0, 43688.56311436972, 42740.78629606832, 43024.78487607542, 43239.35140972825, 43785.0, 45604.0, 34061.82969085139, 37289.44065839069, 38558.42162367511, 39237.8038109819, 40336.39495407513, 28075.859620702584, 29431.26421839471, 29486.705132948395, 29649.25876853096, 30152.0], "value": 20679.828663003816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.7897716767195, 392.6976228304206, 394.964453199212, 397.0807580451257, 419.0738467985751, 13910.791338129937, 18469.35357262496, 19472.12375443105, 20278.69581956272, 20290.39128826136, 19282.421527354167, 19356.3225287115, 19516.51208719783, 19833.801661983376, 19945.401637950883, 5547.223388725582, 5729.3411257705375, 5782.884342313151, 5854.707264636772, 5953.821385358425, 5822.7088645567765, 5851.0, 5852.12218167274, 5882.5588080893895, 5886.970565147169, 5759.3376761672525, 5817.8836423271505, 5835.649861008353, 5876.882462350751, 5881.3530511643685, 5916.3787802280785, 6828.453723702117, 7116.43068554517, 7123.679434425463, 7173.6413179340825, 6645.269020407752, 6900.689468973908, 7059.8588028239665, 7108.644567771643, 7171.820704482378, 24878.253652390456, 26350.209493715218, 26647.733522664912, 27119.593206101923, 27393.178204653894, 2547.5796493578537, 2724.2372135802007, 2837.3474100956687, 2872.0091568409075, 2888.3645597968625, 15743.370265189378, 15932.681346373007, 16018.5995350116, 16254.918725406416, 17032.82967170325, 2026.3211824038817, 2065.8450616203695, 2071.7099606055162, 2076.512019675375, 2176.945576360604, 93428.0, 93739.53130234373, 93779.0, 95621.5218923901, 95994.52002739941, 16894.0, 17016.149192540324, 17737.556561085818, 17829.375971840924, 18045.819541804678, 32021.679783202337, 32081.839590801897, 32096.0, 32123.51814722781, 32136.678633213836, 8955.955220223857, 9114.407563508483, 9160.0, 9344.906550934404, 9450.33847630673, 7526.811829704192, 7603.429742769204, 7788.766337009899, 7818.530888146729, 7831.804204894923, 8746.157498812783, 9175.0, 9240.722778316662, 9306.767330816783, 9417.233106757214, 3191.792533485316, 3402.8128452935325, 3516.5933626549586, 3632.2372301816913, 3651.744377893522, 954.3844220477753, 1047.120418848156, 1068.3589846092282, 1069.0, 1102.8420158833194, 20112.698309525367, 20422.489437764176, 20619.58760824805, 20653.690194647093, 20768.68846967297, 1019.6533178719271, 1038.678009816959, 1057.5558265528343, 1062.3201151263197, 1072.8766191888033, 10701.83947240792, 11580.420978951019, 11627.360495172847, 11644.602647682332, 11666.416679166008, 457552.0, 464774.0, 465416.0, 467525.0, 467689.9846502305, 55862.0, 78650.21349786544, 94799.0, 95182.52408737912, 98651.0, 933.4306073295285, 980.3235767320526, 983.0759086458706, 996.7956568903357, 1009.3842755918884, 17082.829171708123, 17601.647967040844, 18270.543236419195, 18408.63182736311, 18477.53806154857, 40554.79722601368, 41838.79080604578, 42461.57538424576, 44320.0, 44382.77808610936, 58694.0, 60380.69809651099, 60682.39317606767, 60917.0, 61552.69223653853, 8379.203975622306, 8578.227959483676, 8725.21473067427, 8727.301815854844, 8914.28685705155, 13444.932775336061, 13577.932110339385, 13720.176789392668, 13889.097208681404, 14127.293635318398, 11863.58477453285, 12008.579699710468, 12083.154179207722, 12219.75560488803, 12269.325187114437, 11380.089592832719, 11689.649310520697, 12023.939880300542, 12064.939675301568, 12435.253884766942, 11525.942370288094, 11539.307641541534, 12136.878631213927, 12184.147109702235, 12314.322712250554, 8630.482171069756, 8668.252080856273, 8772.210501054935, 8798.296136309207, 8939.955300223457, 10595.311304765166, 11673.766524669629, 11718.824217636913, 11731.0, 12601.936990314989], "value": 10387.03673076066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.0, 1482.733108040553, 1619.9514014579559, 1759.780027496563, 1762.4272111563737, 8127.065387480441, 8758.12418758124, 8839.823203535925, 9502.52487375632, 9521.904780952196, 8875.0, 9212.49331286779, 9248.4913329767, 9251.44491330519, 9280.4431734096, 2353.6940197774265, 2398.1726304424947, 2404.230646193219, 2407.16952651335, 2419.0323870451784, 2355.634876594122, 2358.1039205102124, 2446.3517167950417, 2447.9265622031367, 2456.668349772776, 2386.809055275574, 2400.987995060022, 2413.553492603874, 2448.375664205634, 2458.397692565315, 2379.1791831817995, 2388.6775285336516, 2393.784559389663, 2397.0292031727176, 2423.563758523465, 2344.5193735284224, 2358.092134528219, 2361.8582885026954, 2376.7266764322153, 2399.940001499959, 9128.863067053999, 9253.0, 9277.304202184863, 9322.347435679505, 9357.76605584859, 5243.2659427680155, 5373.865653358658, 5377.892442151174, 5381.704006279653, 5382.542483888874, 3590.138366791977, 3601.2617413430185, 3626.7823930563986, 3689.520362352877, 3689.9262014759825, 1224.369449733388, 1250.9874901251053, 1253.1165528302524, 1294.1911305434103, 1305.673581604599, 13149.737005259936, 13204.801927971088, 13228.603141905662, 13230.933845330808, 13250.337483125708, 4653.951661661617, 4831.347768051339, 4843.854684359475, 4913.238448040559, 4982.526659967298, 10870.18473614482, 10929.071028962468, 10959.671209863716, 10977.176711746652, 10986.725331866768, 5570.637908535932, 5576.6096373254295, 5585.944140558624, 5614.775408983595, 5616.0, 4291.74249545022, 4861.80552777892, 4868.172410690191, 4890.706557606555, 5033.748312584356, 4130.791867441449, 4155.397467367276, 4164.937525937114, 4201.451139507057, 4418.116376724668, 1334.2728213123871, 1356.4438580182077, 1357.8981576381811, 1365.706373129782, 1379.827521559805, 875.4747151708924, 995.8307087795092, 1011.2971484817981, 1024.702836177515, 1028.3572767020612, 6179.3202747697715, 6189.783357582463, 6289.685515724195, 6355.5551111421755, 6674.2658307586125, 992.0823238504355, 1048.397171626318, 1113.2763703592568, 1117.5138814615668, 1127.5454663484177, 4289.549597292239, 4300.80646370914, 4464.598186163196, 4507.729536227836, 4556.70381425213, 11366.261193022427, 11614.535418583162, 11677.591284305008, 11700.06399488056, 11756.823647645293, 11547.884521154849, 11596.652100437, 11611.6516504505, 11635.709107272385, 11636.069114470822, 8206.548639824867, 8470.872936905827, 8503.532305723245, 8591.226789588967, 8779.078196789245, 6249.687515624291, 6253.937460625336, 6373.3945275198785, 6396.232452105777, 6450.709718062604, 10608.0, 10686.625968091079, 10721.927807219216, 10776.67669969902, 10802.783944320912, 10645.201609879136, 10680.412577308012, 10719.678409647411, 10733.624323148651, 10792.784144316913, 8180.263776260165, 8228.50628962264, 8333.2916702081, 8385.916140838757, 8408.117147699404, 8990.056044115274, 9002.054784247559, 9025.503597302211, 9039.819203616022, 9064.456132632064, 7921.762347129596, 8049.557274349967, 8116.472429292077, 8186.54973976437, 8374.790630234049, 8075.273225409741, 8111.553864537507, 8112.391570632344, 8144.714934977247, 8242.0, 7309.013283206912, 7385.630718463948, 7417.332440080419, 7536.811579710551, 7626.54240745557, 5558.91661625084, 5647.943520564741, 5655.406182350958, 5680.744366503434, 5807.0998995155815, 5604.439556044363, 5617.185508101385, 5763.020286551213, 5913.852153696192, 5920.052791553331], "value": 4915.157092776648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.0884895745042, 327.2685547800665, 330.3508605590015, 333.62967106511775, 333.8063922924704, 5481.397046324901, 5524.696141712204, 5606.523445507137, 5616.663000219979, 5622.971885140573, 5495.093309603911, 5495.368032676243, 5499.1476321170185, 5504.834854954348, 5540.3628582713, 4135.751854888709, 4205.453291072156, 4299.140171965604, 4299.50555686097, 4312.417823593806, 4269.146170765859, 4277.465316835395, 4306.310990241562, 4319.911263446635, 4321.913561728764, 4260.3822445745345, 4290.54949230331, 4292.270314046619, 4296.505901821283, 4317.352397140438, 4065.451164092854, 4218.936715949263, 4251.6173544380845, 4286.914261714779, 4306.846576711644, 3716.6097559756377, 3731.738778285521, 3741.120836603396, 3741.345264578715, 3748.9437658435145, 5464.754086066137, 5476.26070480484, 5487.560995120421, 5492.945070549284, 5498.532624726903, 4787.593054590364, 4804.23132298834, 4845.3216549683075, 4847.781849816767, 4868.537488938545, 5696.658200507983, 5701.74780961522, 5747.626404283708, 5765.913511297334, 5795.913061304083, 4024.9195016099807, 4030.7984600769846, 4034.4150098235887, 4037.7375470594316, 4039.5354534228354, 5851.61964472308, 5989.903533763191, 6013.428724271231, 6016.127661489103, 6029.216201893726, 4162.313218319004, 4181.644560212355, 4198.732684350417, 4210.915781684349, 4224.197402493516, 4246.808893599796, 4266.978665106654, 4267.274563324242, 4269.765162916007, 4271.654428854901, 4712.764361781898, 4849.975750121227, 4875.000624871893, 4906.0, 4926.679765815282, 5744.712764361765, 5764.625299355528, 5775.209684997664, 5842.415758424208, 5880.206172166788, 1463.0270869871629, 1465.5090544667441, 1473.4990103364694, 1476.468471350313, 1479.9556013319402, 916.0884919505135, 931.9813603727888, 934.5654270764128, 936.5879013234292, 941.6892425499568, 4850.660453768202, 4881.389826271716, 4951.72765497901, 4988.775505102279, 5005.9749701251985, 5183.134071734173, 5218.895622087537, 5253.816116435906, 5277.129273669878, 5305.628605997543, 4960.751962401938, 4991.900161996739, 5013.623978201649, 5209.322788037531, 5641.915371269434, 3154.022253101546, 3155.495120780664, 3191.68083191679, 3191.9361612767616, 3192.56900318454, 6038.826022631849, 6092.3603021682975, 6221.36050410515, 6230.352100357421, 6256.280527739368, 5990.9101363479585, 6022.09668549721, 6037.6679282639, 6111.51107911366, 6142.232220972379, 6263.592866463757, 6272.18461599989, 6280.277768056732, 6283.6858157091965, 6288.9056664150075, 5806.129080637938, 5891.764329426775, 5910.970445147918, 5946.851328716643, 5949.66132620157, 5872.500837428866, 5892.587518873637, 5906.320773111147, 5914.4381283777975, 5937.0, 6068.362821903813, 6190.442860142609, 6195.31851496326, 6213.813585592258, 6229.875402492015, 4134.772587507596, 4144.0, 4160.105577300895, 4165.854195103157, 4185.953511622094, 5896.793612223723, 5912.586118971631, 5937.34689184198, 5999.730012149376, 6024.969875150597, 5601.103823388238, 5629.296337957755, 5780.190773291826, 5791.681457519877, 5853.0, 5760.308762948473, 5797.304323481209, 5828.475437210502, 5849.3858144894175, 5859.414058594107, 5502.944970550243, 5634.295713035871, 5682.460166284196, 5781.537477001913, 5816.563757718103, 5763.538916886723, 5775.27809023872, 5782.537397008314, 5833.212516310244, 5891.469767720926, 5708.286464191976, 5728.651252986422, 5732.598718089694, 5760.222369979999, 5776.740046697824], "value": 4362.138229206183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.4454936522924, 742.0687037767605, 744.0699126092385, 745.0277388008647, 776.763087258386, 16015.0, 16793.412230571932, 17087.57281067974, 17289.30842766288, 17297.308107675693, 15705.450309239179, 15924.12417317047, 15925.681486370266, 15980.0, 16023.519294421187, 801.8396320735861, 814.8411059843332, 815.0463957170095, 816.4285000499644, 821.2198411509061, 790.9169537198597, 799.9280064794167, 806.4919100966383, 808.737160422862, 838.7986883148061, 847.9152084791502, 853.8164294676643, 855.2260204514924, 856.1181982557976, 856.7001549457702, 849.227203245044, 849.5667209723055, 850.8978922529274, 851.6167724523958, 852.2457625001856, 617.7065893700501, 618.4773866083152, 619.1115748900297, 619.8419403052238, 620.6090163197202, 16164.353425862952, 16169.676606467923, 16177.83822161775, 16191.0, 16200.43298484559, 15335.30991105403, 15493.147876866768, 15633.218339083, 15686.607834804106, 15859.286332115082, 12703.364831758468, 12812.231266124063, 12930.48278068876, 13149.60551183466, 13395.933020334933, 3880.204558065618, 3888.591697871739, 3970.325044742372, 4044.2315959967514, 4046.0, 84377.57811210904, 85908.0, 85945.57027214886, 86411.13588864157, 86469.0, 10647.414392208348, 11739.765204695857, 11905.226160299553, 11952.701182470333, 12100.757984840255, 20411.387658370273, 21836.0, 21875.234366797085, 21910.671339929915, 21919.561608767734, 8289.4197406181, 8303.667853285922, 8509.914900851036, 8678.262347700516, 8737.475751454933, 4835.419749630067, 4873.415190177201, 4908.730019848943, 5009.423916249678, 5087.516685914832, 3539.2036791721657, 3663.8351274192723, 3666.8533258669886, 3672.081979505124, 3690.2619476104887, 582.5368831778746, 585.2012003615035, 598.6587645042284, 599.7541008186622, 613.0773186354508, 643.2281262485037, 652.1587152573222, 669.8626781509779, 680.3570625758709, 697.8081027717418, 10047.899521004843, 10189.082982531607, 10532.526036328383, 10618.309809862334, 10640.148788097089, 556.8023351710166, 565.9727594416122, 618.3653516890842, 705.9682314295869, 710.7903168565285, 4719.811207551728, 4930.926036109461, 5040.571551418097, 5106.897862042812, 5149.2791009258735, 74287.0, 74414.62792686002, 117586.41206793912, 127435.0, 127689.36155319349, 65254.34745652578, 92123.0, 104899.475502622, 107692.46153769181, 110361.0, 54550.454495455335, 54920.72539637276, 56642.150367744514, 74935.62532187304, 85491.57254213688, 10188.541515631963, 10990.835137473105, 11000.449977500934, 11112.111031117653, 11155.442227888736, 40275.194496109325, 48252.0, 50230.246546302566, 53927.730361347945, 54724.45275547194, 69578.65210674117, 76177.61911190409, 76562.0, 77112.2288777105, 78577.0, 12820.871791281968, 12966.938174535077, 13021.869781302066, 13482.258475783927, 13581.524646637321, 14942.248696058869, 15001.699966000837, 15103.54689359321, 15156.393744250106, 15855.0, 14439.398988366815, 14811.703765924836, 14960.551183464513, 14983.40066397332, 15232.466863659718, 14241.928790355982, 14596.782584138742, 14658.560243192722, 14825.332860021541, 15292.0, 13306.401211945293, 13602.319884005958, 13842.584722458343, 13901.791473128114, 14205.928970355495, 10847.457627118454, 10873.293235939638, 11062.336259824437, 11357.886421135683, 11758.823617645914, 10383.428911409945, 10805.405702686114, 12108.878911210775, 12327.630171094881, 12714.11001229942], "value": 7670.319855462183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 107.0, 112.0, 113.0, 114.0, 114.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 147.0, 177.0, 122.0, 142.0, 152.0, 126.0, 179.0, 120.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 161.0, 162.0, 167.0, 168.0, 164.0, 162.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 184.0, 76.0, 76.0, 77.0, 76.0, 194.0, 75.0], "value": 98.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 153.0, 84.0, 85.0, 85.0, 144.0, 84.0, 85.0, 137.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 119.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 148.0, 148.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 57.0, 51.0, 52.0, 53.0, 57.0, 51.0, 50.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 82.0, 77.0, 84.0, 76.0, 80.0, 77.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 125.0, 125.0, 133.0, 122.0, 125.0, 123.0, 164.0, 122.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 159.0, 162.0, 162.0, 172.0, 163.0, 162.0, 159.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 67.0, 65.0, 64.0, 66.0, 67.0, 64.0], "value": 65.3, "unit": "score"}]}]} 16:38:58 INFO - Return code: 0 16:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:38:59 ERROR - # TBPL SUCCESS # 16:38:59 INFO - Running post-action listener: _resource_record_post_action 16:38:59 INFO - [mozharness: 2016-08-02 23:38:59.017173Z] Finished run-tests step (success) 16:38:59 INFO - Running post-run listener: _resource_record_post_run 16:38:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331886592; Read time: 12; Write time: 177056 16:38:59 INFO - TinderboxPrint: CPU usage
13.3% 16:38:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:38:59 INFO - TinderboxPrint: I/O write bytes / time
331,886,592 / 177,056 16:38:59 INFO - TinderboxPrint: CPU idle
8,247.9 (86.6%) 16:38:59 INFO - TinderboxPrint: CPU user
1,213.7 (12.8%) 16:38:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:38:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14028800; Read time: 0; Write time: 2716 16:38:59 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290971648; Read time: 0; Write time: 145892 16:38:59 INFO - Running post-run listener: _upload_blobber_files 16:38:59 INFO - Blob upload gear active. 16:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:38:59 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 16:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:00 INFO - (blobuploader) - INFO - Done attempting. 16:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:04 INFO - (blobuploader) - INFO - Done attempting. 16:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:06 INFO - (blobuploader) - INFO - Done attempting. 16:39:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:06 INFO - Return code: 0 16:39:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7579feb830e6c05fbaafadd10575afea77cef18e3cf8216ecd2c323f328480f621867e750222bc111bd2791010ac9798cd886a2cfa20a53ed7feba9ea3842f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13fff281b7a394a96ed3a1ded7d369e6bde2d593c97258fb4383f56e09d0c55d1e36b491fc25019946c88182b219c70cfecce3485d86c9ae6555f7065d232a1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e017152e821eeb0aa8e3a01bd5add7880a03ec8fe39b6c55b812f360d7149064f5a4e5b3c66e1e898d010e1ed56ec917afa90fd88262706c47563082a9bbe25b"} 16:39:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:06 INFO - Contents: 16:39:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7579feb830e6c05fbaafadd10575afea77cef18e3cf8216ecd2c323f328480f621867e750222bc111bd2791010ac9798cd886a2cfa20a53ed7feba9ea3842f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13fff281b7a394a96ed3a1ded7d369e6bde2d593c97258fb4383f56e09d0c55d1e36b491fc25019946c88182b219c70cfecce3485d86c9ae6555f7065d232a1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e017152e821eeb0aa8e3a01bd5add7880a03ec8fe39b6c55b812f360d7149064f5a4e5b3c66e1e898d010e1ed56ec917afa90fd88262706c47563082a9bbe25b"} 16:39:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:06 INFO - Copying logs to upload dir... 16:39:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.537989 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-02 16:39:05.823023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 16:39:05.827389) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7579feb830e6c05fbaafadd10575afea77cef18e3cf8216ecd2c323f328480f621867e750222bc111bd2791010ac9798cd886a2cfa20a53ed7feba9ea3842f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13fff281b7a394a96ed3a1ded7d369e6bde2d593c97258fb4383f56e09d0c55d1e36b491fc25019946c88182b219c70cfecce3485d86c9ae6555f7065d232a1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e017152e821eeb0aa8e3a01bd5add7880a03ec8fe39b6c55b812f360d7149064f5a4e5b3c66e1e898d010e1ed56ec917afa90fd88262706c47563082a9bbe25b"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470169830/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7579feb830e6c05fbaafadd10575afea77cef18e3cf8216ecd2c323f328480f621867e750222bc111bd2791010ac9798cd886a2cfa20a53ed7feba9ea3842f79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13fff281b7a394a96ed3a1ded7d369e6bde2d593c97258fb4383f56e09d0c55d1e36b491fc25019946c88182b219c70cfecce3485d86c9ae6555f7065d232a1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e017152e821eeb0aa8e3a01bd5add7880a03ec8fe39b6c55b812f360d7149064f5a4e5b3c66e1e898d010e1ed56ec917afa90fd88262706c47563082a9bbe25b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 16:39:05.855729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:39:05.856151) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470174395.666633-1443063928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:39:05.940034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 16:39:05.940496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 16:39:05.940936) ========= ========= Total master_lag: 0.19 =========