builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1469596730.05 results: success (0) buildid: 20160726192237 builduid: 4f95ce8bfc254a498170c65802f9f4b7 revision: eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.052266) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.053204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.053872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.069505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.069833) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 22:18:50-- 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% 29.3M=0s 2016-07-26 22:18:50 (29.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.164865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.165636) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.219406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.220211) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 --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 eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 --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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 22:18:50,811 truncating revision to first 12 chars 2016-07-26 22:18:50,811 Setting DEBUG logging. 2016-07-26 22:18:50,811 attempt 1/10 2016-07-26 22:18:50,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/eb74a01c8dc0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 22:18:51,125 unpacking tar archive at: mozilla-inbound-eb74a01c8dc0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.980682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.981065) ========= script_repo_revision: eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.981557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.981865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 22:18:50.992618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-26 22:18:50.992935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:18:51 INFO - MultiFileLogger online at 20160726 22:18:51 in /builds/slave/test 22:18:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:18:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:18:51 INFO - {'append_to_log': False, 22:18:51 INFO - 'base_work_dir': '/builds/slave/test', 22:18:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:18:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:18:51 INFO - 'branch': 'Mozilla-Inbound', 22:18:51 INFO - 'buildbot_json_path': 'buildprops.json', 22:18:51 INFO - 'config_files': ('talos/linux_config.py',), 22:18:51 INFO - 'default_actions': ('clobber', 22:18:51 INFO - 'read-buildbot-config', 22:18:51 INFO - 'download-and-extract', 22:18:51 INFO - 'populate-webroot', 22:18:51 INFO - 'create-virtualenv', 22:18:51 INFO - 'install', 22:18:51 INFO - 'run-tests'), 22:18:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:18:51 INFO - 'download_minidump_stackwalk': True, 22:18:51 INFO - 'download_symbols': 'ondemand', 22:18:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:18:51 INFO - 'tooltool.py': '/tools/tooltool.py', 22:18:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:18:51 INFO - '/tools/misc-python/virtualenv.py')}, 22:18:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:18:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:18:51 INFO - 'installer_path': 'installer.exe', 22:18:51 INFO - 'log_level': 'info', 22:18:51 INFO - 'log_name': 'talos', 22:18:51 INFO - 'log_to_console': True, 22:18:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:18:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:18:51 INFO - 'opt_config_files': (), 22:18:51 INFO - 'pip_index': False, 22:18:51 INFO - 'sps_profile': False, 22:18:51 INFO - 'sps_profile_interval': 0, 22:18:51 INFO - 'suite': 'dromaeojs', 22:18:51 INFO - 'system_bits': '32', 22:18:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:18:51 INFO - 'title': 'talos-linux64-ix-004', 22:18:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:18:51 INFO - 'use_talos_json': True, 22:18:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:18:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:18:51 INFO - 'work_dir': 'build'} 22:18:51 INFO - [mozharness: 2016-07-27 05:18:51.668999Z] Running clobber step. 22:18:51 INFO - Running pre-action listener: _resource_record_pre_action 22:18:51 INFO - Running main action method: clobber 22:18:51 INFO - rmtree: /builds/slave/test/build 22:18:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:18:52 INFO - Running post-action listener: _resource_record_post_action 22:18:52 INFO - [mozharness: 2016-07-27 05:18:52.145452Z] Finished clobber step (success) 22:18:52 INFO - [mozharness: 2016-07-27 05:18:52.145553Z] Running read-buildbot-config step. 22:18:52 INFO - Running pre-action listener: _resource_record_pre_action 22:18:52 INFO - Running main action method: read_buildbot_config 22:18:52 INFO - Using buildbot properties: 22:18:52 INFO - { 22:18:52 INFO - "project": "", 22:18:52 INFO - "product": "firefox", 22:18:52 INFO - "script_repo_revision": "production", 22:18:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:18:52 INFO - "repository": "", 22:18:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:18:52 INFO - "buildid": "20160726192237", 22:18:52 INFO - "pgo_build": "True", 22:18:52 INFO - "basedir": "/builds/slave/test", 22:18:52 INFO - "buildnumber": 1406, 22:18:52 INFO - "slavename": "talos-linux64-ix-004", 22:18:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:18:52 INFO - "platform": "ubuntu64_hw", 22:18:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:18:52 INFO - "branch": "mozilla-inbound", 22:18:52 INFO - "repo_path": "integration/mozilla-inbound", 22:18:52 INFO - "revision": "eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19", 22:18:52 INFO - "stage_platform": "linux64-pgo", 22:18:52 INFO - "builduid": "4f95ce8bfc254a498170c65802f9f4b7", 22:18:52 INFO - "slavebuilddir": "test" 22:18:52 INFO - } 22:18:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:18:52 INFO - Running post-action listener: _resource_record_post_action 22:18:52 INFO - [mozharness: 2016-07-27 05:18:52.148029Z] Finished read-buildbot-config step (success) 22:18:52 INFO - [mozharness: 2016-07-27 05:18:52.148120Z] Running download-and-extract step. 22:18:52 INFO - Running pre-action listener: _resource_record_pre_action 22:18:52 INFO - Running main action method: download_and_extract 22:18:52 INFO - mkdir: /builds/slave/test/build/tests 22: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')]} 22:18:52 INFO - https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:18:52 INFO - Downloaded 1361 bytes. 22:18:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:18:52 INFO - Using the following test package requirements: 22:18:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:18:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:18:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'jsshell-linux-x86_64.zip'], 22:18:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:18:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:18:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:18:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:18:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:18:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22: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')]} 22:18:52 INFO - https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:18:53 INFO - Downloaded 24349542 bytes. 22:18:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:18:54 INFO - Return code: 0 22:18:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22: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')]} 22:18:54 INFO - https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:18:55 INFO - Downloaded 24349542 bytes. 22:18:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:18:57 INFO - Return code: 0 22:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:57 INFO - https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:18:58 INFO - Downloaded 14403317 bytes. 22:18:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:18:58 INFO - Return code: 0 22: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')]} 22:18:58 INFO - https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:18:59 INFO - Downloaded 60887155 bytes. 22:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:18:59 INFO - mkdir: /builds/slave/test/properties 22:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 22:18:59 INFO - Contents: 22:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:19:00 INFO - Running post-action listener: _resource_record_post_action 22:19:00 INFO - Running post-action listener: set_extra_try_arguments 22:19:00 INFO - [mozharness: 2016-07-27 05:19:00.491950Z] Finished download-and-extract step (success) 22:19:00 INFO - [mozharness: 2016-07-27 05:19:00.492183Z] Running populate-webroot step. 22:19:00 INFO - Running pre-action listener: _resource_record_pre_action 22:19:00 INFO - Running main action method: populate_webroot 22:19:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:19:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:19:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:19:00 INFO - '--tppagecycles', 22:19:00 INFO - '7'], 22:19:00 INFO - 'tests': ['tsvgm']}}, 22:19:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:19:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:19:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:19:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:19:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['damp', 'tps']}, 22:19:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'tests': ['damp', 'tps']}, 22:19:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['dromaeo_dom']}, 22:19:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:19:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['basic_compositor_video']}, 22:19:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:19:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'other-e10s': {'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['a11yr', 22:19:00 INFO - 'ts_paint', 22:19:00 INFO - 'tpaint', 22:19:00 INFO - 'sessionrestore', 22:19:00 INFO - 'sessionrestore_no_auto_restore', 22:19:00 INFO - 'tabpaint']}, 22:19:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['tsvgx', 22:19:00 INFO - 'tsvgr_opacity', 22:19:00 INFO - 'tart', 22:19:00 INFO - 'tscrollx', 22:19:00 INFO - 'cart']}, 22:19:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:19:00 INFO - 'tsvgr_opacity', 22:19:00 INFO - 'tart', 22:19:00 INFO - 'tscrollx', 22:19:00 INFO - 'cart']}, 22:19:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'talos_options': ['--disable-e10s'], 22:19:00 INFO - 'tests': ['tp5o']}, 22:19:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'tests': ['tp5o']}, 22:19:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'talos_options': ['--disable-e10s', 22:19:00 INFO - '--xperf_path', 22:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:00 INFO - 'tests': ['tp5n']}, 22:19:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:00 INFO - 'talos_options': ['--xperf_path', 22:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:00 INFO - 'tests': ['tp5n']}}, 22:19:00 INFO - 'talos.zip': {'path': '', 22:19:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:19:00 INFO - Running post-action listener: _resource_record_post_action 22:19:00 INFO - [mozharness: 2016-07-27 05:19:00.510271Z] Finished populate-webroot step (success) 22:19:00 INFO - [mozharness: 2016-07-27 05:19:00.510361Z] Running create-virtualenv step. 22:19:00 INFO - Running pre-action listener: _resource_record_pre_action 22:19:00 INFO - Running main action method: create_virtualenv 22:19:00 INFO - Creating virtualenv /builds/slave/test/build/venv 22:19:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:19:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:00 INFO - Using real prefix '/usr' 22:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:01 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:03 INFO - Installing pip.................done. 22:19:03 INFO - Return code: 0 22:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:03 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:19:03 INFO - Using env: {'DISPLAY': ':0', 22:19:03 INFO - 'HOME': '/home/cltbld', 22:19:03 INFO - 'LANG': 'en_US.UTF-8', 22:19:03 INFO - 'LANGUAGE': 'en_US:en', 22:19:03 INFO - 'LOGNAME': 'cltbld', 22:19:03 INFO - 'MAIL': '/var/mail/cltbld', 22:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:03 INFO - 'MOZ_NO_REMOTE': '1', 22:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:03 INFO - 'NO_EM_RESTART': '1', 22:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:03 INFO - 'PWD': '/builds/slave/test', 22:19:03 INFO - 'SHELL': '/bin/bash', 22:19:03 INFO - 'SHLVL': '1', 22:19:03 INFO - 'TERM': 'linux', 22:19:03 INFO - 'TMOUT': '86400', 22:19:03 INFO - 'USER': 'cltbld', 22:19:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:03 INFO - '_': '/tools/buildbot/bin/python'} 22:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:19:03 INFO - Cleaning up... 22:19:03 INFO - Return code: 0 22:19:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:03 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:19:03 INFO - Using env: {'DISPLAY': ':0', 22:19:03 INFO - 'HOME': '/home/cltbld', 22:19:03 INFO - 'LANG': 'en_US.UTF-8', 22:19:03 INFO - 'LANGUAGE': 'en_US:en', 22:19:03 INFO - 'LOGNAME': 'cltbld', 22:19:03 INFO - 'MAIL': '/var/mail/cltbld', 22:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:03 INFO - 'MOZ_NO_REMOTE': '1', 22:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:03 INFO - 'NO_EM_RESTART': '1', 22:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:03 INFO - 'PWD': '/builds/slave/test', 22:19:03 INFO - 'SHELL': '/bin/bash', 22:19:03 INFO - 'SHLVL': '1', 22:19:03 INFO - 'TERM': 'linux', 22:19:03 INFO - 'TMOUT': '86400', 22:19:03 INFO - 'USER': 'cltbld', 22:19:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:03 INFO - '_': '/tools/buildbot/bin/python'} 22:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:03 INFO - Downloading/unpacking psutil>=3.1.1 22: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 22: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 22: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 22: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 22: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 22: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 22:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:05 INFO - Installing collected packages: psutil 22:19:05 INFO - Running setup.py install for psutil 22:19:05 INFO - building 'psutil._psutil_linux' extension 22:19:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:19:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:19:05 INFO - building 'psutil._psutil_posix' extension 22:19:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:19:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:06 INFO - Successfully installed psutil 22:19:06 INFO - Cleaning up... 22:19:06 INFO - Return code: 0 22:19:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:19:06 INFO - Using env: {'DISPLAY': ':0', 22:19:06 INFO - 'HOME': '/home/cltbld', 22:19:06 INFO - 'LANG': 'en_US.UTF-8', 22:19:06 INFO - 'LANGUAGE': 'en_US:en', 22:19:06 INFO - 'LOGNAME': 'cltbld', 22:19:06 INFO - 'MAIL': '/var/mail/cltbld', 22:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:06 INFO - 'MOZ_NO_REMOTE': '1', 22:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:06 INFO - 'NO_EM_RESTART': '1', 22:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:06 INFO - 'PWD': '/builds/slave/test', 22:19:06 INFO - 'SHELL': '/bin/bash', 22:19:06 INFO - 'SHLVL': '1', 22:19:06 INFO - 'TERM': 'linux', 22:19:06 INFO - 'TMOUT': '86400', 22:19:06 INFO - 'USER': 'cltbld', 22:19:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:06 INFO - '_': '/tools/buildbot/bin/python'} 22:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:08 INFO - Installing collected packages: mozsystemmonitor 22:19:08 INFO - Running setup.py install for mozsystemmonitor 22:19:08 INFO - Successfully installed mozsystemmonitor 22:19:08 INFO - Cleaning up... 22:19:08 INFO - Return code: 0 22:19:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:19:08 INFO - Using env: {'DISPLAY': ':0', 22:19:08 INFO - 'HOME': '/home/cltbld', 22:19:08 INFO - 'LANG': 'en_US.UTF-8', 22:19:08 INFO - 'LANGUAGE': 'en_US:en', 22:19:08 INFO - 'LOGNAME': 'cltbld', 22:19:08 INFO - 'MAIL': '/var/mail/cltbld', 22:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:08 INFO - 'MOZ_NO_REMOTE': '1', 22:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:08 INFO - 'NO_EM_RESTART': '1', 22:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:08 INFO - 'PWD': '/builds/slave/test', 22:19:08 INFO - 'SHELL': '/bin/bash', 22:19:08 INFO - 'SHLVL': '1', 22:19:08 INFO - 'TERM': 'linux', 22:19:08 INFO - 'TMOUT': '86400', 22:19:08 INFO - 'USER': 'cltbld', 22:19:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:08 INFO - '_': '/tools/buildbot/bin/python'} 22:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:08 INFO - Downloading/unpacking jsonschema==2.5.1 22:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:11 INFO - warning: no files found matching '*.txt' 22:19:11 INFO - no previously-included directories found matching 'build' 22:19:11 INFO - no previously-included directories found matching 'dist' 22:19:11 INFO - no previously-included directories found matching '.git*' 22:19:11 INFO - Installing collected packages: jsonschema, functools32 22:19:11 INFO - Running setup.py install for functools32 22:19:11 INFO - warning: no files found matching '*.txt' 22:19:11 INFO - no previously-included directories found matching 'build' 22:19:11 INFO - no previously-included directories found matching 'dist' 22:19:11 INFO - no previously-included directories found matching '.git*' 22:19:11 INFO - Successfully installed jsonschema functools32 22:19:11 INFO - Cleaning up... 22:19:11 INFO - Return code: 0 22:19:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:11 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:19:11 INFO - Using env: {'DISPLAY': ':0', 22:19:11 INFO - 'HOME': '/home/cltbld', 22:19:11 INFO - 'LANG': 'en_US.UTF-8', 22:19:11 INFO - 'LANGUAGE': 'en_US:en', 22:19:11 INFO - 'LOGNAME': 'cltbld', 22:19:11 INFO - 'MAIL': '/var/mail/cltbld', 22:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:11 INFO - 'MOZ_NO_REMOTE': '1', 22:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:11 INFO - 'NO_EM_RESTART': '1', 22:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:11 INFO - 'PWD': '/builds/slave/test', 22:19:11 INFO - 'SHELL': '/bin/bash', 22:19:11 INFO - 'SHLVL': '1', 22:19:11 INFO - 'TERM': 'linux', 22:19:11 INFO - 'TMOUT': '86400', 22:19:11 INFO - 'USER': 'cltbld', 22:19:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:11 INFO - '_': '/tools/buildbot/bin/python'} 22:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:14 INFO - Downloading docopt-0.6.1.tar.gz 22:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:14 INFO - Running setup.py install for blobuploader 22:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:14 INFO - Running setup.py install for requests 22:19:14 INFO - Running setup.py install for docopt 22:19:14 INFO - Successfully installed blobuploader requests docopt 22:19:14 INFO - Cleaning up... 22:19:14 INFO - Return code: 0 22:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:14 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:14 INFO - Using env: {'DISPLAY': ':0', 22:19:14 INFO - 'HOME': '/home/cltbld', 22:19:14 INFO - 'LANG': 'en_US.UTF-8', 22:19:14 INFO - 'LANGUAGE': 'en_US:en', 22:19:14 INFO - 'LOGNAME': 'cltbld', 22:19:14 INFO - 'MAIL': '/var/mail/cltbld', 22:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:14 INFO - 'MOZ_NO_REMOTE': '1', 22:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:14 INFO - 'NO_EM_RESTART': '1', 22:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:14 INFO - 'PWD': '/builds/slave/test', 22:19:14 INFO - 'SHELL': '/bin/bash', 22:19:14 INFO - 'SHLVL': '1', 22:19:14 INFO - 'TERM': 'linux', 22:19:14 INFO - 'TMOUT': '86400', 22:19:14 INFO - 'USER': 'cltbld', 22:19:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:14 INFO - '_': '/tools/buildbot/bin/python'} 22:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:14 INFO - Running setup.py (path:/tmp/pip-N48OLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:15 INFO - Running setup.py (path:/tmp/pip-PiDZTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:15 INFO - Running setup.py (path:/tmp/pip-hLlDRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:15 INFO - Running setup.py (path:/tmp/pip-1qJnot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:15 INFO - Running setup.py (path:/tmp/pip-LgMdhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:15 INFO - Running setup.py (path:/tmp/pip-8SXNmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:15 INFO - Running setup.py (path:/tmp/pip-b03IlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:15 INFO - Running setup.py (path:/tmp/pip-j6uIGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:15 INFO - Running setup.py (path:/tmp/pip-4fj9FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:15 INFO - Running setup.py (path:/tmp/pip-NacgvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:15 INFO - Running setup.py (path:/tmp/pip-2kMedO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:15 INFO - Running setup.py (path:/tmp/pip-0Q8qo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:15 INFO - Running setup.py (path:/tmp/pip-WOoSt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:15 INFO - Running setup.py (path:/tmp/pip-CjP01g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:15 INFO - Running setup.py (path:/tmp/pip-EEeC2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:16 INFO - Running setup.py (path:/tmp/pip-q25ewk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:16 INFO - Running setup.py (path:/tmp/pip-l_hyWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:16 INFO - Running setup.py install for manifestparser 22:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Running setup.py install for mozcrash 22:19:16 INFO - Running setup.py install for mozdebug 22:19:16 INFO - Running setup.py install for mozdevice 22:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Running setup.py install for mozfile 22:19:16 INFO - Running setup.py install for mozhttpd 22:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Running setup.py install for mozinfo 22:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Running setup.py install for mozInstall 22:19:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:16 INFO - Running setup.py install for mozleak 22:19:17 INFO - Running setup.py install for mozlog 22:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Running setup.py install for moznetwork 22:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Running setup.py install for mozprocess 22:19:17 INFO - Running setup.py install for mozprofile 22:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Running setup.py install for mozrunner 22:19:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Running setup.py install for mozscreenshot 22:19:17 INFO - Running setup.py install for moztest 22:19:17 INFO - Running setup.py install for mozversion 22:19:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:17 INFO - Cleaning up... 22:19:17 INFO - Return code: 0 22:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:17 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:17 INFO - Using env: {'DISPLAY': ':0', 22:19:17 INFO - 'HOME': '/home/cltbld', 22:19:17 INFO - 'LANG': 'en_US.UTF-8', 22:19:17 INFO - 'LANGUAGE': 'en_US:en', 22:19:17 INFO - 'LOGNAME': 'cltbld', 22:19:17 INFO - 'MAIL': '/var/mail/cltbld', 22:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:17 INFO - 'MOZ_NO_REMOTE': '1', 22:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:17 INFO - 'NO_EM_RESTART': '1', 22:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:17 INFO - 'PWD': '/builds/slave/test', 22:19:17 INFO - 'SHELL': '/bin/bash', 22:19:17 INFO - 'SHLVL': '1', 22:19:17 INFO - 'TERM': 'linux', 22:19:17 INFO - 'TMOUT': '86400', 22:19:17 INFO - 'USER': 'cltbld', 22:19:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:17 INFO - '_': '/tools/buildbot/bin/python'} 22:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:18 INFO - Running setup.py (path:/tmp/pip-L3iQsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:18 INFO - Running setup.py (path:/tmp/pip-Afjb5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:18 INFO - Running setup.py (path:/tmp/pip-4tdfjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:18 INFO - Running setup.py (path:/tmp/pip-FJDRAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:18 INFO - Running setup.py (path:/tmp/pip-Df1sJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:18 INFO - Running setup.py (path:/tmp/pip-2_Q3Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:18 INFO - Running setup.py (path:/tmp/pip-vr9SCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:18 INFO - Running setup.py (path:/tmp/pip-GPZBCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:18 INFO - Running setup.py (path:/tmp/pip-C1z0U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:18 INFO - Running setup.py (path:/tmp/pip-VsP2lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:18 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)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:18 INFO - Running setup.py (path:/tmp/pip-YyIJIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:18 INFO - Running setup.py (path:/tmp/pip-hgI0ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:19 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)) 22:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:19 INFO - Running setup.py (path:/tmp/pip-72zmUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:19 INFO - Running setup.py (path:/tmp/pip-pEONWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:19 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)) 22:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:19 INFO - Running setup.py (path:/tmp/pip-NLYEXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:19 INFO - Running setup.py (path:/tmp/pip-ZiJJsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:19 INFO - Running setup.py (path:/tmp/pip-ibFsgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:21 INFO - Downloading blessings-1.6.tar.gz 22:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:21 INFO - Installing collected packages: blessings 22:19:21 INFO - Running setup.py install for blessings 22:19:21 INFO - Successfully installed blessings 22:19:21 INFO - Cleaning up... 22:19:21 INFO - Return code: 0 22:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:21 INFO - Reading from file tmpfile_stdout 22:19:21 INFO - Current package versions: 22:19:21 INFO - argparse == 1.2.1 22:19:21 INFO - blessings == 1.6 22:19:21 INFO - blobuploader == 1.2.4 22:19:21 INFO - docopt == 0.6.1 22:19:21 INFO - functools32 == 3.2.3-2 22:19:21 INFO - jsonschema == 2.5.1 22:19:21 INFO - manifestparser == 1.1 22:19:21 INFO - mozInstall == 1.12 22:19:21 INFO - mozcrash == 0.17 22:19:21 INFO - mozdebug == 0.1 22:19:21 INFO - mozdevice == 0.48 22:19:21 INFO - mozfile == 1.2 22:19:21 INFO - mozhttpd == 0.7 22:19:21 INFO - mozinfo == 0.9 22:19:21 INFO - mozleak == 0.1 22:19:21 INFO - mozlog == 3.3 22:19:21 INFO - moznetwork == 0.27 22:19:21 INFO - mozprocess == 0.23 22:19:21 INFO - mozprofile == 0.28 22:19:21 INFO - mozrunner == 6.12 22:19:21 INFO - mozscreenshot == 0.1 22:19:21 INFO - mozsystemmonitor == 0.3 22:19:21 INFO - moztest == 0.7 22:19:21 INFO - mozversion == 1.4 22:19:21 INFO - psutil == 3.1.1 22:19:21 INFO - requests == 1.2.3 22:19:21 INFO - wsgiref == 0.1.2 22:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:21 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 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:21 INFO - Using env: {'DISPLAY': ':0', 22:19:21 INFO - 'HOME': '/home/cltbld', 22:19:21 INFO - 'LANG': 'en_US.UTF-8', 22:19:21 INFO - 'LANGUAGE': 'en_US:en', 22:19:21 INFO - 'LOGNAME': 'cltbld', 22:19:21 INFO - 'MAIL': '/var/mail/cltbld', 22:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:21 INFO - 'MOZ_NO_REMOTE': '1', 22:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:21 INFO - 'NO_EM_RESTART': '1', 22:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:21 INFO - 'PWD': '/builds/slave/test', 22:19:21 INFO - 'SHELL': '/bin/bash', 22:19:21 INFO - 'SHLVL': '1', 22:19:21 INFO - 'TERM': 'linux', 22:19:21 INFO - 'TMOUT': '86400', 22:19:21 INFO - 'USER': 'cltbld', 22:19:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:21 INFO - '_': '/tools/buildbot/bin/python'} 22:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:21 INFO - Cleaning up... 22:19:22 INFO - Return code: 0 22:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1592180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:19:22 INFO - Using env: {'DISPLAY': ':0', 22:19:22 INFO - 'HOME': '/home/cltbld', 22:19:22 INFO - 'LANG': 'en_US.UTF-8', 22:19:22 INFO - 'LANGUAGE': 'en_US:en', 22:19:22 INFO - 'LOGNAME': 'cltbld', 22:19:22 INFO - 'MAIL': '/var/mail/cltbld', 22:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:22 INFO - 'MOZ_NO_REMOTE': '1', 22:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:22 INFO - 'NO_EM_RESTART': '1', 22:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:22 INFO - 'PWD': '/builds/slave/test', 22:19:22 INFO - 'SHELL': '/bin/bash', 22:19:22 INFO - 'SHLVL': '1', 22:19:22 INFO - 'TERM': 'linux', 22:19:22 INFO - 'TMOUT': '86400', 22:19:22 INFO - 'USER': 'cltbld', 22:19:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:22 INFO - '_': '/tools/buildbot/bin/python'} 22:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:19:22 INFO - Cleaning up... 22:19:22 INFO - Return code: 0 22:19:22 INFO - Running post-action listener: _resource_record_post_action 22:19:22 INFO - Running post-action listener: _start_resource_monitoring 22:19:22 INFO - Starting resource monitoring. 22:19:22 INFO - [mozharness: 2016-07-27 05:19:22.264036Z] Finished create-virtualenv step (success) 22:19:22 INFO - [mozharness: 2016-07-27 05:19:22.264524Z] Running install step. 22:19:22 INFO - Running pre-action listener: _resource_record_pre_action 22:19:22 INFO - Running main action method: install 22:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:22 INFO - Reading from file tmpfile_stdout 22:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:22 INFO - Reading from file tmpfile_stdout 22:19:22 INFO - Output received: 22:19:22 INFO - Usage: mozinstall [options] installer 22:19:22 INFO - Options: 22:19:22 INFO - -h, --help show this help message and exit 22:19:22 INFO - -d DEST, --destination=DEST 22:19:22 INFO - Directory to install application into. [default: 22:19:22 INFO - "/builds/slave/test"] 22:19:22 INFO - --app=APP Application being installed. [default: firefox] 22:19:22 INFO - mkdir: /builds/slave/test/build/application 22:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:19:39 INFO - Reading from file tmpfile_stdout 22:19:39 INFO - Output received: 22:19:39 INFO - /builds/slave/test/build/application/firefox/firefox 22:19:39 INFO - Running post-action listener: _resource_record_post_action 22:19:39 INFO - [mozharness: 2016-07-27 05:19:39.880652Z] Finished install step (success) 22:19:39 INFO - [mozharness: 2016-07-27 05:19:39.880935Z] Running run-tests step. 22:19:39 INFO - Running pre-action listener: _resource_record_pre_action 22:19:39 INFO - Running main action method: run_tests 22:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:39 INFO - Python 2.7.3 22:19:39 INFO - Return code: 0 22:19:39 INFO - grabbing minidump binary from tooltool 22:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:39 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 0x15903b0>, '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 0x15912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1591740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:19:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:19:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:19:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:39 INFO - Return code: 0 22:19:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:19:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:19:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:39 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:19:39 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:19:39 INFO - Using env: {'DISPLAY': ':0', 22:19:39 INFO - 'HOME': '/home/cltbld', 22:19:39 INFO - 'LANG': 'en_US.UTF-8', 22:19:39 INFO - 'LANGUAGE': 'en_US:en', 22:19:39 INFO - 'LOGNAME': 'cltbld', 22:19:39 INFO - 'MAIL': '/var/mail/cltbld', 22:19:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:19:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:39 INFO - 'MOZ_NO_REMOTE': '1', 22:19:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:39 INFO - 'NO_EM_RESTART': '1', 22:19:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:39 INFO - 'PWD': '/builds/slave/test', 22:19:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:19:39 INFO - 'SHELL': '/bin/bash', 22:19:39 INFO - 'SHLVL': '1', 22:19:39 INFO - 'TERM': 'linux', 22:19:39 INFO - 'TMOUT': '86400', 22:19:39 INFO - 'USER': 'cltbld', 22:19:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493', 22:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:39 INFO - '_': '/tools/buildbot/bin/python'} 22:19:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:19:40 INFO - mozversion application_buildid: 20160726192237 22:19:40 INFO - mozversion application_changeset: eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 22:19:40 INFO - mozversion application_display_name: Nightly 22:19:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:40 INFO - mozversion application_name: Firefox 22:19:40 INFO - mozversion application_remotingname: firefox 22:19:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:19:40 INFO - mozversion application_vendor: Mozilla 22:19:40 INFO - mozversion application_version: 50.0a1 22:19:40 INFO - mozversion platform_buildid: 20160726192237 22:19:40 INFO - mozversion platform_changeset: eb74a01c8dc0bc508ea8b492e6a4c179e1c2ff19 22:19:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:19:40 INFO - mozversion platform_version: 50.0a1 22:19:40 INFO - using testdate: 1469596780 22:19:40 INFO - actual date: 1469596780 22:19:40 INFO - starting webserver on 'localhost:45033' 22:19:40 INFO - SUITE-START | Running 2 tests 22:19:40 INFO - TEST-START | dromaeo_css 22:19:40 INFO - operating with platform_type : linux_ 22:19:40 INFO - Initialising browser for dromaeo_css test... 22:19:40 INFO - TEST-INFO | started process 28837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlzzEH/profile http://localhost:45033/getInfo.html) 22:19:43 INFO - PROCESS | 28837 | JavaScript error: , line 0: uncaught exception: undefined 22:19:44 INFO - PROCESS | 28837 | __metrics Screen width/height:1600/1200 22:19:44 INFO - PROCESS | 28837 | colorDepth:24 22:19:44 INFO - PROCESS | 28837 | Browser inner width/height: 1024/697 22:19:44 INFO - PROCESS | 28837 | __metrics 22:19:44 INFO - PROCESS | 28837 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:19:44 INFO - PROCESS | 28837 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:45 INFO - TEST-INFO | 28837: exit 0 22:19:45 INFO - Browser initialized. 22:19:45 INFO - Running cycle 1/1 for dromaeo_css test... 22:19:45 INFO - TEST-INFO | started process 28915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlzzEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:57 INFO - PROCESS | 28915 | RSS: Main: 157380608 22:19:57 INFO - PROCESS | 28915 | 22:20:49 INFO - PROCESS | 28915 | 1469596849132 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:22:57 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45033/tests/dromaeo/cssquery-ext.html) 22:22:58 INFO - PROCESS | 28915 | RSS: Main: 256765952 22:22:58 INFO - PROCESS | 28915 | 22:26:00 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-ext.html (next: http://localhost:45033/tests/dromaeo/cssquery-jquery.html) 22:26:01 INFO - PROCESS | 28915 | RSS: Main: 243712000 22:26:01 INFO - PROCESS | 28915 | 22:29:03 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45033/tests/dromaeo/cssquery-mootools.html) 22:29:03 INFO - PROCESS | 28915 | RSS: Main: 186720256 22:29:03 INFO - PROCESS | 28915 | 22:32:05 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45033/tests/dromaeo/cssquery-prototype.html) 22:32:06 INFO - PROCESS | 28915 | RSS: Main: 229883904 22:32:06 INFO - PROCESS | 28915 | 22:35:09 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45033/tests/dromaeo/cssquery-yui.html) 22:35:09 INFO - PROCESS | 28915 | RSS: Main: 182353920 22:35:09 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | Cycle 1(1): loaded http://localhost:45033/tests/dromaeo/cssquery-yui.html (next: http://localhost:45033/tests/dromaeo/cssquery-dojo.html) 22:38:12 INFO - PROCESS | 28915 | RSS: Main: 271249408 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | __start_tp_report 22:38:12 INFO - PROCESS | 28915 | _x_x_mozilla_page_load 22:38:12 INFO - PROCESS | 28915 | _x_x_mozilla_page_load_details 22:38:12 INFO - PROCESS | 28915 | |i|pagename|runs| 22:38:12 INFO - PROCESS | 28915 | |0;dojo.html;3008.6088808454897;3044.9342730044473;3064.7241748242654;3069.094617087959;3110.50231962886;5372.516473517383;5419.268398766166;5457.126859702448;5541.528970037547;5559.888802223958;5429.701366424845;5476.123820188771;5518.806841760539;5551.77792888284;5552.278203833496;4854.611631069523;4911.557959783619;4930.112579735646;4949.257611358289;5136.563392111675;5028.949710502903;5052.69683818972;5073.264376665381;5083.567896728764;5088.6946783193125;4837.685550439228;4940.061388336223;4953.529414705597;4988.700677959334;5053.469385714502;4925.556699896991;4935.407751069894;4945.826896058621;4952.455229924705;5000.174971129759;4954.182559877652;4985.102681517325;4988.102141614508;4994.225894986283;5010.974945125251;5345.198220266952;5448.700321482317;5511.173324001392;5518.19986102013;5555.138953462219;5927.9407205928255;5966.164736936832;5973.522118230575;5978.671173085479;5986.371430999726;5962.165296858443;5973.372795856416;5979.581429299951;6022.759089636409;6028.39716028398;5262.631615786897;5434.157705555605;5456.454354564512;5479.561635069224;5557.5553955683445;6046.836943743107;6052.162837212497;6052.450584611729;6055.432867670813;6055.907566157199;5815.244018277682;5859.414058594191;5872.17789509469;5875.030619947746;5878.911816322759;5675.4892059714;5796.130580412888;5860.150278209721;5867.882642347129;5918.496927761103;5836.241288632451;5882.941170588325;5888.911666325009;5925.229720136354;5934.910976335358;5875.853103672443;5902.026165682614;5923.970380148158;5926.555508336892;5929;4320.092780516126;4347;4433.490148632884;4492.752898590609;4494.820207191741;3920.4903362562686;3948.973266950556;4005.439238506611;4011.3581826907553;4034.8587799427464;5523;5572;5572.58205634579;5579.944200557942;5625.46558076982;5668.9716551417805;5936;5952.196453478725;5962.940370596239;6000.849978750566;5474.39781624021;5524.06090964537;5553.583481238923;5648.74580643872;5650.604457687922;4921.138800709861;4951.504849515091;4957;4967.602591792648;4993.700377977333;6040.486558642565;6093.268807743099;6096.207493025879;6100.176476175659;6100.450959413585;5716.657000579979;5848.385919478394;5865.882682346414;5868.237129173351;5991.2510936132985;6084.117802918464;6087.421694938974;6090;6090.512758979359;6108.083787431743;5827;5838.32859221195;5838.854028649148;5847.356790753099;5849.736761845812;5694.174344720075;5867.413258674099;5889.852753681193;5924.940750592611;6016.849578760566;5795.710214489343;5807.651540907559;5809.912851307149;5815.854603634943;5828.6211396259105;5751.7411716472025;5799.449052340021;5804.158397032322;5811;5817.069268916953;5468.535174510212;5585.273914391103;5614.101743720985;5630.88738225225;5716.428357164416;5809.331926828469;5825.330087040044;5873.765049397976;5877.794277200277;5878.823635290948;5628.774849005994;5631.4368563145;5638.23883775685;5638.436156384329;5639.2668953035845 22:38:12 INFO - PROCESS | 28915 | |1;ext.html;596.361892774731;599.4574909706714;630.4735545819241;635.0125554762343;635.4566845347231;30134.397312053745;30613.38773224534;33331.66668333316;33359.33281334372;33421;44381;45814.77092614541;45854.77072614641;49309.753451232784;49397.50602493974;8917.554122293892;9078.500682462462;9080.182783549479;9081.59132839024;9086.954565227164;9017.053209413016;9102.317326200528;9104;9116.8632470513;9121.680741174061;9140.314476414262;9144.131307525775;9152.771180720501;9163.083691630816;9181.127792859668;9037.999999999967;9051.637934482613;9092.727018217454;9095.135962083592;9097.590608422637;8965.865512017324;9031.774205644846;9063.773405664846;9064.456132632064;9073.31950103745;43006.78496607528;43355.34966975498;43374;43375.78312108451;43390.13219735619;3480.443129099357;3543.982280088583;3576.78539287641;3706.721995850295;4215.409842622035;33018;33128;33512.83243583766;33571;34991.82504087463;4157.792110394468;4244.448221731155;4257.467816522934;4354.782260886943;4399.054203346264;381108.9999999972;383877;385280;388777;390351;58578.414215858145;58886.41113588895;58902;58904;58923;62220.06669899955;62259.066114008325;62278.37721622817;62330;62374.68812655999;17384.217710203073;17555.21001554933;17601.11994400275;17610.2075406607;17612.647747044986;13636.181829090287;13757.724845503033;13812.37844297009;13819;13835.239061851493;15273.6181595461;16940.152992350333;16964.522272934264;17031.914840425718;17202.483925482255;5917.970410147922;6192.256929168439;6270.2789179244055;6270.7491700331475;6311.747530098744;966.8034315553898;1011.2668315471225;1028.8096702110133;1068.4123731947398;1146.8910453506903;33253.3349333012;33496;33503;33733.491011358645;33855;1121.6915348279126;1134.466800603715;1159.837622732818;1197.7245233596148;1247.6308445386353;17168.22742976569;17394.910951648013;17505;17571.385001524886;17692.557686057953;536226;541054;541062;541586;542189;59638.403615964155;59638.403615964155;59823.102653460235;59952;59967.700161499786;1225.5159212111166;1336.7393358295233;1349.50068474665;1356.9457221711218;1401.628568429367;29697.5545366824;31162.844185778926;34064.31871362509;34169.31661366808;34356.48465272973;50241.748791255806;50614;50616.74691626518;50703;50720.49279507158;406319;406951;406972;407632.80917977286;408642;24612.384690382885;26761.464770704086;27718;27745.861270694324;28952.855235723688;44871.32693009542;44960.10079798451;45957.310640339754;46338.76830615825;46438.76780616075;40685.186296273314;41274.38088428616;41700;42843.357349639155;43298;40764;41645;41773;41888.162236754484;42536.78731606322;40732;40856.38715419212;40907.18185636211;40969.79515102405;41045.794771025954;34203.4869476963;36366.27267454689;36685.44971825478;37119.628803712694;37286.44070339001;28274;28427.672955975173;28453.715462845106;28749;28775.280617984718 22:38:12 INFO - PROCESS | 28915 | |2;jquery.html;369.5491500369548;383.82152299180876;385.955615104263;398.2671883733929;400.1097557933598;17900.910495447522;18905.810941890577;19396.418107456764;19490.805091949078;19585.118669659863;18584.256629734828;18931.810681893177;19037.714434283498;19162.808371916275;19315.517112072204;5809.448102430262;5810.825675229728;5854.590178687494;5998.370171132012;5998.8800223995495;5685.459881311269;5752.827415177551;5754;5816.5055970242365;5819.447152520504;5694.2312787773535;5727.284089488814;5733.168690539869;5796.449337312949;5821.446962538552;5697.230873832042;5829.708514574254;5837.824865254028;5855.677937713424;5864.882702345929;4723.244280915037;4952.603791696692;4983.177775667011;5018.222175562793;5190.844274671766;12541.372931353395;12791.168574042751;14383.568492945229;22266.220682276205;22612.43468913274;2149.570085982794;2187.56248750249;2245.14684419921;2295.437617783637;2607.8044146689076;8950.462972221623;9093.63625454981;9500.097490738368;9636;9825.950870245675;1864.5338665333666;1935.823146531188;1968.2422267427;1968.379960312497;1971.9704204436946;72035.63982180055;84331;84861;85488.57255713681;87644;8860.158284962918;9400.670976515788;9404.200642945289;9582.377145485521;10322.174226061898;12226.816597751042;12642.431090600945;12642.810357844455;12705.17416367933;12738.617841464771;7543.396528277724;7684.385249180053;7768.922310776933;7897.3287270581495;8025.478343907627;7438.814029649302;7521.736739214101;7564.654956963359;7649.38804895607;7939.0870049945;3749.962500374961;3805.5433347997864;3952.3676211805973;4023.114914718757;4045.2314060328445;1901.3250296144945;1908.6182763447366;1922.6731455652573;1929.604431091651;1985.4540001499704;889.4085433186858;911.5761171055491;1020.5407566594913;1033.1734612310122;1073.5598404654054;19053.237870485304;20069.49826254326;20126.798732012787;20142;20191.4952126198;970.3289882060832;970.9708708738749;979.8040391921644;1017.704865588971;1047.533847437898;10933.016028557468;11283.097352211804;11301;11320.377379244055;11322.886771132347;523956;528864;536351;538174;540764;87710.56144719236;88082;90172.49137543097;91309;91330;982.7051884434641;1019.3781793106199;1020.5254556631202;1027.111548510548;1032.2155162076726;17013.829861701226;17113.82886171172;18472.72290915664;18525.35161269403;18709.625807483502;40961.1807763849;43351;43704.781476092416;45321.00462326627;46258.537414625425;59023;59194.40805591889;61391.693041534505;62296;63040.36959630345;7886.804673293115;7892.921070789448;7965.960170199112;8021.398395120273;8073.233042860918;7252.093488313961;11946.223495472766;12716.809247861105;12910.935445322713;13378.732425351243;6130.693465326626;10740.140788737039;11617.6514704559;11710;12065;11465.082793376343;11890.524379024742;11998.460069296729;12096.637100886988;12295.877041229473;11517.82723259135;12151.392430378623;12208.145429820182;12382.318972456602;12671.113022088366;8118.6752529900505;8137.389695772722;8218.465799722999;8262.049864265686;8318;9547.8837216244;11535.36555489456;12240.938795305967;12303.539292141786;12562.120651554304 22:38:12 INFO - PROCESS | 28915 | |3;mootools.html;1342.261756034181;1437.1018113678952;1492.3359105198185;1574.4095964013495;1751.0456801043438;8291.626876790544;8529.701460448885;8547.957260213698;8859.689910853122;8869;8744;8837.027926928033;8842.071582483843;8844.469331840079;8853;2368.0882860098855;2375.4536456614987;2394.305651361103;2396.2451827674313;2397.2688330059327;2360.704911886014;2370.7036620422446;2407.903683852644;2414.746451622572;2416.8912398942;2284.543091381722;2354.6578450283346;2354.82338824588;2356.0340260493203;2382.7617238276207;2280.897359618821;2284.8172146228344;2294.105298933409;2301.091069027733;2348.917787877433;2305.227748704186;2311.653252012195;2315.0508291600363;2315.1549684365086;2315.444293369596;8704.086070962585;8707.825843483159;8756.956215218946;8773;8773.473591584525;4971.229459433757;5117.7185254810975;5126.154184559543;5137.717425541594;5138.229265610151;3153.936921261562;3206.9358612827614;3215.8713651453913;3237.8542965566608;3240.643529211785;957.3346524165707;962.7352478068517;972.8297547929155;977.5698692575315;977.6822532676908;11264.943675281653;11405;11415.543378264943;11421.143414243881;11429.257098288668;4215.747055176699;4474.485434175046;4600.677952543289;4633.513481084505;4637.258038713857;9979.80040399188;10025;10151.340162889537;10406.5837366506;10407;5075.416327122354;5119.641625086283;5121.667091639031;5122.103631864484;5122.538971492509;4177.832886684499;4207.410962465257;4712.69367491112;4749.501302363271;4784.114938736345;3903.5510916244993;3942.8422863085157;4025.255327764373;4025.376066709665;4083.8570650027104;1235.4008305971597;1253.4798058805493;1266.6263452281598;1267.8098285257101;1271.3007845684836;998.3361064891766;1005.5374527717332;1011.8128146292812;1025.5692609104194;1028.5422986770964;5911.940880591225;6040.788572399945;6067.24159480065;6081.087836824512;6302.936970630235;405.6004835237289;414.6040531292608;416.01819705495006;416.4378089579044;418.9601987811214;4089.8977525561504;4216.536181020086;4294.055307832335;4354.716943398669;4388.780560971939;10437.634682786218;10653.414062226651;10656.893431065746;10762.78474430507;10766.246362754531;10408.230600797882;10552.736181595521;10696.251262411557;10713.464326783629;10729.302595331279;8118.147594502492;8187.426880118334;8194.30348420379;8194.754157375288;8201.015878094668;6000.819975400745;6207.441330280297;6224.128621992834;6229.968850155901;6387.169667943138;9546.522673866419;9700.417974921527;9847.803043939224;9978.850317245102;10050.597976080875;10073.194144468278;10101.595936162765;10188.541515631963;10282.485875706036;10285.485725713535;7576.090869095744;7746.147923728273;7817.6872925084635;7989.241022102891;7992.760217193493;8434.493930364199;8519.318454523747;8570.228679418882;8575.228229459379;8584.74245772628;7707.653155608124;7724.7682569523;7771.961140194263;7800.45396822217;7889.881651775343;7624.80937976555;7711.3830893527265;7714.267144621252;7749.651265692944;7919.208079192034;6901.068355771907;6922.10012698346;6939.826504337432;6998.650067496503;6999.230084690782;5270.314859068297;5378.569714422915;5383.4885685861345;5399.190121481809;5540.889182216414;5223.425423203368;5245.0558899398475;5291.153415453509;5309.681419114865;5428.131498960148 22:38:12 INFO - PROCESS | 28915 | |4;prototype.html;295.15438269358293;302.7789713509138;308.88571228645407;310.62569603627634;314.52192667145954;5123.5388815006645;5211.5309622133955;5225.320708307924;5281.1286137787265;5289.471052894709;5232.816851410202;5237.607179461536;5266.368035835695;5294.655847369918;5299.417064122943;4118.320477121271;4123.60825721556;4130.380442933554;4144.316187829005;4156.397322388259;3946.4869566956254;4056.3571753439905;4143.378493226025;4148.43996060531;4149.107941792514;4036.414719865618;4038.313486707252;4044.413560033808;4051.635352818246;4061.4110953911663;4015.437838702584;4037.3338399164395;4057.4116753070934;4065.695072869532;4074.9185016299803;3400.6429324921023;3489.145159435929;3498.4577390504514;3557.5019497270405;3565.4668492548194;5059.747012649353;5109.182530795092;5119.56483698886;5129.307543481619;5141.717205553693;4574.794134263932;4602.412167802103;4622.8382006629945;4626.791794369262;4630.402511133653;5344.770702738353;5409.134538473825;5456.181572764078;5490.862728431821;5513.2005859150195;3842.1739326045035;3849.287881741887;3852.1332700142525;3858.9387918322404;3861.2856621525107;5649.802256921029;5654.264945557051;5677.432256774331;5690.687012214326;5711.371749107595;3804.296205201991;3924.9607503924594;3948.2103579283685;3950.111224974415;3953.7627742335553;3974.82113304902;3976.443297938291;3995.440638310639;3996.7002474813926;4003.2393845169327;4584.266517357207;4606.078784243098;4616.3998680172035;4623.9075218495445;4641.305923337957;5277.577793776489;5511.751971161308;5526.392096869341;5575.881165157214;5581.134924086773;1293.6313150751992;1340.544214966916;1349.0961056092442;1351.9662008449868;1361.3669643615767;891.5497673674753;907.6505545365083;924.4499522783933;925.4724806860025;929.4284015330658;5231.215317702299;5282.603804714662;5287.814926477555;5297.867553311198;5303.708296043755;5613.438656134354;5619.330817861483;5622.863311941436;5628.465295796893;5650.406707295757;5196.41509339655;5274.525292723673;5311.946880531223;5331.626786125012;5352.063388907003;3007.473692103873;3010.9397812043635;3015.853975489344;3018.0945716285028;3055.9915227974716;5863.736131874076;5878.794242201502;5883.2057672213705;5890.936712909263;5899.026660600953;5512.834614961557;5739.540836733051;5746.448458916069;5754.856128596819;5768.3654797972185;5817.854553636108;5820.970895145497;5838.883222335615;5841.41585841421;5893.44012318829;5434.483724046209;5658.830235092953;5674.290713660793;5715.885682286248;5748.281464816898;5543.420125264281;5594.916076258941;5602.607817452902;5639.351474580476;5647;5801.332846722681;5805.796797112081;5824.912626310524;5855.765769369177;5860.413958604276;3752.94370584436;3851.9422208666333;3890.221955608833;3907.6873850092493;3927.941080883846;5534.750936207961;5715.599908006566;5721.312212897288;5743.9138412923;5755.97122014404;5494.2857428535635;5534.778608855761;5549.084401073777;5577.860553486195;5595.832125036255;5535.8892822144135;5550.361708403424;5567.164925261243;5585.3297604287745;5588.30146231721;5285;5424.972875135599;5497.752601133038;5509.586780991362;5526.944730552643;5566.888662226652;5567.109262517978;5579.7489112990825;5587.245721827501;5592.804251851166;5454.181872719124;5504.4495550444635;5505.614606977473;5511.779528818803;5515.503604675599 22:38:12 INFO - PROCESS | 28915 | |5;yui.html;710.3997122431547;711.7757906259528;713.8715031294369;716.8136284566011;720.125048066599;14681;15294.541163765078;15478.613034674125;15551.377944882192;15785.447509337162;15285.84714152861;15352.539423817276;15392.076475411483;15442.227888605581;15469.76795348068;808.0626473290984;825.1830687619274;829.0134739659816;829.0921441022101;830.0454477351034;673.5386260411609;801.5751651624648;822.48183644304;825.471698113205;827.764087235138;862.6032025268385;871.1941454154913;871.2028493928049;871.2507243770352;871.590352534311;859.2481578618708;860.3934226370425;860.9870851937226;861.027039445429;861.8664107063415;511.96160287978176;601.8615718384752;615.5229696984873;619.340402471371;619.7087368936593;13357.933210333984;13460.596182114552;13473.191608503521;13486.730265394735;13497.717716816986;13404.664883377896;13778.65553361164;13887.861121388758;13971.930140349234;14024.579262622137;12768.872311276862;13021.28382938938;13206.867931320756;13657.317134143253;14191.432342706383;3943.4084887266854;3970.265500882346;3982.601739825994;4058.939115913264;4137.958620413788;67304.6634766823;68949.65525172392;69871.65064174698;77561.22438775597;78041.60979195124;11304.877264019708;11450.198486105892;11683;11704.590339338252;11940.223885447418;21712.240071597735;21915.232966846404;21921.780782192294;21999.890000549894;22051.33845984623;8952.955235223912;8985.730428087169;8989.101089890959;9029.954850225708;9405.106514881076;4927.433345165352;5066.797328106908;5095.898082038412;5107.106256405188;5210.062188805976;3437.2438063626464;3514.086337552255;3536.7170626350344;3543.1496440854007;3552.1474846036767;644.8130042287778;669.6015870557109;679.1307126877605;679.1917618034523;681.2029924987776;666.3602941176428;743.0822933676905;760.4336258587199;761.6953218712559;781.2265856801839;9423.38747981379;9952.800943981225;10096.192304615613;10176.236782241362;10184.490775461345;736.9410447164214;753.2505157368454;758.9506682065648;762.5005621318046;766.9616519174131;4699.765011749399;4910.533499317559;4931.753412329369;4932.753362331869;4932.876678083005;125161.74838251683;125862;127740.3435512955;130198;134280;110972;111698.44150779357;112462;113495;116503.41748291205;90370;94821.52589237009;96763;97206.51396742971;98112.50943745236;9125.497889542748;9192.586333615138;9331.206847417774;9345.205657519187;9531.428114313163;56058.71970640121;56443.71778141083;56817.43182568121;57408.42591574198;58499.4150058511;77368.61315693386;82080.9306074524;84832.57583712041;86202.56898715466;87076;11380.260283081574;11538.826917596074;11794.705132371759;11821.290722556674;12390.62828115158;14612.85387146115;14873.85126148768;14932.402703891723;15689.60775980564;15840.920795395949;13271.668208294484;13371.3982870773;13692.3838427273;14321.928390358398;14461.349239284047;14425.85574144245;14538.127712337293;14609;14976.951613386958;15094.924525377302;13658.726825463635;13975.504701293376;14146;14198.3610737515;14475.059121157092;10640;10643.239522411133;10935.28920620157;11020.834687479533;11041.613543526259;10198.898011019795;10623.205539604724;11579.942100289445;11679.76640467203;11879.643610691694 22:38:12 INFO - PROCESS | 28915 | __end_tp_report 22:38:12 INFO - PROCESS | 28915 | __start_cc_report 22:38:12 INFO - PROCESS | 28915 | _x_x_mozilla_cycle_collect,940 22:38:12 INFO - PROCESS | 28915 | __end_cc_report 22:38:12 INFO - PROCESS | 28915 | __startTimestamp1469597892749__endTimestamp 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | ------- Summary: start ------- 22:38:12 INFO - PROCESS | 28915 | Number of tests: 6 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#0] dojo.html Cycles:165 Average:5461.49 Median:5648.75 stddev:654.34 (11.6%) stddev-sans-first:627.42 22:38:12 INFO - PROCESS | 28915 | Values: 3008.6 3044.9 3064.7 3069.1 3110.5 5372.5 5419.3 5457.1 5541.5 5559.9 5429.7 5476.1 5518.8 5551.8 5552.3 4854.6 4911.6 4930.1 4949.3 5136.6 5028.9 5052.7 5073.3 5083.6 5088.7 4837.7 4940.1 4953.5 4988.7 5053.5 4925.6 4935.4 4945.8 4952.5 5000.2 4954.2 4985.1 4988.1 4994.2 5011.0 5345.2 5448.7 5511.2 5518.2 5555.1 5927.9 5966.2 5973.5 5978.7 5986.4 5962.2 5973.4 5979.6 6022.8 6028.4 5262.6 5434.2 5456.5 5479.6 5557.6 6046.8 6052.2 6052.5 6055.4 6055.9 5815.2 5859.4 5872.2 5875.0 5878.9 5675.5 5796.1 5860.2 5867.9 5918.5 5836.2 5882.9 5888.9 5925.2 5934.9 5875.9 5902.0 5924.0 5926.6 5929.0 4320.1 4347.0 4433.5 4492.8 4494.8 3920.5 3949.0 4005.4 4011.4 4034.9 5523.0 5572.0 5572.6 5579.9 5625.5 5669.0 5936.0 5952.2 5962.9 6000.8 5474.4 5524.1 5553.6 5648.7 5650.6 4921.1 4951.5 4957.0 4967.6 4993.7 6040.5 6093.3 6096.2 6100.2 6100.5 5716.7 5848.4 5865.9 5868.2 5991.3 6084.1 6087.4 6090.0 6090.5 6108.1 5827.0 5838.3 5838.9 5847.4 5849.7 5694.2 5867.4 5889.9 5924.9 6016.8 5795.7 5807.7 5809.9 5815.9 5828.6 5751.7 5799.4 5804.2 5811.0 5817.1 5468.5 5585.3 5614.1 5630.9 5716.4 5809.3 5825.3 5873.8 5877.8 5878.8 5628.8 5631.4 5638.2 5638.4 5639.3 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#1] ext.html Cycles:180 Average:60527.95 Median:22716.09 stddev:119194.38 (524.7%) stddev-sans-first:119443.81 22:38:12 INFO - PROCESS | 28915 | Values: 596.4 599.5 630.5 635.0 635.5 30134.4 30613.4 33331.7 33359.3 33421.0 44381.0 45814.8 45854.8 49309.8 49397.5 8917.6 9078.5 9080.2 9081.6 9087.0 9017.1 9102.3 9104.0 9116.9 9121.7 9140.3 9144.1 9152.8 9163.1 9181.1 9038.0 9051.6 9092.7 9095.1 9097.6 8965.9 9031.8 9063.8 9064.5 9073.3 43006.8 43355.3 43374.0 43375.8 43390.1 3480.4 3544.0 3576.8 3706.7 4215.4 33018.0 33128.0 33512.8 33571.0 34991.8 4157.8 4244.4 4257.5 4354.8 4399.1 381109.0 383877.0 385280.0 388777.0 390351.0 58578.4 58886.4 58902.0 58904.0 58923.0 62220.1 62259.1 62278.4 62330.0 62374.7 17384.2 17555.2 17601.1 17610.2 17612.6 13636.2 13757.7 13812.4 13819.0 13835.2 15273.6 16940.2 16964.5 17031.9 17202.5 5918.0 6192.3 6270.3 6270.7 6311.7 966.8 1011.3 1028.8 1068.4 1146.9 33253.3 33496.0 33503.0 33733.5 33855.0 1121.7 1134.5 1159.8 1197.7 1247.6 17168.2 17394.9 17505.0 17571.4 17692.6 536226.0 541054.0 541062.0 541586.0 542189.0 59638.4 59638.4 59823.1 59952.0 59967.7 1225.5 1336.7 1349.5 1356.9 1401.6 29697.6 31162.8 34064.3 34169.3 34356.5 50241.7 50614.0 50616.7 50703.0 50720.5 406319.0 406951.0 406972.0 407632.8 408642.0 24612.4 26761.5 27718.0 27745.9 28952.9 44871.3 44960.1 45957.3 46338.8 46438.8 40685.2 41274.4 41700.0 42843.4 43298.0 40764.0 41645.0 41773.0 41888.2 42536.8 40732.0 40856.4 40907.2 40969.8 41045.8 34203.5 36366.3 36685.4 37119.6 37286.4 28274.0 28427.7 28453.7 28749.0 28775.3 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#2] jquery.html Cycles:180 Average:29940.41 Median:4034.17 stddev:87877.60 (2178.3%) stddev-sans-first:88096.07 22:38:12 INFO - PROCESS | 28915 | Values: 369.5 383.8 386.0 398.3 400.1 17900.9 18905.8 19396.4 19490.8 19585.1 18584.3 18931.8 19037.7 19162.8 19315.5 5809.4 5810.8 5854.6 5998.4 5998.9 5685.5 5752.8 5754.0 5816.5 5819.4 5694.2 5727.3 5733.2 5796.4 5821.4 5697.2 5829.7 5837.8 5855.7 5864.9 4723.2 4952.6 4983.2 5018.2 5190.8 12541.4 12791.2 14383.6 22266.2 22612.4 2149.6 2187.6 2245.1 2295.4 2607.8 8950.5 9093.6 9500.1 9636.0 9826.0 1864.5 1935.8 1968.2 1968.4 1972.0 72035.6 84331.0 84861.0 85488.6 87644.0 8860.2 9400.7 9404.2 9582.4 10322.2 12226.8 12642.4 12642.8 12705.2 12738.6 7543.4 7684.4 7768.9 7897.3 8025.5 7438.8 7521.7 7564.7 7649.4 7939.1 3750.0 3805.5 3952.4 4023.1 4045.2 1901.3 1908.6 1922.7 1929.6 1985.5 889.4 911.6 1020.5 1033.2 1073.6 19053.2 20069.5 20126.8 20142.0 20191.5 970.3 971.0 979.8 1017.7 1047.5 10933.0 11283.1 11301.0 11320.4 11322.9 523956.0 528864.0 536351.0 538174.0 540764.0 87710.6 88082.0 90172.5 91309.0 91330.0 982.7 1019.4 1020.5 1027.1 1032.2 17013.8 17113.8 18472.7 18525.4 18709.6 40961.2 43351.0 43704.8 45321.0 46258.5 59023.0 59194.4 61391.7 62296.0 63040.4 7886.8 7892.9 7966.0 8021.4 8073.2 7252.1 11946.2 12716.8 12910.9 13378.7 6130.7 10740.1 11617.7 11710.0 12065.0 11465.1 11890.5 11998.5 12096.6 12295.9 11517.8 12151.4 12208.1 12382.3 12671.1 8118.7 8137.4 8218.5 8262.0 8318.0 9547.9 11535.4 12240.9 12303.5 12562.1 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#3] mootools.html Cycles:180 Average:5741.59 Median:4674.98 stddev:3240.97 (69.3%) stddev-sans-first:3233.20 22:38:12 INFO - PROCESS | 28915 | Values: 1342.3 1437.1 1492.3 1574.4 1751.0 8291.6 8529.7 8548.0 8859.7 8869.0 8744.0 8837.0 8842.1 8844.5 8853.0 2368.1 2375.5 2394.3 2396.2 2397.3 2360.7 2370.7 2407.9 2414.7 2416.9 2284.5 2354.7 2354.8 2356.0 2382.8 2280.9 2284.8 2294.1 2301.1 2348.9 2305.2 2311.7 2315.1 2315.2 2315.4 8704.1 8707.8 8757.0 8773.0 8773.5 4971.2 5117.7 5126.2 5137.7 5138.2 3153.9 3206.9 3215.9 3237.9 3240.6 957.3 962.7 972.8 977.6 977.7 11264.9 11405.0 11415.5 11421.1 11429.3 4215.7 4474.5 4600.7 4633.5 4637.3 9979.8 10025.0 10151.3 10406.6 10407.0 5075.4 5119.6 5121.7 5122.1 5122.5 4177.8 4207.4 4712.7 4749.5 4784.1 3903.6 3942.8 4025.3 4025.4 4083.9 1235.4 1253.5 1266.6 1267.8 1271.3 998.3 1005.5 1011.8 1025.6 1028.5 5911.9 6040.8 6067.2 6081.1 6302.9 405.6 414.6 416.0 416.4 419.0 4089.9 4216.5 4294.1 4354.7 4388.8 10437.6 10653.4 10656.9 10762.8 10766.2 10408.2 10552.7 10696.3 10713.5 10729.3 8118.1 8187.4 8194.3 8194.8 8201.0 6000.8 6207.4 6224.1 6230.0 6387.2 9546.5 9700.4 9847.8 9978.9 10050.6 10073.2 10101.6 10188.5 10282.5 10285.5 7576.1 7746.1 7817.7 7989.2 7992.8 8434.5 8519.3 8570.2 8575.2 8584.7 7707.7 7724.8 7772.0 7800.5 7889.9 7624.8 7711.4 7714.3 7749.7 7919.2 6901.1 6922.1 6939.8 6998.7 6999.2 5270.3 5378.6 5383.5 5399.2 5540.9 5223.4 5245.1 5291.2 5309.7 5428.1 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#4] prototype.html Cycles:180 Average:4625.62 Median:5296.26 stddev:1385.65 (26.2%) stddev-sans-first:1350.88 22:38:12 INFO - PROCESS | 28915 | Values: 295.2 302.8 308.9 310.6 314.5 5123.5 5211.5 5225.3 5281.1 5289.5 5232.8 5237.6 5266.4 5294.7 5299.4 4118.3 4123.6 4130.4 4144.3 4156.4 3946.5 4056.4 4143.4 4148.4 4149.1 4036.4 4038.3 4044.4 4051.6 4061.4 4015.4 4037.3 4057.4 4065.7 4074.9 3400.6 3489.1 3498.5 3557.5 3565.5 5059.7 5109.2 5119.6 5129.3 5141.7 4574.8 4602.4 4622.8 4626.8 4630.4 5344.8 5409.1 5456.2 5490.9 5513.2 3842.2 3849.3 3852.1 3858.9 3861.3 5649.8 5654.3 5677.4 5690.7 5711.4 3804.3 3925.0 3948.2 3950.1 3953.8 3974.8 3976.4 3995.4 3996.7 4003.2 4584.3 4606.1 4616.4 4623.9 4641.3 5277.6 5511.8 5526.4 5575.9 5581.1 1293.6 1340.5 1349.1 1352.0 1361.4 891.5 907.7 924.4 925.5 929.4 5231.2 5282.6 5287.8 5297.9 5303.7 5613.4 5619.3 5622.9 5628.5 5650.4 5196.4 5274.5 5311.9 5331.6 5352.1 3007.5 3010.9 3015.9 3018.1 3056.0 5863.7 5878.8 5883.2 5890.9 5899.0 5512.8 5739.5 5746.4 5754.9 5768.4 5817.9 5821.0 5838.9 5841.4 5893.4 5434.5 5658.8 5674.3 5715.9 5748.3 5543.4 5594.9 5602.6 5639.4 5647.0 5801.3 5805.8 5824.9 5855.8 5860.4 3752.9 3851.9 3890.2 3907.7 3927.9 5534.8 5715.6 5721.3 5743.9 5756.0 5494.3 5534.8 5549.1 5577.9 5595.8 5535.9 5550.4 5567.2 5585.3 5588.3 5285.0 5425.0 5497.8 5509.6 5526.9 5566.9 5567.1 5579.7 5587.2 5592.8 5454.2 5504.4 5505.6 5511.8 5515.5 22:38:12 INFO - PROCESS | 28915 | 22:38:12 INFO - PROCESS | 28915 | [#5] yui.html Cycles:180 Average:22202.38 Median:4020.77 stddev:33183.38 (825.3%) stddev-sans-first:33237.22 22:38:12 INFO - PROCESS | 28915 | Values: 710.4 711.8 713.9 716.8 720.1 14681.0 15294.5 15478.6 15551.4 15785.4 15285.8 15352.5 15392.1 15442.2 15469.8 808.1 825.2 829.0 829.1 830.0 673.5 801.6 822.5 825.5 827.8 862.6 871.2 871.2 871.3 871.6 859.2 860.4 861.0 861.0 861.9 512.0 601.9 615.5 619.3 619.7 13357.9 13460.6 13473.2 13486.7 13497.7 13404.7 13778.7 13887.9 13971.9 14024.6 12768.9 13021.3 13206.9 13657.3 14191.4 3943.4 3970.3 3982.6 4058.9 4138.0 67304.7 68949.7 69871.7 77561.2 78041.6 11304.9 11450.2 11683.0 11704.6 11940.2 21712.2 21915.2 21921.8 21999.9 22051.3 8953.0 8985.7 8989.1 9030.0 9405.1 4927.4 5066.8 5095.9 5107.1 5210.1 3437.2 3514.1 3536.7 3543.1 3552.1 644.8 669.6 679.1 679.2 681.2 666.4 743.1 760.4 761.7 781.2 9423.4 9952.8 10096.2 10176.2 10184.5 736.9 753.3 759.0 762.5 767.0 4699.8 4910.5 4931.8 4932.8 4932.9 125161.7 125862.0 127740.3 130198.0 134280.0 110972.0 111698.4 112462.0 113495.0 116503.4 90370.0 94821.5 96763.0 97206.5 98112.5 9125.5 9192.6 9331.2 9345.2 9531.4 56058.7 56443.7 56817.4 57408.4 58499.4 77368.6 82080.9 84832.6 86202.6 87076.0 11380.3 11538.8 11794.7 11821.3 12390.6 14612.9 14873.9 14932.4 15689.6 15840.9 13271.7 13371.4 13692.4 14321.9 14461.3 14425.9 14538.1 14609.0 14977.0 15094.9 13658.7 13975.5 14146.0 14198.4 14475.1 10640.0 10643.2 10935.3 11020.8 11041.6 10198.9 10623.2 11579.9 11679.8 11879.6 22:38:12 INFO - PROCESS | 28915 | -------- Summary: end -------- 22:38:12 INFO - PROCESS | 28915 | 22:38:13 INFO - TEST-INFO | 28915: exit 0 22:38:13 INFO - TEST-OK | dromaeo_css | took 1113282ms 22:38:13 INFO - TEST-START | kraken 22:38:13 INFO - operating with platform_type : linux_ 22:38:13 INFO - Initialising browser for kraken test... 22:38:13 INFO - TEST-INFO | started process 29107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNy_ah/profile http://localhost:45033/getInfo.html) 22:38:16 INFO - PROCESS | 29107 | JavaScript error: , line 0: uncaught exception: undefined 22:38:17 INFO - PROCESS | 29107 | __metrics Screen width/height:1600/1200 22:38:17 INFO - PROCESS | 29107 | colorDepth:24 22:38:17 INFO - PROCESS | 29107 | Browser inner width/height: 1024/697 22:38:17 INFO - PROCESS | 29107 | __metrics 22:38:18 INFO - PROCESS | 29107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:38:18 INFO - PROCESS | 29107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:19 INFO - TEST-INFO | 29107: exit 0 22:38:19 INFO - Browser initialized. 22:38:19 INFO - Running cycle 1/1 for kraken test... 22:38:19 INFO - TEST-INFO | started process 29189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNy_ah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:31 INFO - PROCESS | 29189 | RSS: Main: 157908992 22:38:31 INFO - PROCESS | 29189 | 22:38:33 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:34 INFO - PROCESS | 29189 | RSS: Main: 213737472 22:38:34 INFO - PROCESS | 29189 | 22:38:36 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-dft) 22:38:37 INFO - PROCESS | 29189 | RSS: Main: 193142784 22:38:37 INFO - PROCESS | 29189 | 22:38:40 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-fft) 22:38:41 INFO - PROCESS | 29189 | RSS: Main: 270233600 22:38:41 INFO - PROCESS | 29189 | 22:38:43 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45033/tests/kraken/driver.html?testName=audio-oscillator) 22:38:43 INFO - PROCESS | 29189 | RSS: Main: 181288960 22:38:43 INFO - PROCESS | 29189 | 22:38:46 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:38:46 INFO - PROCESS | 29189 | RSS: Main: 185151488 22:38:46 INFO - PROCESS | 29189 | 22:38:49 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-darkroom) 22:38:50 INFO - PROCESS | 29189 | RSS: Main: 221585408 22:38:50 INFO - PROCESS | 29189 | 22:38:53 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45033/tests/kraken/driver.html?testName=imaging-desaturate) 22:38:54 INFO - PROCESS | 29189 | RSS: Main: 220954624 22:38:54 INFO - PROCESS | 29189 | 22:38:57 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45033/tests/kraken/driver.html?testName=json-parse-financial) 22:38:57 INFO - PROCESS | 29189 | RSS: Main: 221130752 22:38:57 INFO - PROCESS | 29189 | 22:38:59 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:38:59 INFO - PROCESS | 29189 | RSS: Main: 185544704 22:38:59 INFO - PROCESS | 29189 | 22:39:01 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:02 INFO - PROCESS | 29189 | RSS: Main: 191541248 22:39:02 INFO - PROCESS | 29189 | 22:39:04 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:04 INFO - PROCESS | 29189 | RSS: Main: 195252224 22:39:04 INFO - PROCESS | 29189 | 22:39:07 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:08 INFO - PROCESS | 29189 | RSS: Main: 188858368 22:39:08 INFO - PROCESS | 29189 | 22:39:10 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:11 INFO - PROCESS | 29189 | RSS: Main: 193912832 22:39:11 INFO - PROCESS | 29189 | 22:39:12 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:45033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45033/tests/kraken/driver.html?testName=ai-astar) 22:39:13 INFO - PROCESS | 29189 | RSS: Main: 244973568 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | __start_tp_report 22:39:13 INFO - PROCESS | 29189 | _x_x_mozilla_page_load 22:39:13 INFO - PROCESS | 29189 | _x_x_mozilla_page_load_details 22:39:13 INFO - PROCESS | 29189 | |i|pagename|runs| 22:39:13 INFO - PROCESS | 29189 | |0;ai-astar;101;111;110;110;111;113;111;109;111;110 22:39:13 INFO - PROCESS | 29189 | |1;audio-beat-detection;147;115;116;173;116;119;139;116;152;116 22:39:13 INFO - PROCESS | 29189 | |2;audio-dft;161;160;160;161;162;163;161;163;160;161 22:39:13 INFO - PROCESS | 29189 | |3;audio-fft;75;74;76;127;76;75;75;75;101;74 22:39:13 INFO - PROCESS | 29189 | |4;audio-oscillator;83;85;115;84;85;85;130;84;85;135 22:39:13 INFO - PROCESS | 29189 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 22:39:13 INFO - PROCESS | 29189 | |6;imaging-darkroom;145;148;145;146;146;147;145;145;146;146 22:39:13 INFO - PROCESS | 29189 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 22:39:13 INFO - PROCESS | 29189 | |8;json-parse-financial;52;52;51;53;51;53;53;52;52;52 22:39:13 INFO - PROCESS | 29189 | |9;json-stringify-tinderbox;62;63;62;62;63;62;62;63;63;62 22:39:13 INFO - PROCESS | 29189 | |10;stanford-crypto-aes;76;76;76;77;76;76;76;79;76;75 22:39:13 INFO - PROCESS | 29189 | |11;stanford-crypto-ccm;122;119;120;136;118;119;121;129;168;123 22:39:13 INFO - PROCESS | 29189 | |12;stanford-crypto-pbkdf2;159;155;157;160;157;159;157;161;157;162 22:39:13 INFO - PROCESS | 29189 | |13;stanford-crypto-sha256-iterative;63;64;63;63;62;63;64;63;62;63 22:39:13 INFO - PROCESS | 29189 | __end_tp_report 22:39:13 INFO - PROCESS | 29189 | __start_cc_report 22:39:13 INFO - PROCESS | 29189 | _x_x_mozilla_cycle_collect,1677 22:39:13 INFO - PROCESS | 29189 | __end_cc_report 22:39:13 INFO - PROCESS | 29189 | __startTimestamp1469597953245__endTimestamp 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | ------- Summary: start ------- 22:39:13 INFO - PROCESS | 29189 | Number of tests: 14 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.23 (2.9%) stddev-sans-first:1.12 22:39:13 INFO - PROCESS | 29189 | Values: 101.0 111.0 110.0 110.0 111.0 113.0 111.0 109.0 111.0 110.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:129.00 stddev:20.62 (16.0%) stddev-sans-first:21.03 22:39:13 INFO - PROCESS | 29189 | Values: 147.0 115.0 116.0 173.0 116.0 119.0 139.0 116.0 152.0 116.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 22:39:13 INFO - PROCESS | 29189 | Values: 161.0 160.0 160.0 161.0 162.0 163.0 161.0 163.0 160.0 161.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:17.56 (23.4%) stddev-sans-first:18.40 22:39:13 INFO - PROCESS | 29189 | Values: 75.0 74.0 76.0 127.0 76.0 75.0 75.0 75.0 101.0 74.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:84.50 stddev:20.99 (24.8%) stddev-sans-first:21.64 22:39:13 INFO - PROCESS | 29189 | Values: 83.0 85.0 115.0 84.0 85.0 85.0 130.0 84.0 85.0 135.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:39:13 INFO - PROCESS | 29189 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 22:39:13 INFO - PROCESS | 29189 | Values: 145.0 148.0 145.0 146.0 146.0 147.0 145.0 145.0 146.0 146.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:39:13 INFO - PROCESS | 29189 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 22:39:13 INFO - PROCESS | 29189 | Values: 52.0 52.0 51.0 53.0 51.0 53.0 53.0 52.0 52.0 52.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 22:39:13 INFO - PROCESS | 29189 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 63.0 62.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 22:39:13 INFO - PROCESS | 29189 | Values: 76.0 76.0 76.0 77.0 76.0 76.0 76.0 79.0 76.0 75.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:122.50 stddev:15.27 (12.5%) stddev-sans-first:16.07 22:39:13 INFO - PROCESS | 29189 | Values: 122.0 119.0 120.0 136.0 118.0 119.0 121.0 129.0 168.0 123.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:2.17 (1.4%) stddev-sans-first:2.29 22:39:13 INFO - PROCESS | 29189 | Values: 159.0 155.0 157.0 160.0 157.0 159.0 157.0 161.0 157.0 162.0 22:39:13 INFO - PROCESS | 29189 | 22:39:13 INFO - PROCESS | 29189 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 22:39:13 INFO - PROCESS | 29189 | Values: 63.0 64.0 63.0 63.0 62.0 63.0 64.0 63.0 62.0 63.0 22:39:13 INFO - PROCESS | 29189 | -------- Summary: end -------- 22:39:13 INFO - PROCESS | 29189 | 22:39:14 INFO - TEST-INFO | 29189: exit 0 22:39:14 INFO - TEST-OK | kraken | took 60755ms 22:39:14 INFO - SUITE-END | took 1174s 22:39:14 INFO - Completed test suite (00:19:34) 22:39:14 INFO - javascript benchmark 22:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3008.6088808454897, 3044.9342730044473, 3064.7241748242654, 3069.094617087959, 3110.50231962886, 5372.516473517383, 5419.268398766166, 5457.126859702448, 5541.528970037547, 5559.888802223958, 5429.701366424845, 5476.123820188771, 5518.806841760539, 5551.77792888284, 5552.278203833496, 4854.611631069523, 4911.557959783619, 4930.112579735646, 4949.257611358289, 5136.563392111675, 5028.949710502903, 5052.69683818972, 5073.264376665381, 5083.567896728764, 5088.6946783193125, 4837.685550439228, 4940.061388336223, 4953.529414705597, 4988.700677959334, 5053.469385714502, 4925.556699896991, 4935.407751069894, 4945.826896058621, 4952.455229924705, 5000.174971129759, 4954.182559877652, 4985.102681517325, 4988.102141614508, 4994.225894986283, 5010.974945125251, 5345.198220266952, 5448.700321482317, 5511.173324001392, 5518.19986102013, 5555.138953462219, 5927.9407205928255, 5966.164736936832, 5973.522118230575, 5978.671173085479, 5986.371430999726, 5962.165296858443, 5973.372795856416, 5979.581429299951, 6022.759089636409, 6028.39716028398, 5262.631615786897, 5434.157705555605, 5456.454354564512, 5479.561635069224, 5557.5553955683445, 6046.836943743107, 6052.162837212497, 6052.450584611729, 6055.432867670813, 6055.907566157199, 5815.244018277682, 5859.414058594191, 5872.17789509469, 5875.030619947746, 5878.911816322759, 5675.4892059714, 5796.130580412888, 5860.150278209721, 5867.882642347129, 5918.496927761103, 5836.241288632451, 5882.941170588325, 5888.911666325009, 5925.229720136354, 5934.910976335358, 5875.853103672443, 5902.026165682614, 5923.970380148158, 5926.555508336892, 5929.0, 4320.092780516126, 4347.0, 4433.490148632884, 4492.752898590609, 4494.820207191741, 3920.4903362562686, 3948.973266950556, 4005.439238506611, 4011.3581826907553, 4034.8587799427464, 5523.0, 5572.0, 5572.58205634579, 5579.944200557942, 5625.46558076982, 5668.9716551417805, 5936.0, 5952.196453478725, 5962.940370596239, 6000.849978750566, 5474.39781624021, 5524.06090964537, 5553.583481238923, 5648.74580643872, 5650.604457687922, 4921.138800709861, 4951.504849515091, 4957.0, 4967.602591792648, 4993.700377977333, 6040.486558642565, 6093.268807743099, 6096.207493025879, 6100.176476175659, 6100.450959413585, 5716.657000579979, 5848.385919478394, 5865.882682346414, 5868.237129173351, 5991.2510936132985, 6084.117802918464, 6087.421694938974, 6090.0, 6090.512758979359, 6108.083787431743, 5827.0, 5838.32859221195, 5838.854028649148, 5847.356790753099, 5849.736761845812, 5694.174344720075, 5867.413258674099, 5889.852753681193, 5924.940750592611, 6016.849578760566, 5795.710214489343, 5807.651540907559, 5809.912851307149, 5815.854603634943, 5828.6211396259105, 5751.7411716472025, 5799.449052340021, 5804.158397032322, 5811.0, 5817.069268916953, 5468.535174510212, 5585.273914391103, 5614.101743720985, 5630.88738225225, 5716.428357164416, 5809.331926828469, 5825.330087040044, 5873.765049397976, 5877.794277200277, 5878.823635290948, 5628.774849005994, 5631.4368563145, 5638.23883775685, 5638.436156384329, 5639.2668953035845], "value": 5414.383701223683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.361892774731, 599.4574909706714, 630.4735545819241, 635.0125554762343, 635.4566845347231, 30134.397312053745, 30613.38773224534, 33331.66668333316, 33359.33281334372, 33421.0, 44381.0, 45814.77092614541, 45854.77072614641, 49309.753451232784, 49397.50602493974, 8917.554122293892, 9078.500682462462, 9080.182783549479, 9081.59132839024, 9086.954565227164, 9017.053209413016, 9102.317326200528, 9104.0, 9116.8632470513, 9121.680741174061, 9140.314476414262, 9144.131307525775, 9152.771180720501, 9163.083691630816, 9181.127792859668, 9037.999999999967, 9051.637934482613, 9092.727018217454, 9095.135962083592, 9097.590608422637, 8965.865512017324, 9031.774205644846, 9063.773405664846, 9064.456132632064, 9073.31950103745, 43006.78496607528, 43355.34966975498, 43374.0, 43375.78312108451, 43390.13219735619, 3480.443129099357, 3543.982280088583, 3576.78539287641, 3706.721995850295, 4215.409842622035, 33018.0, 33128.0, 33512.83243583766, 33571.0, 34991.82504087463, 4157.792110394468, 4244.448221731155, 4257.467816522934, 4354.782260886943, 4399.054203346264, 381108.9999999972, 383877.0, 385280.0, 388777.0, 390351.0, 58578.414215858145, 58886.41113588895, 58902.0, 58904.0, 58923.0, 62220.06669899955, 62259.066114008325, 62278.37721622817, 62330.0, 62374.68812655999, 17384.217710203073, 17555.21001554933, 17601.11994400275, 17610.2075406607, 17612.647747044986, 13636.181829090287, 13757.724845503033, 13812.37844297009, 13819.0, 13835.239061851493, 15273.6181595461, 16940.152992350333, 16964.522272934264, 17031.914840425718, 17202.483925482255, 5917.970410147922, 6192.256929168439, 6270.2789179244055, 6270.7491700331475, 6311.747530098744, 966.8034315553898, 1011.2668315471225, 1028.8096702110133, 1068.4123731947398, 1146.8910453506903, 33253.3349333012, 33496.0, 33503.0, 33733.491011358645, 33855.0, 1121.6915348279126, 1134.466800603715, 1159.837622732818, 1197.7245233596148, 1247.6308445386353, 17168.22742976569, 17394.910951648013, 17505.0, 17571.385001524886, 17692.557686057953, 536226.0, 541054.0, 541062.0, 541586.0, 542189.0, 59638.403615964155, 59638.403615964155, 59823.102653460235, 59952.0, 59967.700161499786, 1225.5159212111166, 1336.7393358295233, 1349.50068474665, 1356.9457221711218, 1401.628568429367, 29697.5545366824, 31162.844185778926, 34064.31871362509, 34169.31661366808, 34356.48465272973, 50241.748791255806, 50614.0, 50616.74691626518, 50703.0, 50720.49279507158, 406319.0, 406951.0, 406972.0, 407632.80917977286, 408642.0, 24612.384690382885, 26761.464770704086, 27718.0, 27745.861270694324, 28952.855235723688, 44871.32693009542, 44960.10079798451, 45957.310640339754, 46338.76830615825, 46438.76780616075, 40685.186296273314, 41274.38088428616, 41700.0, 42843.357349639155, 43298.0, 40764.0, 41645.0, 41773.0, 41888.162236754484, 42536.78731606322, 40732.0, 40856.38715419212, 40907.18185636211, 40969.79515102405, 41045.794771025954, 34203.4869476963, 36366.27267454689, 36685.44971825478, 37119.628803712694, 37286.44070339001, 28274.0, 28427.672955975173, 28453.715462845106, 28749.0, 28775.280617984718], "value": 20157.0721005515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5491500369548, 383.82152299180876, 385.955615104263, 398.2671883733929, 400.1097557933598, 17900.910495447522, 18905.810941890577, 19396.418107456764, 19490.805091949078, 19585.118669659863, 18584.256629734828, 18931.810681893177, 19037.714434283498, 19162.808371916275, 19315.517112072204, 5809.448102430262, 5810.825675229728, 5854.590178687494, 5998.370171132012, 5998.8800223995495, 5685.459881311269, 5752.827415177551, 5754.0, 5816.5055970242365, 5819.447152520504, 5694.2312787773535, 5727.284089488814, 5733.168690539869, 5796.449337312949, 5821.446962538552, 5697.230873832042, 5829.708514574254, 5837.824865254028, 5855.677937713424, 5864.882702345929, 4723.244280915037, 4952.603791696692, 4983.177775667011, 5018.222175562793, 5190.844274671766, 12541.372931353395, 12791.168574042751, 14383.568492945229, 22266.220682276205, 22612.43468913274, 2149.570085982794, 2187.56248750249, 2245.14684419921, 2295.437617783637, 2607.8044146689076, 8950.462972221623, 9093.63625454981, 9500.097490738368, 9636.0, 9825.950870245675, 1864.5338665333666, 1935.823146531188, 1968.2422267427, 1968.379960312497, 1971.9704204436946, 72035.63982180055, 84331.0, 84861.0, 85488.57255713681, 87644.0, 8860.158284962918, 9400.670976515788, 9404.200642945289, 9582.377145485521, 10322.174226061898, 12226.816597751042, 12642.431090600945, 12642.810357844455, 12705.17416367933, 12738.617841464771, 7543.396528277724, 7684.385249180053, 7768.922310776933, 7897.3287270581495, 8025.478343907627, 7438.814029649302, 7521.736739214101, 7564.654956963359, 7649.38804895607, 7939.0870049945, 3749.962500374961, 3805.5433347997864, 3952.3676211805973, 4023.114914718757, 4045.2314060328445, 1901.3250296144945, 1908.6182763447366, 1922.6731455652573, 1929.604431091651, 1985.4540001499704, 889.4085433186858, 911.5761171055491, 1020.5407566594913, 1033.1734612310122, 1073.5598404654054, 19053.237870485304, 20069.49826254326, 20126.798732012787, 20142.0, 20191.4952126198, 970.3289882060832, 970.9708708738749, 979.8040391921644, 1017.704865588971, 1047.533847437898, 10933.016028557468, 11283.097352211804, 11301.0, 11320.377379244055, 11322.886771132347, 523956.0, 528864.0, 536351.0, 538174.0, 540764.0, 87710.56144719236, 88082.0, 90172.49137543097, 91309.0, 91330.0, 982.7051884434641, 1019.3781793106199, 1020.5254556631202, 1027.111548510548, 1032.2155162076726, 17013.829861701226, 17113.82886171172, 18472.72290915664, 18525.35161269403, 18709.625807483502, 40961.1807763849, 43351.0, 43704.781476092416, 45321.00462326627, 46258.537414625425, 59023.0, 59194.40805591889, 61391.693041534505, 62296.0, 63040.36959630345, 7886.804673293115, 7892.921070789448, 7965.960170199112, 8021.398395120273, 8073.233042860918, 7252.093488313961, 11946.223495472766, 12716.809247861105, 12910.935445322713, 13378.732425351243, 6130.693465326626, 10740.140788737039, 11617.6514704559, 11710.0, 12065.0, 11465.082793376343, 11890.524379024742, 11998.460069296729, 12096.637100886988, 12295.877041229473, 11517.82723259135, 12151.392430378623, 12208.145429820182, 12382.318972456602, 12671.113022088366, 8118.6752529900505, 8137.389695772722, 8218.465799722999, 8262.049864265686, 8318.0, 9547.8837216244, 11535.36555489456, 12240.938795305967, 12303.539292141786, 12562.120651554304], "value": 8937.381431463316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.261756034181, 1437.1018113678952, 1492.3359105198185, 1574.4095964013495, 1751.0456801043438, 8291.626876790544, 8529.701460448885, 8547.957260213698, 8859.689910853122, 8869.0, 8744.0, 8837.027926928033, 8842.071582483843, 8844.469331840079, 8853.0, 2368.0882860098855, 2375.4536456614987, 2394.305651361103, 2396.2451827674313, 2397.2688330059327, 2360.704911886014, 2370.7036620422446, 2407.903683852644, 2414.746451622572, 2416.8912398942, 2284.543091381722, 2354.6578450283346, 2354.82338824588, 2356.0340260493203, 2382.7617238276207, 2280.897359618821, 2284.8172146228344, 2294.105298933409, 2301.091069027733, 2348.917787877433, 2305.227748704186, 2311.653252012195, 2315.0508291600363, 2315.1549684365086, 2315.444293369596, 8704.086070962585, 8707.825843483159, 8756.956215218946, 8773.0, 8773.473591584525, 4971.229459433757, 5117.7185254810975, 5126.154184559543, 5137.717425541594, 5138.229265610151, 3153.936921261562, 3206.9358612827614, 3215.8713651453913, 3237.8542965566608, 3240.643529211785, 957.3346524165707, 962.7352478068517, 972.8297547929155, 977.5698692575315, 977.6822532676908, 11264.943675281653, 11405.0, 11415.543378264943, 11421.143414243881, 11429.257098288668, 4215.747055176699, 4474.485434175046, 4600.677952543289, 4633.513481084505, 4637.258038713857, 9979.80040399188, 10025.0, 10151.340162889537, 10406.5837366506, 10407.0, 5075.416327122354, 5119.641625086283, 5121.667091639031, 5122.103631864484, 5122.538971492509, 4177.832886684499, 4207.410962465257, 4712.69367491112, 4749.501302363271, 4784.114938736345, 3903.5510916244993, 3942.8422863085157, 4025.255327764373, 4025.376066709665, 4083.8570650027104, 1235.4008305971597, 1253.4798058805493, 1266.6263452281598, 1267.8098285257101, 1271.3007845684836, 998.3361064891766, 1005.5374527717332, 1011.8128146292812, 1025.5692609104194, 1028.5422986770964, 5911.940880591225, 6040.788572399945, 6067.24159480065, 6081.087836824512, 6302.936970630235, 405.6004835237289, 414.6040531292608, 416.01819705495006, 416.4378089579044, 418.9601987811214, 4089.8977525561504, 4216.536181020086, 4294.055307832335, 4354.716943398669, 4388.780560971939, 10437.634682786218, 10653.414062226651, 10656.893431065746, 10762.78474430507, 10766.246362754531, 10408.230600797882, 10552.736181595521, 10696.251262411557, 10713.464326783629, 10729.302595331279, 8118.147594502492, 8187.426880118334, 8194.30348420379, 8194.754157375288, 8201.015878094668, 6000.819975400745, 6207.441330280297, 6224.128621992834, 6229.968850155901, 6387.169667943138, 9546.522673866419, 9700.417974921527, 9847.803043939224, 9978.850317245102, 10050.597976080875, 10073.194144468278, 10101.595936162765, 10188.541515631963, 10282.485875706036, 10285.485725713535, 7576.090869095744, 7746.147923728273, 7817.6872925084635, 7989.241022102891, 7992.760217193493, 8434.493930364199, 8519.318454523747, 8570.228679418882, 8575.228229459379, 8584.74245772628, 7707.653155608124, 7724.7682569523, 7771.961140194263, 7800.45396822217, 7889.881651775343, 7624.80937976555, 7711.3830893527265, 7714.267144621252, 7749.651265692944, 7919.208079192034, 6901.068355771907, 6922.10012698346, 6939.826504337432, 6998.650067496503, 6999.230084690782, 5270.314859068297, 5378.569714422915, 5383.4885685861345, 5399.190121481809, 5540.889182216414, 5223.425423203368, 5245.0558899398475, 5291.153415453509, 5309.681419114865, 5428.131498960148], "value": 4508.733883491839, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.15438269358293, 302.7789713509138, 308.88571228645407, 310.62569603627634, 314.52192667145954, 5123.5388815006645, 5211.5309622133955, 5225.320708307924, 5281.1286137787265, 5289.471052894709, 5232.816851410202, 5237.607179461536, 5266.368035835695, 5294.655847369918, 5299.417064122943, 4118.320477121271, 4123.60825721556, 4130.380442933554, 4144.316187829005, 4156.397322388259, 3946.4869566956254, 4056.3571753439905, 4143.378493226025, 4148.43996060531, 4149.107941792514, 4036.414719865618, 4038.313486707252, 4044.413560033808, 4051.635352818246, 4061.4110953911663, 4015.437838702584, 4037.3338399164395, 4057.4116753070934, 4065.695072869532, 4074.9185016299803, 3400.6429324921023, 3489.145159435929, 3498.4577390504514, 3557.5019497270405, 3565.4668492548194, 5059.747012649353, 5109.182530795092, 5119.56483698886, 5129.307543481619, 5141.717205553693, 4574.794134263932, 4602.412167802103, 4622.8382006629945, 4626.791794369262, 4630.402511133653, 5344.770702738353, 5409.134538473825, 5456.181572764078, 5490.862728431821, 5513.2005859150195, 3842.1739326045035, 3849.287881741887, 3852.1332700142525, 3858.9387918322404, 3861.2856621525107, 5649.802256921029, 5654.264945557051, 5677.432256774331, 5690.687012214326, 5711.371749107595, 3804.296205201991, 3924.9607503924594, 3948.2103579283685, 3950.111224974415, 3953.7627742335553, 3974.82113304902, 3976.443297938291, 3995.440638310639, 3996.7002474813926, 4003.2393845169327, 4584.266517357207, 4606.078784243098, 4616.3998680172035, 4623.9075218495445, 4641.305923337957, 5277.577793776489, 5511.751971161308, 5526.392096869341, 5575.881165157214, 5581.134924086773, 1293.6313150751992, 1340.544214966916, 1349.0961056092442, 1351.9662008449868, 1361.3669643615767, 891.5497673674753, 907.6505545365083, 924.4499522783933, 925.4724806860025, 929.4284015330658, 5231.215317702299, 5282.603804714662, 5287.814926477555, 5297.867553311198, 5303.708296043755, 5613.438656134354, 5619.330817861483, 5622.863311941436, 5628.465295796893, 5650.406707295757, 5196.41509339655, 5274.525292723673, 5311.946880531223, 5331.626786125012, 5352.063388907003, 3007.473692103873, 3010.9397812043635, 3015.853975489344, 3018.0945716285028, 3055.9915227974716, 5863.736131874076, 5878.794242201502, 5883.2057672213705, 5890.936712909263, 5899.026660600953, 5512.834614961557, 5739.540836733051, 5746.448458916069, 5754.856128596819, 5768.3654797972185, 5817.854553636108, 5820.970895145497, 5838.883222335615, 5841.41585841421, 5893.44012318829, 5434.483724046209, 5658.830235092953, 5674.290713660793, 5715.885682286248, 5748.281464816898, 5543.420125264281, 5594.916076258941, 5602.607817452902, 5639.351474580476, 5647.0, 5801.332846722681, 5805.796797112081, 5824.912626310524, 5855.765769369177, 5860.413958604276, 3752.94370584436, 3851.9422208666333, 3890.221955608833, 3907.6873850092493, 3927.941080883846, 5534.750936207961, 5715.599908006566, 5721.312212897288, 5743.9138412923, 5755.97122014404, 5494.2857428535635, 5534.778608855761, 5549.084401073777, 5577.860553486195, 5595.832125036255, 5535.8892822144135, 5550.361708403424, 5567.164925261243, 5585.3297604287745, 5588.30146231721, 5285.0, 5424.972875135599, 5497.752601133038, 5509.586780991362, 5526.944730552643, 5566.888662226652, 5567.109262517978, 5579.7489112990825, 5587.245721827501, 5592.804251851166, 5454.181872719124, 5504.4495550444635, 5505.614606977473, 5511.779528818803, 5515.503604675599], "value": 4173.9972031709485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.3997122431547, 711.7757906259528, 713.8715031294369, 716.8136284566011, 720.125048066599, 14681.0, 15294.541163765078, 15478.613034674125, 15551.377944882192, 15785.447509337162, 15285.84714152861, 15352.539423817276, 15392.076475411483, 15442.227888605581, 15469.76795348068, 808.0626473290984, 825.1830687619274, 829.0134739659816, 829.0921441022101, 830.0454477351034, 673.5386260411609, 801.5751651624648, 822.48183644304, 825.471698113205, 827.764087235138, 862.6032025268385, 871.1941454154913, 871.2028493928049, 871.2507243770352, 871.590352534311, 859.2481578618708, 860.3934226370425, 860.9870851937226, 861.027039445429, 861.8664107063415, 511.96160287978176, 601.8615718384752, 615.5229696984873, 619.340402471371, 619.7087368936593, 13357.933210333984, 13460.596182114552, 13473.191608503521, 13486.730265394735, 13497.717716816986, 13404.664883377896, 13778.65553361164, 13887.861121388758, 13971.930140349234, 14024.579262622137, 12768.872311276862, 13021.28382938938, 13206.867931320756, 13657.317134143253, 14191.432342706383, 3943.4084887266854, 3970.265500882346, 3982.601739825994, 4058.939115913264, 4137.958620413788, 67304.6634766823, 68949.65525172392, 69871.65064174698, 77561.22438775597, 78041.60979195124, 11304.877264019708, 11450.198486105892, 11683.0, 11704.590339338252, 11940.223885447418, 21712.240071597735, 21915.232966846404, 21921.780782192294, 21999.890000549894, 22051.33845984623, 8952.955235223912, 8985.730428087169, 8989.101089890959, 9029.954850225708, 9405.106514881076, 4927.433345165352, 5066.797328106908, 5095.898082038412, 5107.106256405188, 5210.062188805976, 3437.2438063626464, 3514.086337552255, 3536.7170626350344, 3543.1496440854007, 3552.1474846036767, 644.8130042287778, 669.6015870557109, 679.1307126877605, 679.1917618034523, 681.2029924987776, 666.3602941176428, 743.0822933676905, 760.4336258587199, 761.6953218712559, 781.2265856801839, 9423.38747981379, 9952.800943981225, 10096.192304615613, 10176.236782241362, 10184.490775461345, 736.9410447164214, 753.2505157368454, 758.9506682065648, 762.5005621318046, 766.9616519174131, 4699.765011749399, 4910.533499317559, 4931.753412329369, 4932.753362331869, 4932.876678083005, 125161.74838251683, 125862.0, 127740.3435512955, 130198.0, 134280.0, 110972.0, 111698.44150779357, 112462.0, 113495.0, 116503.41748291205, 90370.0, 94821.52589237009, 96763.0, 97206.51396742971, 98112.50943745236, 9125.497889542748, 9192.586333615138, 9331.206847417774, 9345.205657519187, 9531.428114313163, 56058.71970640121, 56443.71778141083, 56817.43182568121, 57408.42591574198, 58499.4150058511, 77368.61315693386, 82080.9306074524, 84832.57583712041, 86202.56898715466, 87076.0, 11380.260283081574, 11538.826917596074, 11794.705132371759, 11821.290722556674, 12390.62828115158, 14612.85387146115, 14873.85126148768, 14932.402703891723, 15689.60775980564, 15840.920795395949, 13271.668208294484, 13371.3982870773, 13692.3838427273, 14321.928390358398, 14461.349239284047, 14425.85574144245, 14538.127712337293, 14609.0, 14976.951613386958, 15094.924525377302, 13658.726825463635, 13975.504701293376, 14146.0, 14198.3610737515, 14475.059121157092, 10640.0, 10643.239522411133, 10935.28920620157, 11020.834687479533, 11041.613543526259, 10198.898011019795, 10623.205539604724, 11579.942100289445, 11679.76640467203, 11879.643610691694], "value": 7750.052706789329, "unit": "score"}], "name": "dromaeo_css", "value": 7225.324907139603, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 110.0, 111.0, 113.0, 111.0, 109.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 116.0, 173.0, 116.0, 119.0, 139.0, 116.0, 152.0, 116.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 163.0, 161.0, 163.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 127.0, 76.0, 75.0, 75.0, 75.0, 101.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 115.0, 84.0, 85.0, 85.0, 130.0, 84.0, 85.0, 135.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 51.0, 53.0, 53.0, 52.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 76.0, 76.0, 76.0, 79.0, 76.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 120.0, 136.0, 118.0, 119.0, 121.0, 129.0, 168.0, 123.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 157.0, 160.0, 157.0, 159.0, 157.0, 161.0, 157.0, 162.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1479.0, "alertThreshold": 2.0}]} 22:39:14 INFO - Return code: 0 22:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:39:14 INFO - # TBPL SUCCESS # 22:39:14 INFO - Running post-action listener: _resource_record_post_action 22:39:14 INFO - [mozharness: 2016-07-27 05:39:14.515241Z] Finished run-tests step (success) 22:39:14 INFO - Running post-run listener: _resource_record_post_run 22:39:14 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558784512; Read time: 16; Write time: 540816 22:39:14 INFO - TinderboxPrint: CPU usage
13.0% 22:39:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:39:14 INFO - TinderboxPrint: I/O write bytes / time
558,784,512 / 540,816 22:39:14 INFO - TinderboxPrint: CPU idle
8,276.4 (87.0%) 22:39:14 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 22:39:14 INFO - TinderboxPrint: Swap in / out
0 / 0 22:39:14 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 261492736; Read time: 0; Write time: 316172 22:39:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296960000; Read time: 0; Write time: 224592 22:39:15 INFO - Running post-run listener: _upload_blobber_files 22:39:15 INFO - Blob upload gear active. 22:39:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:39:15 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:39:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:16 INFO - (blobuploader) - INFO - Done attempting. 22:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:17 INFO - (blobuploader) - INFO - Done attempting. 22:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:28 INFO - (blobuploader) - INFO - Done attempting. 22:39:28 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:28 INFO - Return code: 0 22:39:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b3b596a03a3af042d7d1820c16aab78a7bc672aaa04e1577a037b661f1406523fb056c82b29775cecb7d7722e8adaf990e17f6fba1bae505a2a355cc3da1405", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48289357460e1ab194b079d977a6b3ee9540f3bcefd30398119dda71212f8567926366aab210aca7dc7560c001a461e0b7c12f339a1e279a0ab0070d182e4f32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55b00dcf90a4deaa8d160c897d3815d1607c07182446d09cba5cb7f9d93f2239c2fb9367c5c70ec16005e7b164585beb5e4cae9d585a357c3c5e28810d2708bf"} 22:39:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:28 INFO - Contents: 22:39:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b3b596a03a3af042d7d1820c16aab78a7bc672aaa04e1577a037b661f1406523fb056c82b29775cecb7d7722e8adaf990e17f6fba1bae505a2a355cc3da1405", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48289357460e1ab194b079d977a6b3ee9540f3bcefd30398119dda71212f8567926366aab210aca7dc7560c001a461e0b7c12f339a1e279a0ab0070d182e4f32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55b00dcf90a4deaa8d160c897d3815d1607c07182446d09cba5cb7f9d93f2239c2fb9367c5c70ec16005e7b164585beb5e4cae9d585a357c3c5e28810d2708bf"} 22:39:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:28 INFO - Copying logs to upload dir... 22:39:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.475874 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-26 22:39:28.493993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 22:39:28.497352) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b3b596a03a3af042d7d1820c16aab78a7bc672aaa04e1577a037b661f1406523fb056c82b29775cecb7d7722e8adaf990e17f6fba1bae505a2a355cc3da1405", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48289357460e1ab194b079d977a6b3ee9540f3bcefd30398119dda71212f8567926366aab210aca7dc7560c001a461e0b7c12f339a1e279a0ab0070d182e4f32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55b00dcf90a4deaa8d160c897d3815d1607c07182446d09cba5cb7f9d93f2239c2fb9367c5c70ec16005e7b164585beb5e4cae9d585a357c3c5e28810d2708bf"} build_url:https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/IjDKByrKRuOLw9g_sdURrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b3b596a03a3af042d7d1820c16aab78a7bc672aaa04e1577a037b661f1406523fb056c82b29775cecb7d7722e8adaf990e17f6fba1bae505a2a355cc3da1405", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48289357460e1ab194b079d977a6b3ee9540f3bcefd30398119dda71212f8567926366aab210aca7dc7560c001a461e0b7c12f339a1e279a0ab0070d182e4f32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55b00dcf90a4deaa8d160c897d3815d1607c07182446d09cba5cb7f9d93f2239c2fb9367c5c70ec16005e7b164585beb5e4cae9d585a357c3c5e28810d2708bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 22:39:28.527357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:39:28.527704) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469596729.666542-59769493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 22:39:28.611088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 22:39:28.611437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 22:39:28.611762) ========= ========= Total master_lag: 0.19 =========