builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1468926555.0 results: success (0) buildid: 20160719012047 builduid: 21dbf6577868400b9bbb6c897bc58d57 revision: 7b4b7cb665c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:14.996647) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:14.997539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:14.998168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.017804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.018411) ========= 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-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 04:09:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2016-07-19 04:09:15 (105 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.123289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.123982) ========= 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-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016387 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.180277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.180614) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7b4b7cb665c3 --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 7b4b7cb665c3 --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-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 04:09:15,778 Setting DEBUG logging. 2016-07-19 04:09:15,778 attempt 1/10 2016-07-19 04:09:15,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7b4b7cb665c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 04:09:16,108 unpacking tar archive at: mozilla-inbound-7b4b7cb665c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.871435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.872172) ========= script_repo_revision: 7b4b7cb665c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.873029) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.873661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 04:09:15.887823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 04:09:15.888128) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:16 INFO - MultiFileLogger online at 20160719 04:09:16 in /builds/slave/test 04:09:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:09:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:16 INFO - {'append_to_log': False, 04:09:16 INFO - 'base_work_dir': '/builds/slave/test', 04:09:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:09:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:16 INFO - 'branch': 'Mozilla-Inbound', 04:09:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:16 INFO - 'config_files': ('talos/linux_config.py',), 04:09:16 INFO - 'default_actions': ('clobber', 04:09:16 INFO - 'read-buildbot-config', 04:09:16 INFO - 'download-and-extract', 04:09:16 INFO - 'populate-webroot', 04:09:16 INFO - 'create-virtualenv', 04:09:16 INFO - 'install', 04:09:16 INFO - 'run-tests'), 04:09:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:16 INFO - 'download_minidump_stackwalk': True, 04:09:16 INFO - 'download_symbols': 'ondemand', 04:09:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:16 INFO - 'installer_path': 'installer.exe', 04:09:16 INFO - 'log_level': 'info', 04:09:16 INFO - 'log_name': 'talos', 04:09:16 INFO - 'log_to_console': True, 04:09:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:16 INFO - 'opt_config_files': (), 04:09:16 INFO - 'pip_index': False, 04:09:16 INFO - 'sps_profile': False, 04:09:16 INFO - 'sps_profile_interval': 0, 04:09:16 INFO - 'suite': 'dromaeojs-e10s', 04:09:16 INFO - 'system_bits': '32', 04:09:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:16 INFO - 'title': 'talos-linux64-ix-004', 04:09:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:16 INFO - 'use_talos_json': True, 04:09:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:16 INFO - 'work_dir': 'build'} 04:09:16 INFO - ##### 04:09:16 INFO - ##### Running clobber step. 04:09:16 INFO - ##### 04:09:16 INFO - Running pre-action listener: _resource_record_pre_action 04:09:16 INFO - Running main action method: clobber 04:09:16 INFO - rmtree: /builds/slave/test/build 04:09:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - ##### 04:09:17 INFO - ##### Finished clobber step (success) 04:09:17 INFO - ##### 04:09:17 INFO - ##### 04:09:17 INFO - ##### Running read-buildbot-config step. 04:09:17 INFO - ##### 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: read_buildbot_config 04:09:17 INFO - Using buildbot properties: 04:09:17 INFO - { 04:09:17 INFO - "project": "", 04:09:17 INFO - "product": "firefox", 04:09:17 INFO - "script_repo_revision": "production", 04:09:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:09:17 INFO - "repository": "", 04:09:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:09:17 INFO - "buildid": "20160719012047", 04:09:17 INFO - "pgo_build": "True", 04:09:17 INFO - "basedir": "/builds/slave/test", 04:09:17 INFO - "buildnumber": 1051, 04:09:17 INFO - "slavename": "talos-linux64-ix-004", 04:09:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:09:17 INFO - "platform": "ubuntu64_hw", 04:09:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:09:17 INFO - "branch": "mozilla-inbound", 04:09:17 INFO - "repo_path": "integration/mozilla-inbound", 04:09:17 INFO - "revision": "7b4b7cb665c3", 04:09:17 INFO - "stage_platform": "linux64-pgo", 04:09:17 INFO - "builduid": "21dbf6577868400b9bbb6c897bc58d57", 04:09:17 INFO - "slavebuilddir": "test" 04:09:17 INFO - } 04:09:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - ##### 04:09:17 INFO - ##### Finished read-buildbot-config step (success) 04:09:17 INFO - ##### 04:09:17 INFO - ##### 04:09:17 INFO - ##### Running download-and-extract step. 04:09:17 INFO - ##### 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: download_and_extract 04:09:17 INFO - mkdir: /builds/slave/test/build/tests 04:09: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')]} 04:09:17 INFO - https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:23 INFO - Downloaded 1361 bytes. 04:09:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:23 INFO - Using the following test package requirements: 04:09:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'jsshell-linux-x86_64.zip'], 04:09:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:23 INFO - https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:26 INFO - Downloaded 24336018 bytes. 04:09:26 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'] 04:09:26 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 04:09:27 INFO - Return code: 0 04:09:27 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 04:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:27 INFO - https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:31 INFO - Downloaded 24336018 bytes. 04:09:31 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'] 04:09:31 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 04:09:32 INFO - Return code: 0 04:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:32 INFO - https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:34 INFO - Downloaded 14403317 bytes. 04:09:34 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'] 04:09:34 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 04:09:34 INFO - Return code: 0 04:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:34 INFO - https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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 04:09:35 INFO - Downloaded 60831578 bytes. 04:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:35 INFO - mkdir: /builds/slave/test/properties 04:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:35 INFO - Contents: 04:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:36 INFO - Running post-action listener: _resource_record_post_action 04:09:36 INFO - Running post-action listener: set_extra_try_arguments 04:09:36 INFO - ##### 04:09:36 INFO - ##### Finished download-and-extract step (success) 04:09:36 INFO - ##### 04:09:36 INFO - ##### 04:09:36 INFO - ##### Running populate-webroot step. 04:09:36 INFO - ##### 04:09:36 INFO - Running pre-action listener: _resource_record_pre_action 04:09:36 INFO - Running main action method: populate_webroot 04:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:36 INFO - '--tppagecycles', 04:09:36 INFO - '7'], 04:09:36 INFO - 'tests': ['tsvgm']}}, 04:09:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['damp', 'tps']}, 04:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'tests': ['damp', 'tps']}, 04:09:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['dromaeo_dom']}, 04:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['basic_compositor_video']}, 04:09:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:09:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['a11yr', 04:09:36 INFO - 'ts_paint', 04:09:36 INFO - 'tpaint', 04:09:36 INFO - 'sessionrestore', 04:09:36 INFO - 'sessionrestore_no_auto_restore', 04:09:36 INFO - 'tabpaint']}, 04:09:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['tsvgx', 04:09:36 INFO - 'tsvgr_opacity', 04:09:36 INFO - 'tart', 04:09:36 INFO - 'tscrollx', 04:09:36 INFO - 'cart']}, 04:09:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:36 INFO - 'tsvgr_opacity', 04:09:36 INFO - 'tart', 04:09:36 INFO - 'tscrollx', 04:09:36 INFO - 'cart']}, 04:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'talos_options': ['--disable-e10s'], 04:09:36 INFO - 'tests': ['tp5o']}, 04:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'tests': ['tp5o']}, 04:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'talos_options': ['--disable-e10s', 04:09:36 INFO - '--xperf_path', 04:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:36 INFO - 'tests': ['tp5n']}, 04:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:36 INFO - 'talos_options': ['--xperf_path', 04:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:36 INFO - 'tests': ['tp5n']}}, 04:09:36 INFO - 'talos.zip': {'path': '', 04:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:36 INFO - Running post-action listener: _resource_record_post_action 04:09:36 INFO - ##### 04:09:36 INFO - ##### Finished populate-webroot step (success) 04:09:36 INFO - ##### 04:09:36 INFO - ##### 04:09:36 INFO - ##### Running create-virtualenv step. 04:09:36 INFO - ##### 04:09:36 INFO - Running pre-action listener: _resource_record_pre_action 04:09:36 INFO - Running main action method: create_virtualenv 04:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:36 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 04:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:36 INFO - Using real prefix '/usr' 04:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:39 INFO - Installing pip.................done. 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 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 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 INFO - Downloading/unpacking psutil>=3.1.1 04:09:39 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 04:09:39 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 04:09:39 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 04:09:39 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 04:09:39 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 04:09:39 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 04:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:41 INFO - Installing collected packages: psutil 04:09:41 INFO - Running setup.py install for psutil 04:09:41 INFO - building 'psutil._psutil_linux' extension 04:09:41 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 04:09:41 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 04:09:41 INFO - building 'psutil._psutil_posix' extension 04:09:41 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 04:09:41 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 04:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:41 INFO - Successfully installed psutil 04:09:41 INFO - Cleaning up... 04:09:41 INFO - Return code: 0 04:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09:41 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')]} 04:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:41 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')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09:42 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 04:09:42 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 04:09:42 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 04:09:42 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 04:09:42 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 04:09:42 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 04:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:44 INFO - Installing collected packages: mozsystemmonitor 04:09:44 INFO - Running setup.py install for mozsystemmonitor 04:09:44 INFO - Successfully installed mozsystemmonitor 04:09:44 INFO - Cleaning up... 04:09:44 INFO - Return code: 0 04:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:44 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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:44 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 04:09:44 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 04:09:44 INFO - Using env: {'DISPLAY': ':0', 04:09:44 INFO - 'HOME': '/home/cltbld', 04:09:44 INFO - 'LANG': 'en_US.UTF-8', 04:09:44 INFO - 'LANGUAGE': 'en_US:en', 04:09:44 INFO - 'LOGNAME': 'cltbld', 04:09:44 INFO - 'MAIL': '/var/mail/cltbld', 04:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:44 INFO - 'MOZ_NO_REMOTE': '1', 04:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:44 INFO - 'NO_EM_RESTART': '1', 04:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:44 INFO - 'PWD': '/builds/slave/test', 04:09:44 INFO - 'SHELL': '/bin/bash', 04:09:44 INFO - 'SHLVL': '1', 04:09:44 INFO - 'TERM': 'linux', 04:09:44 INFO - 'TMOUT': '86400', 04:09:44 INFO - 'USER': 'cltbld', 04:09:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:44 INFO - '_': '/tools/buildbot/bin/python'} 04:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:46 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 04:09:46 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 04:09:46 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 04:09:46 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 04:09:46 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 04:09:46 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 04:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:46 INFO - warning: no files found matching '*.txt' 04:09:46 INFO - no previously-included directories found matching 'build' 04:09:46 INFO - no previously-included directories found matching 'dist' 04:09:46 INFO - no previously-included directories found matching '.git*' 04:09:46 INFO - Installing collected packages: jsonschema, functools32 04:09:46 INFO - Running setup.py install for functools32 04:09:46 INFO - warning: no files found matching '*.txt' 04:09:46 INFO - no previously-included directories found matching 'build' 04:09:46 INFO - no previously-included directories found matching 'dist' 04:09:46 INFO - no previously-included directories found matching '.git*' 04:09:46 INFO - Successfully installed jsonschema functools32 04:09:46 INFO - Cleaning up... 04:09:46 INFO - Return code: 0 04:09:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:09:46 INFO - Using env: {'DISPLAY': ':0', 04:09:46 INFO - 'HOME': '/home/cltbld', 04:09:46 INFO - 'LANG': 'en_US.UTF-8', 04:09:46 INFO - 'LANGUAGE': 'en_US:en', 04:09:46 INFO - 'LOGNAME': 'cltbld', 04:09:46 INFO - 'MAIL': '/var/mail/cltbld', 04:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:46 INFO - 'MOZ_NO_REMOTE': '1', 04:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:46 INFO - 'NO_EM_RESTART': '1', 04:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:46 INFO - 'PWD': '/builds/slave/test', 04:09:46 INFO - 'SHELL': '/bin/bash', 04:09:46 INFO - 'SHLVL': '1', 04:09:46 INFO - 'TERM': 'linux', 04:09:46 INFO - 'TMOUT': '86400', 04:09:46 INFO - 'USER': 'cltbld', 04:09:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:46 INFO - '_': '/tools/buildbot/bin/python'} 04:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - Downloading docopt-0.6.1.tar.gz 04:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:49 INFO - Running setup.py install for blobuploader 04:09:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:49 INFO - Running setup.py install for requests 04:09:50 INFO - Running setup.py install for docopt 04:09:50 INFO - Successfully installed blobuploader requests docopt 04:09:50 INFO - Cleaning up... 04:09:50 INFO - Return code: 0 04:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:50 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')]} 04:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:50 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')]} 04:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:50 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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:50 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 04:09:50 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 04:09:50 INFO - Using env: {'DISPLAY': ':0', 04:09:50 INFO - 'HOME': '/home/cltbld', 04:09:50 INFO - 'LANG': 'en_US.UTF-8', 04:09:50 INFO - 'LANGUAGE': 'en_US:en', 04:09:50 INFO - 'LOGNAME': 'cltbld', 04:09:50 INFO - 'MAIL': '/var/mail/cltbld', 04:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:50 INFO - 'MOZ_NO_REMOTE': '1', 04:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:50 INFO - 'NO_EM_RESTART': '1', 04:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:50 INFO - 'PWD': '/builds/slave/test', 04:09:50 INFO - 'SHELL': '/bin/bash', 04:09:50 INFO - 'SHLVL': '1', 04:09:50 INFO - 'TERM': 'linux', 04:09:50 INFO - 'TMOUT': '86400', 04:09:50 INFO - 'USER': 'cltbld', 04:09:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:50 INFO - '_': '/tools/buildbot/bin/python'} 04:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:50 INFO - Running setup.py (path:/tmp/pip-dDL0g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:50 INFO - Running setup.py (path:/tmp/pip-MS1S1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:50 INFO - Running setup.py (path:/tmp/pip-dbU7a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:50 INFO - Running setup.py (path:/tmp/pip-WpiUZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:50 INFO - Running setup.py (path:/tmp/pip-sSD_V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:50 INFO - Running setup.py (path:/tmp/pip-idvwKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:51 INFO - Running setup.py (path:/tmp/pip-8Iz5Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:51 INFO - Running setup.py (path:/tmp/pip-smXrT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:51 INFO - Running setup.py (path:/tmp/pip-UWb1kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:51 INFO - Running setup.py (path:/tmp/pip-RpqMPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:51 INFO - Running setup.py (path:/tmp/pip-KMgoLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:51 INFO - Running setup.py (path:/tmp/pip-lIMZKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:51 INFO - Running setup.py (path:/tmp/pip-KA76dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:51 INFO - Running setup.py (path:/tmp/pip-620s1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:51 INFO - Running setup.py (path:/tmp/pip-diHACN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:51 INFO - Running setup.py (path:/tmp/pip-oWX1R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:51 INFO - Running setup.py (path:/tmp/pip-WVZOxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:51 INFO - Running setup.py install for manifestparser 04:09:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozcrash 04:09:52 INFO - Running setup.py install for mozdebug 04:09:52 INFO - Running setup.py install for mozdevice 04:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozfile 04:09:52 INFO - Running setup.py install for mozhttpd 04:09:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozinfo 04:09:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozInstall 04:09:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozleak 04:09:52 INFO - Running setup.py install for mozlog 04:09:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for moznetwork 04:09:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozprocess 04:09:53 INFO - Running setup.py install for mozprofile 04:09:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Running setup.py install for mozrunner 04:09:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Running setup.py install for mozscreenshot 04:09:53 INFO - Running setup.py install for moztest 04:09:53 INFO - Running setup.py install for mozversion 04:09:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:53 INFO - Cleaning up... 04:09:53 INFO - Return code: 0 04:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:53 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')]} 04:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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')]} 04:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:53 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 04:09:53 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 04:09:53 INFO - Using env: {'DISPLAY': ':0', 04:09:53 INFO - 'HOME': '/home/cltbld', 04:09:53 INFO - 'LANG': 'en_US.UTF-8', 04:09:53 INFO - 'LANGUAGE': 'en_US:en', 04:09:53 INFO - 'LOGNAME': 'cltbld', 04:09:53 INFO - 'MAIL': '/var/mail/cltbld', 04:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:53 INFO - 'MOZ_NO_REMOTE': '1', 04:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:53 INFO - 'NO_EM_RESTART': '1', 04:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:53 INFO - 'PWD': '/builds/slave/test', 04:09:53 INFO - 'SHELL': '/bin/bash', 04:09:53 INFO - 'SHLVL': '1', 04:09:53 INFO - 'TERM': 'linux', 04:09:53 INFO - 'TMOUT': '86400', 04:09:53 INFO - 'USER': 'cltbld', 04:09:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:53 INFO - '_': '/tools/buildbot/bin/python'} 04:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:53 INFO - Running setup.py (path:/tmp/pip-_scXZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:53 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)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:53 INFO - Running setup.py (path:/tmp/pip-jAQnfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:53 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)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:53 INFO - Running setup.py (path:/tmp/pip-JA2vTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:54 INFO - Running setup.py (path:/tmp/pip-FnNvc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:54 INFO - Running setup.py (path:/tmp/pip-oDApsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:54 INFO - Running setup.py (path:/tmp/pip-rDsSZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:54 INFO - Running setup.py (path:/tmp/pip-qqAmPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:54 INFO - Running setup.py (path:/tmp/pip-OXcoeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:54 INFO - Running setup.py (path:/tmp/pip-MYvgFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:54 INFO - Running setup.py (path:/tmp/pip-Qcf9LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:54 INFO - Running setup.py (path:/tmp/pip-OJJUE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:54 INFO - Running setup.py (path:/tmp/pip-phHlO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:54 INFO - Running setup.py (path:/tmp/pip-QC0liA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:54 INFO - Running setup.py (path:/tmp/pip-fXq5QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:54 INFO - Running setup.py (path:/tmp/pip-ARLUkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:54 INFO - Running setup.py (path:/tmp/pip-4yKcyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:54 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)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:55 INFO - Running setup.py (path:/tmp/pip-nOWMPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:55 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)) 04:09:55 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)) 04:09:55 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)) 04:09:55 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)) 04:09:55 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)) 04:09:55 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)) 04:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:56 INFO - Downloading blessings-1.6.tar.gz 04:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:57 INFO - Installing collected packages: blessings 04:09:57 INFO - Running setup.py install for blessings 04:09:57 INFO - Successfully installed blessings 04:09:57 INFO - Cleaning up... 04:09:57 INFO - Return code: 0 04:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:57 INFO - Reading from file tmpfile_stdout 04:09:57 INFO - Current package versions: 04:09:57 INFO - argparse == 1.2.1 04:09:57 INFO - blessings == 1.6 04:09:57 INFO - blobuploader == 1.2.4 04:09:57 INFO - docopt == 0.6.1 04:09:57 INFO - functools32 == 3.2.3-2 04:09:57 INFO - jsonschema == 2.5.1 04:09:57 INFO - manifestparser == 1.1 04:09:57 INFO - mozInstall == 1.12 04:09:57 INFO - mozcrash == 0.17 04:09:57 INFO - mozdebug == 0.1 04:09:57 INFO - mozdevice == 0.48 04:09:57 INFO - mozfile == 1.2 04:09:57 INFO - mozhttpd == 0.7 04:09:57 INFO - mozinfo == 0.9 04:09:57 INFO - mozleak == 0.1 04:09:57 INFO - mozlog == 3.2 04:09:57 INFO - moznetwork == 0.27 04:09:57 INFO - mozprocess == 0.23 04:09:57 INFO - mozprofile == 0.28 04:09:57 INFO - mozrunner == 6.12 04:09:57 INFO - mozscreenshot == 0.1 04:09:57 INFO - mozsystemmonitor == 0.3 04:09:57 INFO - moztest == 0.7 04:09:57 INFO - mozversion == 1.4 04:09:57 INFO - psutil == 3.1.1 04:09:57 INFO - requests == 1.2.3 04:09:57 INFO - wsgiref == 0.1.2 04:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:57 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 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:57 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 04:09:57 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 04:09:57 INFO - Using env: {'DISPLAY': ':0', 04:09:57 INFO - 'HOME': '/home/cltbld', 04:09:57 INFO - 'LANG': 'en_US.UTF-8', 04:09:57 INFO - 'LANGUAGE': 'en_US:en', 04:09:57 INFO - 'LOGNAME': 'cltbld', 04:09:57 INFO - 'MAIL': '/var/mail/cltbld', 04:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:57 INFO - 'MOZ_NO_REMOTE': '1', 04:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:57 INFO - 'NO_EM_RESTART': '1', 04:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:57 INFO - 'PWD': '/builds/slave/test', 04:09:57 INFO - 'SHELL': '/bin/bash', 04:09:57 INFO - 'SHLVL': '1', 04:09:57 INFO - 'TERM': 'linux', 04:09:57 INFO - 'TMOUT': '86400', 04:09:57 INFO - 'USER': 'cltbld', 04:09:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:57 INFO - '_': '/tools/buildbot/bin/python'} 04:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 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)) 04:09:57 INFO - Cleaning up... 04:09:57 INFO - Return code: 0 04:09:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b59400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, '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-1468926343.258948-2127461917', '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 04:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:57 INFO - Using env: {'DISPLAY': ':0', 04:09:57 INFO - 'HOME': '/home/cltbld', 04:09:57 INFO - 'LANG': 'en_US.UTF-8', 04:09:57 INFO - 'LANGUAGE': 'en_US:en', 04:09:57 INFO - 'LOGNAME': 'cltbld', 04:09:57 INFO - 'MAIL': '/var/mail/cltbld', 04:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:57 INFO - 'MOZ_NO_REMOTE': '1', 04:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:57 INFO - 'NO_EM_RESTART': '1', 04:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:57 INFO - 'PWD': '/builds/slave/test', 04:09:57 INFO - 'SHELL': '/bin/bash', 04:09:57 INFO - 'SHLVL': '1', 04:09:57 INFO - 'TERM': 'linux', 04:09:57 INFO - 'TMOUT': '86400', 04:09:57 INFO - 'USER': 'cltbld', 04:09:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:57 INFO - '_': '/tools/buildbot/bin/python'} 04:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:57 INFO - Cleaning up... 04:09:57 INFO - Return code: 0 04:09:57 INFO - Running post-action listener: _resource_record_post_action 04:09:57 INFO - Running post-action listener: _start_resource_monitoring 04:09:57 INFO - Starting resource monitoring. 04:09:57 INFO - ##### 04:09:57 INFO - ##### Finished create-virtualenv step (success) 04:09:57 INFO - ##### 04:09:57 INFO - ##### 04:09:57 INFO - ##### Running install step. 04:09:57 INFO - ##### 04:09:57 INFO - Running pre-action listener: _resource_record_pre_action 04:09:57 INFO - Running main action method: install 04:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:58 INFO - Reading from file tmpfile_stdout 04:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:58 INFO - Reading from file tmpfile_stdout 04:09:58 INFO - Output received: 04:09:58 INFO - Usage: mozinstall [options] installer 04:09:58 INFO - Options: 04:09:58 INFO - -h, --help show this help message and exit 04:09:58 INFO - -d DEST, --destination=DEST 04:09:58 INFO - Directory to install application into. [default: 04:09:58 INFO - "/builds/slave/test"] 04:09:58 INFO - --app=APP Application being installed. [default: firefox] 04:09:58 INFO - mkdir: /builds/slave/test/build/application 04:09:58 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'] 04:09:58 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 04:10:15 INFO - Reading from file tmpfile_stdout 04:10:15 INFO - Output received: 04:10:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:15 INFO - Running post-action listener: _resource_record_post_action 04:10:15 INFO - ##### 04:10:15 INFO - ##### Finished install step (success) 04:10:15 INFO - ##### 04:10:15 INFO - ##### 04:10:15 INFO - ##### Running run-tests step. 04:10:15 INFO - ##### 04:10:15 INFO - Running pre-action listener: _resource_record_pre_action 04:10:15 INFO - Running main action method: run_tests 04:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:15 INFO - Python 2.7.3 04:10:15 INFO - Return code: 0 04:10:15 INFO - grabbing minidump binary from tooltool 04:10:15 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')]} 04:10:15 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 0x1be8570>, '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 0x1be9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:15 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 04:10:15 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 04:10:15 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 04:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:15 INFO - Return code: 0 04:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:10:15 INFO - Using env: {'DISPLAY': ':0', 04:10:15 INFO - 'HOME': '/home/cltbld', 04:10:15 INFO - 'LANG': 'en_US.UTF-8', 04:10:15 INFO - 'LANGUAGE': 'en_US:en', 04:10:15 INFO - 'LOGNAME': 'cltbld', 04:10:15 INFO - 'MAIL': '/var/mail/cltbld', 04:10:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:15 INFO - 'MOZ_NO_REMOTE': '1', 04:10:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:15 INFO - 'NO_EM_RESTART': '1', 04:10:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:15 INFO - 'PWD': '/builds/slave/test', 04:10:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:15 INFO - 'SHELL': '/bin/bash', 04:10:15 INFO - 'SHLVL': '1', 04:10:15 INFO - 'TERM': 'linux', 04:10:15 INFO - 'TMOUT': '86400', 04:10:15 INFO - 'USER': 'cltbld', 04:10:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468926343.258948-2127461917', 04:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:15 INFO - '_': '/tools/buildbot/bin/python'} 04:10:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:10:15 INFO - mozversion application_buildid: 20160719012047 04:10:15 INFO - mozversion application_changeset: 7b4b7cb665c31a078be296a945b8c949fe5493bd 04:10:15 INFO - mozversion application_display_name: Nightly 04:10:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:15 INFO - mozversion application_name: Firefox 04:10:15 INFO - mozversion application_remotingname: firefox 04:10:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:15 INFO - mozversion application_vendor: Mozilla 04:10:15 INFO - mozversion application_version: 50.0a1 04:10:15 INFO - mozversion platform_buildid: 20160719012047 04:10:15 INFO - mozversion platform_changeset: 7b4b7cb665c31a078be296a945b8c949fe5493bd 04:10:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:15 INFO - mozversion platform_version: 50.0a1 04:10:15 INFO - using testdate: 1468926615 04:10:15 INFO - actual date: 1468926615 04:10:15 INFO - starting webserver on 'localhost:52252' 04:10:15 INFO - SUITE-START | Running 2 tests 04:10:15 INFO - TEST-START | dromaeo_css 04:10:15 INFO - operating with platform_type : linux_ 04:10:15 INFO - Initialising browser for dromaeo_css test... 04:10:15 INFO - TEST-INFO | started process 14119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPrcehQ/profile http://localhost:52252/getInfo.html) 04:10:20 INFO - PROCESS | 14119 | __metrics Screen width/height:1600/1200 04:10:20 INFO - PROCESS | 14119 | colorDepth:24 04:10:20 INFO - PROCESS | 14119 | Browser inner width/height: 1024/697 04:10:20 INFO - PROCESS | 14119 | __metrics 04:10:21 ERROR - PROCESS | 14119 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:10:21 INFO - TEST-INFO | 14119: exit 0 04:10:21 INFO - Browser initialized. 04:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:21 INFO - TEST-INFO | started process 14240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPrcehQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:33 INFO - PROCESS | 14240 | RSS: Main: 167428096 04:10:33 INFO - PROCESS | 14240 | 04:11:23 INFO - PROCESS | 14240 | 1468926683250 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] 04:13:31 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52252/tests/dromaeo/cssquery-ext.html) 04:13:32 INFO - PROCESS | 14240 | RSS: Main: 173146112 04:13:32 INFO - PROCESS | 14240 | 04:16:34 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-ext.html (next: http://localhost:52252/tests/dromaeo/cssquery-jquery.html) 04:16:34 INFO - PROCESS | 14240 | RSS: Main: 168022016 04:16:34 INFO - PROCESS | 14240 | 04:19:36 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52252/tests/dromaeo/cssquery-mootools.html) 04:19:37 INFO - PROCESS | 14240 | RSS: Main: 172564480 04:19:37 INFO - PROCESS | 14240 | 04:22:39 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52252/tests/dromaeo/cssquery-prototype.html) 04:22:39 INFO - PROCESS | 14240 | RSS: Main: 167084032 04:22:39 INFO - PROCESS | 14240 | 04:25:42 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52252/tests/dromaeo/cssquery-yui.html) 04:25:42 INFO - PROCESS | 14240 | RSS: Main: 169115648 04:25:42 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-yui.html (next: http://localhost:52252/tests/dromaeo/cssquery-dojo.html) 04:28:45 INFO - PROCESS | 14240 | RSS: Main: 169574400 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | __start_tp_report 04:28:45 INFO - PROCESS | 14240 | _x_x_mozilla_page_load 04:28:45 INFO - PROCESS | 14240 | _x_x_mozilla_page_load_details 04:28:45 INFO - PROCESS | 14240 | |i|pagename|runs| 04:28:45 INFO - PROCESS | 14240 | |0;dojo.html;3007.293286077772;3061.4948533491975;3065.4635438798205;3095.6594774574805;3095.829729364884;5396.163594642837;5411.945880541193;5427.3215848019;5427.72861356932;5430.72846357682;5315.0432922074015;5370.3287089113865;5389;5427.0773968425365;5538.224648549196;4759.524047595239;4794.832180873653;4896.167651499236;4923.9753801230945;4981.1532039553185;777.0281325709745;4703.788329525162;4751.144793937107;4844.927326090112;4886.1204983103025;4853.854384368475;4906.264060390934;4928.457869634337;4939;4947.109520286347;4948.554630083309;4952.603791696655;4957.033378491195;4957.82647607332;4968.577670897978;4778.163821331288;4806.735629540374;4817.8313759018265;4847.733374664392;4854.2961270615915;5343.864093584696;5387.622866399353;5395.622306438551;5430.484104010113;5434.592405569559;5603.971980140114;5717.48542631161;5839.503642190419;5861.6483011019045;5875.441833025856;5737;5791.942080579182;5796.391378905197;5818;5837.066069428914;5462.044142275086;5497.312835895513;5502.972485137549;5503;5505.834824955257;5827;5908.438698323653;5934.525237980951;6006.519478441802;6017.819465416044;5654.9151762723595;5666.97166514173;5686.061799803069;5688;5689.573282003867;5817.127430885316;5819.15622234782;5821.446962538552;5825.446582574648;5847.035239185487;5785.566082543742;5786.334571524244;5833.008388573952;5874.559408044413;5898.8230353089475;5831.387704290988;5835.416458354215;5841;5911.320198177179;5918.082697181943;4377.890552736207;4463.687541872037;4482.484514280834;4496.482904465963;4541.364209010741;3872.1094148346037;3914.2758589661003;3959.2279505496726;3966.087799806061;3983.183447393277;5501.752421141058;5589.608727389125;5610.102383618601;5610.523105535994;5628.690422026746;5897.292324921037;5909.172715819789;5913.822585322448;5920.111983202554;5931.406859314034;5417.51242388187;5565.972170139124;5622.662640241599;5627;5636.436356364331;5023.372078490189;5044.621653376012;5054.646174767805;5073.416557095981;5116.897662046813;5990.520758339322;6029.095635654687;6037.879242415127;6039.275286965504;6056.121862330026;5771.884562308646;5773.278340207474;5822.505087067647;5839.299284085937;5875.970620146872;5982.730777115127;6029.969850150721;6046.697665116814;6065.848353791191;6104.4505994460715;5764.452377024176;5768.365479797303;5772.913406298993;5774.711264436845;5779.797707080232;5653.858653533694;5887.322957859729;5888.823335299948;5892.616979896293;5920.467157955804;5839.474447299764;5844.15259787337;5847.970760146172;5857.912131318119;5890.175375447355;5788.044972579477;5813.709314534341;5839.182514448065;5846.707664616837;5848.766049357978;5446.183072539151;5530.5022547970875;5584.944150558443;5585.748641311069;5750.223719797774;5649.180868773922;5718.399568045295;5728;5765.048766953406;5767.884642307215;5551.139573366135;5569.972150139223;5619.157126431068;5619.466150715675;5639.520640745583 04:28:45 INFO - PROCESS | 14240 | |1;ext.html;558.5495381413749;592.5141384065066;595.6932179927338;606.5632744424015;640.0846789091597;40519;43973.12053758923;44276;44386.112277754466;44524.332135018;44688;45265;45364;45406.318905216445;45459;8737.95631021844;8930.955345223298;8931.866022009675;8940.105989401072;8946.105389461067;8903.24322432594;8964.686235981742;8978.820423591524;8988.325875559327;9013.729588112334;9019.909800902005;9036.231920286751;9070.274378049773;9085.863712044325;9108.817823643523;8931.77670558238;8975.147361000727;8997.235235005033;9008.59461324242;9027.864582031274;8821.603027863697;8849.778755531099;8852.247558957431;8874.156955089256;8901.910980890172;41730;42498.36252456216;42528;42586.57413425888;42679;3363.428217203081;3396.813175275359;3442.3631628148623;3544.5392099026963;3635.381985062546;31408.37183256322;33191.6680833191;33651.831740841386;33778.49332260018;33909.49135762965;4401.295792673157;4522.570355816192;4661.09108723799;4741.786619602126;4759.571638552547;390427;390607;392988;393818;394127;61801;63009;63132;63260.367396326365;63449.68275158687;36113.81943090268;36666.26667466636;36674.26651466956;38849.22301553953;65821.34178658153;17776.466705998842;17889.28442862271;17935.551611209823;17936.19287132082;17963.910180449013;13163.73672526544;13196.670083247996;13223.735525289632;13238.801417978739;13258.668533286553;19826.60346793056;20172.39482815518;20229.291974780812;20238.595228095357;20303.4924126898;7386.2613738625705;7545.434092443089;7601.46789724725;7625.542467451971;7637.2362763724295;961.8412961861214;1041.250299784154;1061.9787604248027;1142.3831131189231;1175.5239128153112;33944.66055339464;34228.48657270143;34390;34476.655233447345;34937;1123.836186927432;1201.471352604851;1202.4528839378063;1219.3171823778534;1220.536196245421;17182;17374.218160182823;17478;17564.946103233848;18001.819981800276;600149;602606;605090;606743;607330;59820.401795982354;61694.69152654208;61721.38278617156;61722.69138654368;61807.381926181064;1324.741675373293;1338.7924871644911;1360.054761940442;1380.0822453068597;1388.5417812121975;31160;33143.66856331406;33368.33263334768;33569.66430335665;33834.154146146546;53073;53294.200586992;53342.73328633332;53717.731411344255;53747.46252537581;481037;482062;482682;482783.68865245;483369;28848.42303153967;29091;29141.85429072841;29223.269418264714;45661.31508027316;47685.5231447695;48165.27752083651;51561;52009.7399513;53210.201846971555;44129.33805992977;44500;44506;44633.10733785241;44903.550964489936;43459.26254024938;44178.77910610555;44197;44398.55601443944;44979.550204498846;45088.54911450844;45385.319220211066;45800.54199458096;46594.06811863812;46724.532754672015;40553.18893622052;42528.787356063025;43902;45933.540664592925;46154.53845461637;35732.4640130393;36449;36652.26695466129;36895;36901.815490922374 04:28:45 INFO - PROCESS | 14240 | |2;jquery.html;379.72834818168536;388.9436031775393;389.75834982310965;390.89445849620586;408.92230476209517;14308.427662893499;18805.059747012645;19940.202391904342;20510.89744551277;20562.38312850615;18952.147153378097;19500.51248718783;19658.705119423183;19797.40607781769;19827.405177844652;5725.112607545827;5849.561282903778;5870.88258234835;5919.1713160157615;5943.435373639497;5170.689758614495;5493.340799104093;5710.172025056364;5826.679532625704;5855.4144585541535;5427.294451721271;5461.2354270402175;5466.234727138204;5500.559955203594;5504.752286147133;5340.679559226459;5386.245925570423;5391.137418013099;5411.729413529328;5589.301337332833;4708.811647534095;4934.80260789568;5519.034169020446;5539.806106786284;5545.057340252127;12553.184043037265;12898.22610643355;12951.546695865694;13002.479900803957;13109.344532773322;2256.7743225677464;2420.636904464327;2835.560488124344;2876.669183043956;2891.7108289171124;9475.857862132074;9503.477308748015;9657.130858222723;9757.756056098584;9843.950780246052;1806.6206096719704;1865.7947625761155;1885.161103309028;1903.4765439504108;1939.0014142716511;83920;87321.56339218326;87836;88793.55603221942;89082.55458722729;10388.48057597117;10489.527971241312;10725.946370268099;11101.44492775358;11105.666829995112;14956.700865982837;14999;15023;15039.721623661893;15116.773248401283;8108.270255677017;8278.544680042534;8402.915970840335;8448.619812108469;8556;8191.467554608931;8221.218984196492;8326.417150799507;8406.747797566082;8442.535660538606;4476.485204201494;4551.52209018055;4635.235186194308;4638.304254361805;4652.371929789435;1880.6083498211226;1966.2626515056854;1974.733410989498;1984.8761824847275;2009.1461129020108;939.8543225799875;955.8279509688323;964.1226483899618;1036.3522798251092;1052.7894421115654;19017.904910475634;19885.304014359717;19935.900320498306;20003.299884504264;20089.698654520194;963.1043129889131;981.1218959031627;994.8507723841482;1034.7930413917247;1057.8416633785992;10331.173506119492;10971.067459266053;11001.6149434771;11004.339739615489;11065.50205240766;498365;499663;505426;512630;517380;84386;96501;102009;103350.48324758328;103503;1022.4172221833633;1026.9691909242736;1066.6106870992032;1070.288258308232;1076.4187338836941;17076.146192690565;17701.203445845225;17739;18134.81865181384;18800.435986920413;35227.29545409129;42948.78525607352;43172.352414713176;43308;43998.560014399445;55929.161062583276;56725.71637141788;57563.4243657558;58826;59047.70476147764;8128.796780080545;8250.958745206235;8272.462289951134;8289.212524810133;8545.060043395097;9241.907580924104;12891.033172511912;13070.54253101175;13706.65733356674;14121.2233327168;11571.074314054687;11587.710307242049;11645.76708465809;11825.408729563316;11889.405529723652;11806.409679516162;11824.940875295568;11858.11064170208;11961.222520536137;12230.694232644255;11413.429328533706;11781.882181178078;12247.816282755588;12314.876851231373;12506.93746531298;8296.668133274843;8373;8399.70601028961;8426.578671066545;8511.489310641382;8102.675892964216;11099.889001109885;11507.769844603228;11546;11696.298222106701 04:28:45 INFO - PROCESS | 14240 | |3;mootools.html;1299.7205600795828;1406.3530775843112;1449.8985071045024;1803.8827476214037;1829.7072468405058;7665.310122089011;8186.5497397643185;8582.184692454206;8729.127087291276;8752.081031491689;8663.523506207157;8889.111088891108;8897;8898.466092034483;8954.059823718513;2290.7022087128694;2327.9185228517003;2328;2329.6621989811465;2331.090874558915;2103.1061798735554;2105.768365479804;2192.3970908000347;2197.055266235518;2203.636399993999;2166.6100101981638;2167.1764729402885;2177.477405422695;2186.125549780085;2210.8452408331423;2216.8891555422165;2244.438890277431;2248.190651365507;2248.876311802842;2253.357793028979;2115;2127.914883404662;2145.731783527059;2147.806697397242;2151.601953638582;8780.648774049094;8922.553872306424;8974.641014359418;9005.774855628597;9021.503817290046;5038.647294689373;5186.5850731941355;5197.58419326453;5202.947970520284;5205.869853253699;3188.3463889902514;3225.4677978133814;3294.8682052717863;3336.699697027255;3349.531065650811;1103.9558417663284;1107.1032463704344;1122.5004872831594;1122.5678113926115;1125.3922881643903;12304.507819687202;12309.076819238593;12366.134370594062;12371.443285052193;12402.06984476168;4404.977975110104;4409.404730361424;4537.705049171794;4566.45202575693;4608.746518941423;10456.058954694114;10468.947655261674;10508.894911050944;10509.211809114347;10510.421926794099;5209.47905209476;5224.764885580158;5230.633855630145;5234.685918844882;5236.031334203185;4273.97863010683;4688.601468875116;4821.63837712173;4828.782704778293;4853.733044682576;3758.530183727034;3857.1707082977296;3884.126071633916;3895.6883449323986;3918.804059796999;1181.438816562126;1183.46743965216;1202.2987472725995;1222.2422098299112;1255.0587059705222;1018.2973748113926;1043.4834756795435;1043.546057465005;1051.7580956380075;1061.5806756331206;6161.075838624152;6182.598131121463;6297.244330680348;6341.143945567382;6352.460040896575;438.861758546057;446.3639313977569;451.62740738890545;1042.9634962776267;1095.1895597257972;4358.389825424443;4423.933640995388;4424.380586717862;4518.164139634178;4536.296873984537;10812.945935270272;11143.944280278547;11254.43727813606;11255.831162532568;11324.660260192208;10331.32846364984;10826.458677066115;10859.83710244347;11101.611443599435;11177.83233251502;8209.876851847228;8247.628856701584;8338.8332233355;8383.748487545383;8411.663533458715;6263.592866463665;6482.546221764431;6488.383603557654;6523.64119973387;6543.836404089745;10218.693439196835;10281.640142594973;10298.330608510423;10336.844947325646;10339.741506462398;10486.16110711126;10512.78974420492;10604.8939510607;10612.787744245226;10634.149268058381;6971.930280697331;7720.227977202235;8005.919940800517;8014.799630009064;8168.83662326762;8733.868991964999;8753.47479151253;8785.692500762443;8796.60415281301;8827.337949653931;7313.817154571178;7446;7868.881966770388;7882.5270483771155;8004.079530854026;7504.549727016397;7557.697692092254;7562.546247225184;7725.034370703662;7772.261635144652;7045.2954704531185;7049;7053.894191587233;7055.611941343275;7101.2898710128575;5251.238570407346;5291.894162116813;5365.9463405367005;5384.626920135341;5449;5286.550643195372;5373.650712703662;5406.351237851483;5483.588730845282;5617.32592088952 04:28:45 INFO - PROCESS | 14240 | |4;prototype.html;312.3409605731905;315.3582459694521;319.2354311424139;320.1053056706505;323.9595050618673;5581.386047534768;5588.7145956429995;5596.972015139929;5625.324961004685;5631.971840140799;5406.16204488304;5459.836204913859;5461.918071228924;5493.093639549469;5552.194931734896;4032.507972050338;4077.858199704073;4219.746815191083;4229.154169166164;4248.150369926012;4191.392248124021;4202.222588821062;4233.51314598822;4235.851745188919;4252.957470425287;4212.094399704063;4235.6187943085115;4241.766702831343;4249.851255206068;4259.850905218318;3973;4178.435911151986;4182.247195504808;4198.958010419888;4245.8089385977555;3585.1933315004176;3627.9455808162897;3632.2553876455263;3642.6721595056574;3650.2881938022097;5382.784688612451;5460.590455715797;5465.180222966547;5509.173623956439;5517.213807027466;4662.160811054009;4877.707337559757;4896.436909755353;4941.283513890502;4945.8268960586565;5838.569550460122;5855.238818953551;5867.266591676041;5894.17481552583;5901.586888917777;4071.676705070864;4079.1433798902267;4082.5509193988933;4083;4100.17996400718;5876.44173803488;6002.669853158074;6089.238845144357;6096.237970253718;6118.1434599156155;4128.8852009957745;4155.8753237402325;4163.791810409467;4168.458100446923;4175.123224122968;4165.333546632524;4183.665306775511;4208.179405016053;4216.978915105405;4230.64039556635;4743;4891.828785992544;4911.189653707098;4914.336564563738;4940.827071052496;5880.764769409261;5880.941190588125;5885.176075349455;5898.115282707542;5935.703214839241;1444.2489905249422;1450.8259008918785;1456.271864067966;1460.2041887171517;1461.9766163685463;897.3897749530252;915.272358475014;927.2396634759433;939.3659279986118;969.0860550412879;5592;5595.944040559623;5597.496225339739;5605.383407825218;5619.325680918316;5862.179294898718;5886.970565147147;5903.822885313448;5939.13882487037;5943;5324.494173053554;5538.446155384429;5590.217369568264;5627.606067575312;5646.661200327993;3158.652548219694;3189.9362012759616;3190.633077196152;3205.5351973963643;3210.5826242588782;5865.94134058654;6121.418465245794;6139.846503837351;6166.260048794174;6268.373162683695;6208.348123446973;6239.282482514478;6289.182406287154;6296;6297.73281618617;6088.512918966383;6218.502519798405;6232.719527621268;6299.811005669837;6335.746570137143;6046.790641871556;6069.666168360783;6089.756409743561;6090.269167699905;6115.471132216946;5980.700964951648;6008.158857760004;6011.519078473799;6037.124616930609;6064.878702426015;5921.963656360206;6147;6147.815565533041;6191.721372538156;6211.844703882439;4147.2534943709215;4184.8744537663915;4199.580041995776;4202.621764041251;4213.452251207324;6080.2399700037495;6095.420935011167;6142.293636231891;6154;6155.4767844731905;5718.599698021265;5815.2149459822385;5869.559783016205;5892.145638882253;5919.881602368015;5879.2944846618675;5903.819236152701;5913.822585322275;5921.911171332519;5949.52403807703;5219.556337711337;5738.942610574008;5880.176775251382;5884.411558844081;5907.527397808251;5919.6744179070565;5932.8813423732145;5939.613925094855;5947.9702601486715;6002.669853157943;5619.494245517923;5790.768369265183;5893.882122357443;5902.996490596523;5908.734106965283 04:28:45 INFO - PROCESS | 14240 | |5;yui.html;641.2369280556138;655.2988302516303;707.2679776431395;787.3548438149122;819.946703464275;15206.467773627925;16148.111853848019;16266;16304.755428668564;16501.17494125295;15178.772318415233;15236.923815380907;15282.923585382057;15923.84076159238;16357.918210408961;808.0384342632263;818.8812622169781;821.5235163605124;825.0182283083112;826.4256341842392;806.4959400374765;808.0989696488402;831.6340810043562;838.1827717974957;841.6380956188837;637.4358692557074;641.4227195524019;641.4451499452963;641.8908785506475;653.0563335979488;636.7325723196245;641.0352419608482;647.4820143884897;650.4243744286293;651.6741629185407;466.4985140973467;466.6873194959351;471.4036743519451;474.43542184799975;478.3064556393209;15835.60410989723;15948.441804536902;15989.680206395924;15996.280167392379;16022.839771602252;15039.548813535612;15112.319945602474;15188.392464301525;15356.232188390535;15440.150791706452;12454.467298451058;12501;12521.12352135351;12559;12686.873131268754;3806.695464362844;3824.101336185994;3931.9213615727526;4031.9596804031876;4033.737807042562;80558.5702195451;81393.59303203446;81766.18233817646;82284;82859;11727.4136293185;11733.4133293335;11886.108541859396;12016.699582510508;12515.374231288399;21617.459563510725;21629.675554866688;21639.242626508312;21672.674909876365;21689.891550542463;8373.623186956602;8463.23830855226;8569.614367353484;8611.956940215385;8915.063918288615;4631.9536804631525;4682.695624784446;4699.224627936421;4706.88232794176;4708.858734237979;3682.3371793076967;3751.756135851161;3767.962320376816;3782.6973842092566;3796.1648437343742;609.4514936557046;617.6170774119985;622.3372108704216;624.9312575616678;635.4027214418431;650.9804705858737;710.4210068793916;723.6996646391793;732.9816754581071;746.2015643261658;9609.375390599589;9614;9659.613615455444;9961.651342202988;10046.296759226783;589.7906243283659;693.3690341788948;696.571608460793;701.4458577723541;703.6763088979025;4503.684742068024;4582.473015603182;4623.329617205553;4748.074125545486;4774.976125119421;94285;114504.42747786375;115801.42099289618;116730;117975.41012295055;58757.41242587605;59740;87079;88784.5560772192;97641.02358976462;57318.426815731305;85326.57336713401;86788;89147.55426222828;91614;9949.751256218653;10234.948825255826;10386.948065259625;10450.372977621368;10604.416757078434;49650.75174624104;49903.500964989886;50388.24417633665;50862.491375085774;52332.47667523276;72985.27014729785;79046.6047669758;79594.6020269895;80054.19945800467;80060.19939800528;13747.862521374658;13799.655008624864;13950.162990220619;13995.650108747363;14019.439222430989;15230.44305302391;15425.691486170439;15634;16431.26059327309;16482.175891205632;14233.288335582973;14251;14431.278436078364;14672.779908301598;14917.179555124572;14096.718065638835;14571.34428950721;14583.343749531508;15100.54698359051;15616.609584760472;13904.721905562035;13982.860171398155;14483.927580362031;14513.564593062225;14885.330160143036;11686.649400517997;11799.174057816213;12082;12094.697632559257;12225.938870305592;10737.389391591012;11562;11714.824277636013;11828.40857957116;11893.108016898941 04:28:45 INFO - PROCESS | 14240 | __end_tp_report 04:28:45 INFO - PROCESS | 14240 | __start_cc_report 04:28:45 INFO - PROCESS | 14240 | _x_x_mozilla_cycle_collect,372 04:28:45 INFO - PROCESS | 14240 | __end_cc_report 04:28:45 INFO - PROCESS | 14240 | __startTimestamp1468927725926__endTimestamp 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | ------- Summary: start ------- 04:28:45 INFO - PROCESS | 14240 | Number of tests: 6 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#0] dojo.html Cycles:165 Average:5385.28 Median:5636.44 stddev:735.49 (13.0%) stddev-sans-first:713.70 04:28:45 INFO - PROCESS | 14240 | Values: 3007.3 3061.5 3065.5 3095.7 3095.8 5396.2 5411.9 5427.3 5427.7 5430.7 5315.0 5370.3 5389.0 5427.1 5538.2 4759.5 4794.8 4896.2 4924.0 4981.2 777.0 4703.8 4751.1 4844.9 4886.1 4853.9 4906.3 4928.5 4939.0 4947.1 4948.6 4952.6 4957.0 4957.8 4968.6 4778.2 4806.7 4817.8 4847.7 4854.3 5343.9 5387.6 5395.6 5430.5 5434.6 5604.0 5717.5 5839.5 5861.6 5875.4 5737.0 5791.9 5796.4 5818.0 5837.1 5462.0 5497.3 5503.0 5503.0 5505.8 5827.0 5908.4 5934.5 6006.5 6017.8 5654.9 5667.0 5686.1 5688.0 5689.6 5817.1 5819.2 5821.4 5825.4 5847.0 5785.6 5786.3 5833.0 5874.6 5898.8 5831.4 5835.4 5841.0 5911.3 5918.1 4377.9 4463.7 4482.5 4496.5 4541.4 3872.1 3914.3 3959.2 3966.1 3983.2 5501.8 5589.6 5610.1 5610.5 5628.7 5897.3 5909.2 5913.8 5920.1 5931.4 5417.5 5566.0 5622.7 5627.0 5636.4 5023.4 5044.6 5054.6 5073.4 5116.9 5990.5 6029.1 6037.9 6039.3 6056.1 5771.9 5773.3 5822.5 5839.3 5876.0 5982.7 6030.0 6046.7 6065.8 6104.5 5764.5 5768.4 5772.9 5774.7 5779.8 5653.9 5887.3 5888.8 5892.6 5920.5 5839.5 5844.2 5848.0 5857.9 5890.2 5788.0 5813.7 5839.2 5846.7 5848.8 5446.2 5530.5 5584.9 5585.7 5750.2 5649.2 5718.4 5728.0 5765.0 5767.9 5551.1 5570.0 5619.2 5619.5 5639.5 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#1] ext.html Cycles:180 Average:65635.80 Median:44503.00 stddev:132993.06 (298.8%) stddev-sans-first:133276.39 04:28:45 INFO - PROCESS | 14240 | Values: 558.5 592.5 595.7 606.6 640.1 40519.0 43973.1 44276.0 44386.1 44524.3 44688.0 45265.0 45364.0 45406.3 45459.0 8738.0 8931.0 8931.9 8940.1 8946.1 8903.2 8964.7 8978.8 8988.3 9013.7 9019.9 9036.2 9070.3 9085.9 9108.8 8931.8 8975.1 8997.2 9008.6 9027.9 8821.6 8849.8 8852.2 8874.2 8901.9 41730.0 42498.4 42528.0 42586.6 42679.0 3363.4 3396.8 3442.4 3544.5 3635.4 31408.4 33191.7 33651.8 33778.5 33909.5 4401.3 4522.6 4661.1 4741.8 4759.6 390427.0 390607.0 392988.0 393818.0 394127.0 61801.0 63009.0 63132.0 63260.4 63449.7 36113.8 36666.3 36674.3 38849.2 65821.3 17776.5 17889.3 17935.6 17936.2 17963.9 13163.7 13196.7 13223.7 13238.8 13258.7 19826.6 20172.4 20229.3 20238.6 20303.5 7386.3 7545.4 7601.5 7625.5 7637.2 961.8 1041.3 1062.0 1142.4 1175.5 33944.7 34228.5 34390.0 34476.7 34937.0 1123.8 1201.5 1202.5 1219.3 1220.5 17182.0 17374.2 17478.0 17564.9 18001.8 600149.0 602606.0 605090.0 606743.0 607330.0 59820.4 61694.7 61721.4 61722.7 61807.4 1324.7 1338.8 1360.1 1380.1 1388.5 31160.0 33143.7 33368.3 33569.7 33834.2 53073.0 53294.2 53342.7 53717.7 53747.5 481037.0 482062.0 482682.0 482783.7 483369.0 28848.4 29091.0 29141.9 29223.3 45661.3 47685.5 48165.3 51561.0 52009.7 53210.2 44129.3 44500.0 44506.0 44633.1 44903.6 43459.3 44178.8 44197.0 44398.6 44979.6 45088.5 45385.3 45800.5 46594.1 46724.5 40553.2 42528.8 43902.0 45933.5 46154.5 35732.5 36449.0 36652.3 36895.0 36901.8 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#2] jquery.html Cycles:180 Average:29479.47 Median:17803.51 stddev:83768.81 (470.5%) stddev-sans-first:83975.30 04:28:45 INFO - PROCESS | 14240 | Values: 379.7 388.9 389.8 390.9 408.9 14308.4 18805.1 19940.2 20510.9 20562.4 18952.1 19500.5 19658.7 19797.4 19827.4 5725.1 5849.6 5870.9 5919.2 5943.4 5170.7 5493.3 5710.2 5826.7 5855.4 5427.3 5461.2 5466.2 5500.6 5504.8 5340.7 5386.2 5391.1 5411.7 5589.3 4708.8 4934.8 5519.0 5539.8 5545.1 12553.2 12898.2 12951.5 13002.5 13109.3 2256.8 2420.6 2835.6 2876.7 2891.7 9475.9 9503.5 9657.1 9757.8 9844.0 1806.6 1865.8 1885.2 1903.5 1939.0 83920.0 87321.6 87836.0 88793.6 89082.6 10388.5 10489.5 10725.9 11101.4 11105.7 14956.7 14999.0 15023.0 15039.7 15116.8 8108.3 8278.5 8402.9 8448.6 8556.0 8191.5 8221.2 8326.4 8406.7 8442.5 4476.5 4551.5 4635.2 4638.3 4652.4 1880.6 1966.3 1974.7 1984.9 2009.1 939.9 955.8 964.1 1036.4 1052.8 19017.9 19885.3 19935.9 20003.3 20089.7 963.1 981.1 994.9 1034.8 1057.8 10331.2 10971.1 11001.6 11004.3 11065.5 498365.0 499663.0 505426.0 512630.0 517380.0 84386.0 96501.0 102009.0 103350.5 103503.0 1022.4 1027.0 1066.6 1070.3 1076.4 17076.1 17701.2 17739.0 18134.8 18800.4 35227.3 42948.8 43172.4 43308.0 43998.6 55929.2 56725.7 57563.4 58826.0 59047.7 8128.8 8251.0 8272.5 8289.2 8545.1 9241.9 12891.0 13070.5 13706.7 14121.2 11571.1 11587.7 11645.8 11825.4 11889.4 11806.4 11824.9 11858.1 11961.2 12230.7 11413.4 11781.9 12247.8 12314.9 12506.9 8296.7 8373.0 8399.7 8426.6 8511.5 8102.7 11099.9 11507.8 11546.0 11696.3 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#3] mootools.html Cycles:180 Average:5848.12 Median:4407.19 stddev:3372.83 (76.5%) stddev-sans-first:3364.96 04:28:45 INFO - PROCESS | 14240 | Values: 1299.7 1406.4 1449.9 1803.9 1829.7 7665.3 8186.5 8582.2 8729.1 8752.1 8663.5 8889.1 8897.0 8898.5 8954.1 2290.7 2327.9 2328.0 2329.7 2331.1 2103.1 2105.8 2192.4 2197.1 2203.6 2166.6 2167.2 2177.5 2186.1 2210.8 2216.9 2244.4 2248.2 2248.9 2253.4 2115.0 2127.9 2145.7 2147.8 2151.6 8780.6 8922.6 8974.6 9005.8 9021.5 5038.6 5186.6 5197.6 5202.9 5205.9 3188.3 3225.5 3294.9 3336.7 3349.5 1104.0 1107.1 1122.5 1122.6 1125.4 12304.5 12309.1 12366.1 12371.4 12402.1 4405.0 4409.4 4537.7 4566.5 4608.7 10456.1 10468.9 10508.9 10509.2 10510.4 5209.5 5224.8 5230.6 5234.7 5236.0 4274.0 4688.6 4821.6 4828.8 4853.7 3758.5 3857.2 3884.1 3895.7 3918.8 1181.4 1183.5 1202.3 1222.2 1255.1 1018.3 1043.5 1043.5 1051.8 1061.6 6161.1 6182.6 6297.2 6341.1 6352.5 438.9 446.4 451.6 1043.0 1095.2 4358.4 4423.9 4424.4 4518.2 4536.3 10812.9 11143.9 11254.4 11255.8 11324.7 10331.3 10826.5 10859.8 11101.6 11177.8 8209.9 8247.6 8338.8 8383.7 8411.7 6263.6 6482.5 6488.4 6523.6 6543.8 10218.7 10281.6 10298.3 10336.8 10339.7 10486.2 10512.8 10604.9 10612.8 10634.1 6971.9 7720.2 8005.9 8014.8 8168.8 8733.9 8753.5 8785.7 8796.6 8827.3 7313.8 7446.0 7868.9 7882.5 8004.1 7504.5 7557.7 7562.5 7725.0 7772.3 7045.3 7049.0 7053.9 7055.6 7101.3 5251.2 5291.9 5365.9 5384.6 5449.0 5286.6 5373.7 5406.4 5483.6 5617.3 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#4] prototype.html Cycles:180 Average:4897.34 Median:5612.35 stddev:1487.23 (26.5%) stddev-sans-first:1451.04 04:28:45 INFO - PROCESS | 14240 | Values: 312.3 315.4 319.2 320.1 324.0 5581.4 5588.7 5597.0 5625.3 5632.0 5406.2 5459.8 5461.9 5493.1 5552.2 4032.5 4077.9 4219.7 4229.2 4248.2 4191.4 4202.2 4233.5 4235.9 4253.0 4212.1 4235.6 4241.8 4249.9 4259.9 3973.0 4178.4 4182.2 4199.0 4245.8 3585.2 3627.9 3632.3 3642.7 3650.3 5382.8 5460.6 5465.2 5509.2 5517.2 4662.2 4877.7 4896.4 4941.3 4945.8 5838.6 5855.2 5867.3 5894.2 5901.6 4071.7 4079.1 4082.6 4083.0 4100.2 5876.4 6002.7 6089.2 6096.2 6118.1 4128.9 4155.9 4163.8 4168.5 4175.1 4165.3 4183.7 4208.2 4217.0 4230.6 4743.0 4891.8 4911.2 4914.3 4940.8 5880.8 5880.9 5885.2 5898.1 5935.7 1444.2 1450.8 1456.3 1460.2 1462.0 897.4 915.3 927.2 939.4 969.1 5592.0 5595.9 5597.5 5605.4 5619.3 5862.2 5887.0 5903.8 5939.1 5943.0 5324.5 5538.4 5590.2 5627.6 5646.7 3158.7 3189.9 3190.6 3205.5 3210.6 5865.9 6121.4 6139.8 6166.3 6268.4 6208.3 6239.3 6289.2 6296.0 6297.7 6088.5 6218.5 6232.7 6299.8 6335.7 6046.8 6069.7 6089.8 6090.3 6115.5 5980.7 6008.2 6011.5 6037.1 6064.9 5922.0 6147.0 6147.8 6191.7 6211.8 4147.3 4184.9 4199.6 4202.6 4213.5 6080.2 6095.4 6142.3 6154.0 6155.5 5718.6 5815.2 5869.6 5892.1 5919.9 5879.3 5903.8 5913.8 5921.9 5949.5 5219.6 5738.9 5880.2 5884.4 5907.5 5919.7 5932.9 5939.6 5948.0 6002.7 5619.5 5790.8 5893.9 5903.0 5908.7 04:28:45 INFO - PROCESS | 14240 | 04:28:45 INFO - PROCESS | 14240 | [#5] yui.html Cycles:180 Average:20579.01 Median:4602.90 stddev:28707.38 (623.7%) stddev-sans-first:28748.87 04:28:45 INFO - PROCESS | 14240 | Values: 641.2 655.3 707.3 787.4 819.9 15206.5 16148.1 16266.0 16304.8 16501.2 15178.8 15236.9 15282.9 15923.8 16357.9 808.0 818.9 821.5 825.0 826.4 806.5 808.1 831.6 838.2 841.6 637.4 641.4 641.4 641.9 653.1 636.7 641.0 647.5 650.4 651.7 466.5 466.7 471.4 474.4 478.3 15835.6 15948.4 15989.7 15996.3 16022.8 15039.5 15112.3 15188.4 15356.2 15440.2 12454.5 12501.0 12521.1 12559.0 12686.9 3806.7 3824.1 3931.9 4032.0 4033.7 80558.6 81393.6 81766.2 82284.0 82859.0 11727.4 11733.4 11886.1 12016.7 12515.4 21617.5 21629.7 21639.2 21672.7 21689.9 8373.6 8463.2 8569.6 8612.0 8915.1 4632.0 4682.7 4699.2 4706.9 4708.9 3682.3 3751.8 3768.0 3782.7 3796.2 609.5 617.6 622.3 624.9 635.4 651.0 710.4 723.7 733.0 746.2 9609.4 9614.0 9659.6 9961.7 10046.3 589.8 693.4 696.6 701.4 703.7 4503.7 4582.5 4623.3 4748.1 4775.0 94285.0 114504.4 115801.4 116730.0 117975.4 58757.4 59740.0 87079.0 88784.6 97641.0 57318.4 85326.6 86788.0 89147.6 91614.0 9949.8 10234.9 10386.9 10450.4 10604.4 49650.8 49903.5 50388.2 50862.5 52332.5 72985.3 79046.6 79594.6 80054.2 80060.2 13747.9 13799.7 13950.2 13995.7 14019.4 15230.4 15425.7 15634.0 16431.3 16482.2 14233.3 14251.0 14431.3 14672.8 14917.2 14096.7 14571.3 14583.3 15100.5 15616.6 13904.7 13982.9 14483.9 14513.6 14885.3 11686.6 11799.2 12082.0 12094.7 12225.9 10737.4 11562.0 11714.8 11828.4 11893.1 04:28:45 INFO - PROCESS | 14240 | -------- Summary: end -------- 04:28:45 INFO - PROCESS | 14240 | 04:28:46 INFO - TEST-INFO | 14240: exit 0 04:28:46 INFO - TEST-OK | dromaeo_css | took 1110942ms 04:28:46 INFO - TEST-START | kraken 04:28:46 INFO - operating with platform_type : linux_ 04:28:46 INFO - Initialising browser for kraken test... 04:28:46 INFO - TEST-INFO | started process 14489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXJ2pQw/profile http://localhost:52252/getInfo.html) 04:28:51 INFO - PROCESS | 14489 | __metrics Screen width/height:1600/1200 04:28:51 INFO - PROCESS | 14489 | colorDepth:24 04:28:51 INFO - PROCESS | 14489 | Browser inner width/height: 1024/697 04:28:51 INFO - PROCESS | 14489 | __metrics 04:28:51 ERROR - PROCESS | 14489 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:28:52 INFO - TEST-INFO | 14489: exit 0 04:28:52 INFO - Browser initialized. 04:28:52 INFO - Running cycle 1/1 for kraken test... 04:28:52 INFO - TEST-INFO | started process 14610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXJ2pQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:04 INFO - PROCESS | 14610 | RSS: Main: 167276544 04:29:04 INFO - PROCESS | 14610 | 04:29:06 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:07 INFO - PROCESS | 14610 | RSS: Main: 172404736 04:29:07 INFO - PROCESS | 14610 | 04:29:10 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-dft) 04:29:10 INFO - PROCESS | 14610 | RSS: Main: 172806144 04:29:10 INFO - PROCESS | 14610 | 04:29:13 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-fft) 04:29:14 INFO - PROCESS | 14610 | RSS: Main: 167510016 04:29:14 INFO - PROCESS | 14610 | 04:29:16 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-oscillator) 04:29:17 INFO - PROCESS | 14610 | RSS: Main: 168148992 04:29:17 INFO - PROCESS | 14610 | 04:29:19 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:19 INFO - PROCESS | 14610 | RSS: Main: 169091072 04:29:19 INFO - PROCESS | 14610 | 04:29:23 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:23 INFO - PROCESS | 14610 | RSS: Main: 168689664 04:29:23 INFO - PROCESS | 14610 | 04:29:27 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:27 INFO - PROCESS | 14610 | RSS: Main: 168960000 04:29:27 INFO - PROCESS | 14610 | 04:29:30 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52252/tests/kraken/driver.html?testName=json-parse-financial) 04:29:31 INFO - PROCESS | 14610 | RSS: Main: 169005056 04:29:31 INFO - PROCESS | 14610 | 04:29:32 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:33 INFO - PROCESS | 14610 | RSS: Main: 168689664 04:29:33 INFO - PROCESS | 14610 | 04:29:35 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:35 INFO - PROCESS | 14610 | RSS: Main: 168484864 04:29:35 INFO - PROCESS | 14610 | 04:29:37 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:38 INFO - PROCESS | 14610 | RSS: Main: 169197568 04:29:38 INFO - PROCESS | 14610 | 04:29:41 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:41 INFO - PROCESS | 14610 | RSS: Main: 169787392 04:29:41 INFO - PROCESS | 14610 | 04:29:44 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:45 INFO - PROCESS | 14610 | RSS: Main: 168775680 04:29:45 INFO - PROCESS | 14610 | 04:29:46 INFO - PROCESS | 14610 | Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52252/tests/kraken/driver.html?testName=ai-astar) 04:29:47 INFO - PROCESS | 14610 | RSS: Main: 169717760 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | __start_tp_report 04:29:47 INFO - PROCESS | 14610 | _x_x_mozilla_page_load 04:29:47 INFO - PROCESS | 14610 | _x_x_mozilla_page_load_details 04:29:47 INFO - PROCESS | 14610 | |i|pagename|runs| 04:29:47 INFO - PROCESS | 14610 | |0;ai-astar;102;114;105;114;114;113;114;113;111;113 04:29:47 INFO - PROCESS | 14610 | |1;audio-beat-detection;142;119;146;164;118;150;144;120;188;122 04:29:47 INFO - PROCESS | 14610 | |2;audio-dft;164;163;164;164;165;167;165;172;163;160 04:29:47 INFO - PROCESS | 14610 | |3;audio-fft;76;76;74;130;75;76;75;74;182;76 04:29:47 INFO - PROCESS | 14610 | |4;audio-oscillator;84;83;142;84;84;84;132;84;83;156 04:29:47 INFO - PROCESS | 14610 | |5;imaging-gaussian-blur;118;117;117;118;118;118;117;118;117;119 04:29:47 INFO - PROCESS | 14610 | |6;imaging-darkroom;147;149;147;147;147;147;148;146;147;148 04:29:47 INFO - PROCESS | 14610 | |7;imaging-desaturate;95;96;96;95;95;95;96;96;95;96 04:29:47 INFO - PROCESS | 14610 | |8;json-parse-financial;59;53;54;52;52;55;52;52;51;53 04:29:47 INFO - PROCESS | 14610 | |9;json-stringify-tinderbox;65;64;62;63;63;62;62;64;64;64 04:29:47 INFO - PROCESS | 14610 | |10;stanford-crypto-aes;91;75;76;75;75;76;81;77;82;81 04:29:47 INFO - PROCESS | 14610 | |11;stanford-crypto-ccm;124;126;131;126;122;130;132;129;155;137 04:29:47 INFO - PROCESS | 14610 | |12;stanford-crypto-pbkdf2;157;156;160;158;160;162;160;160;157;157 04:29:47 INFO - PROCESS | 14610 | |13;stanford-crypto-sha256-iterative;67;67;63;63;63;64;64;64;62;63 04:29:47 INFO - PROCESS | 14610 | __end_tp_report 04:29:47 INFO - PROCESS | 14610 | __start_cc_report 04:29:47 INFO - PROCESS | 14610 | _x_x_mozilla_cycle_collect,881 04:29:47 INFO - PROCESS | 14610 | __end_cc_report 04:29:47 INFO - PROCESS | 14610 | __startTimestamp1468927787008__endTimestamp 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | ------- Summary: start ------- 04:29:47 INFO - PROCESS | 14610 | Number of tests: 14 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.50 stddev:4.27 (3.8%) stddev-sans-first:2.92 04:29:47 INFO - PROCESS | 14610 | Values: 102.0 114.0 105.0 114.0 114.0 113.0 114.0 113.0 111.0 113.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:145.00 stddev:22.77 (15.7%) stddev-sans-first:24.15 04:29:47 INFO - PROCESS | 14610 | Values: 142.0 119.0 146.0 164.0 118.0 150.0 144.0 120.0 188.0 122.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.13 (1.9%) stddev-sans-first:3.31 04:29:47 INFO - PROCESS | 14610 | Values: 164.0 163.0 164.0 164.0 165.0 167.0 165.0 172.0 163.0 160.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.50 stddev:36.19 (47.9%) stddev-sans-first:37.96 04:29:47 INFO - PROCESS | 14610 | Values: 76.0 76.0 74.0 130.0 75.0 76.0 75.0 74.0 182.0 76.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:29.36 (34.9%) stddev-sans-first:30.44 04:29:47 INFO - PROCESS | 14610 | Values: 84.0 83.0 142.0 84.0 84.0 84.0 132.0 84.0 83.0 156.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:29:47 INFO - PROCESS | 14610 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 119.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:29:47 INFO - PROCESS | 14610 | Values: 147.0 149.0 147.0 147.0 147.0 147.0 148.0 146.0 147.0 148.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:29:47 INFO - PROCESS | 14610 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:2.31 (4.4%) stddev-sans-first:1.22 04:29:47 INFO - PROCESS | 14610 | Values: 59.0 53.0 54.0 52.0 52.0 55.0 52.0 52.0 51.0 53.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 04:29:47 INFO - PROCESS | 14610 | Values: 65.0 64.0 62.0 63.0 63.0 62.0 62.0 64.0 64.0 64.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:5.07 (6.4%) stddev-sans-first:2.92 04:29:47 INFO - PROCESS | 14610 | Values: 91.0 75.0 76.0 75.0 75.0 76.0 81.0 77.0 82.0 81.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.50 stddev:9.41 (7.2%) stddev-sans-first:9.62 04:29:47 INFO - PROCESS | 14610 | Values: 124.0 126.0 131.0 126.0 122.0 130.0 132.0 129.0 155.0 137.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:160.00 stddev:1.95 (1.2%) stddev-sans-first:1.96 04:29:47 INFO - PROCESS | 14610 | Values: 157.0 156.0 160.0 158.0 160.0 162.0 160.0 160.0 157.0 157.0 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - PROCESS | 14610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.41 04:29:47 INFO - PROCESS | 14610 | Values: 67.0 67.0 63.0 63.0 63.0 64.0 64.0 64.0 62.0 63.0 04:29:47 INFO - PROCESS | 14610 | -------- Summary: end -------- 04:29:47 INFO - PROCESS | 14610 | 04:29:47 INFO - TEST-INFO | 14610: exit 0 04:29:47 INFO - TEST-OK | kraken | took 61320ms 04:29:47 INFO - SUITE-END | took 1172s 04:29:48 INFO - Completed test suite (00:19:32) 04:29:48 INFO - javascript benchmark 04:29:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7340.265016938816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.293286077772, 3061.4948533491975, 3065.4635438798205, 3095.6594774574805, 3095.829729364884, 5396.163594642837, 5411.945880541193, 5427.3215848019, 5427.72861356932, 5430.72846357682, 5315.0432922074015, 5370.3287089113865, 5389.0, 5427.0773968425365, 5538.224648549196, 4759.524047595239, 4794.832180873653, 4896.167651499236, 4923.9753801230945, 4981.1532039553185, 777.0281325709745, 4703.788329525162, 4751.144793937107, 4844.927326090112, 4886.1204983103025, 4853.854384368475, 4906.264060390934, 4928.457869634337, 4939.0, 4947.109520286347, 4948.554630083309, 4952.603791696655, 4957.033378491195, 4957.82647607332, 4968.577670897978, 4778.163821331288, 4806.735629540374, 4817.8313759018265, 4847.733374664392, 4854.2961270615915, 5343.864093584696, 5387.622866399353, 5395.622306438551, 5430.484104010113, 5434.592405569559, 5603.971980140114, 5717.48542631161, 5839.503642190419, 5861.6483011019045, 5875.441833025856, 5737.0, 5791.942080579182, 5796.391378905197, 5818.0, 5837.066069428914, 5462.044142275086, 5497.312835895513, 5502.972485137549, 5503.0, 5505.834824955257, 5827.0, 5908.438698323653, 5934.525237980951, 6006.519478441802, 6017.819465416044, 5654.9151762723595, 5666.97166514173, 5686.061799803069, 5688.0, 5689.573282003867, 5817.127430885316, 5819.15622234782, 5821.446962538552, 5825.446582574648, 5847.035239185487, 5785.566082543742, 5786.334571524244, 5833.008388573952, 5874.559408044413, 5898.8230353089475, 5831.387704290988, 5835.416458354215, 5841.0, 5911.320198177179, 5918.082697181943, 4377.890552736207, 4463.687541872037, 4482.484514280834, 4496.482904465963, 4541.364209010741, 3872.1094148346037, 3914.2758589661003, 3959.2279505496726, 3966.087799806061, 3983.183447393277, 5501.752421141058, 5589.608727389125, 5610.102383618601, 5610.523105535994, 5628.690422026746, 5897.292324921037, 5909.172715819789, 5913.822585322448, 5920.111983202554, 5931.406859314034, 5417.51242388187, 5565.972170139124, 5622.662640241599, 5627.0, 5636.436356364331, 5023.372078490189, 5044.621653376012, 5054.646174767805, 5073.416557095981, 5116.897662046813, 5990.520758339322, 6029.095635654687, 6037.879242415127, 6039.275286965504, 6056.121862330026, 5771.884562308646, 5773.278340207474, 5822.505087067647, 5839.299284085937, 5875.970620146872, 5982.730777115127, 6029.969850150721, 6046.697665116814, 6065.848353791191, 6104.4505994460715, 5764.452377024176, 5768.365479797303, 5772.913406298993, 5774.711264436845, 5779.797707080232, 5653.858653533694, 5887.322957859729, 5888.823335299948, 5892.616979896293, 5920.467157955804, 5839.474447299764, 5844.15259787337, 5847.970760146172, 5857.912131318119, 5890.175375447355, 5788.044972579477, 5813.709314534341, 5839.182514448065, 5846.707664616837, 5848.766049357978, 5446.183072539151, 5530.5022547970875, 5584.944150558443, 5585.748641311069, 5750.223719797774, 5649.180868773922, 5718.399568045295, 5728.0, 5765.048766953406, 5767.884642307215, 5551.139573366135, 5569.972150139223, 5619.157126431068, 5619.466150715675, 5639.520640745583], "value": 5334.198919343174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5495381413749, 592.5141384065066, 595.6932179927338, 606.5632744424015, 640.0846789091597, 40519.0, 43973.12053758923, 44276.0, 44386.112277754466, 44524.332135018, 44688.0, 45265.0, 45364.0, 45406.318905216445, 45459.0, 8737.95631021844, 8930.955345223298, 8931.866022009675, 8940.105989401072, 8946.105389461067, 8903.24322432594, 8964.686235981742, 8978.820423591524, 8988.325875559327, 9013.729588112334, 9019.909800902005, 9036.231920286751, 9070.274378049773, 9085.863712044325, 9108.817823643523, 8931.77670558238, 8975.147361000727, 8997.235235005033, 9008.59461324242, 9027.864582031274, 8821.603027863697, 8849.778755531099, 8852.247558957431, 8874.156955089256, 8901.910980890172, 41730.0, 42498.36252456216, 42528.0, 42586.57413425888, 42679.0, 3363.428217203081, 3396.813175275359, 3442.3631628148623, 3544.5392099026963, 3635.381985062546, 31408.37183256322, 33191.6680833191, 33651.831740841386, 33778.49332260018, 33909.49135762965, 4401.295792673157, 4522.570355816192, 4661.09108723799, 4741.786619602126, 4759.571638552547, 390427.0, 390607.0, 392988.0, 393818.0, 394127.0, 61801.0, 63009.0, 63132.0, 63260.367396326365, 63449.68275158687, 36113.81943090268, 36666.26667466636, 36674.26651466956, 38849.22301553953, 65821.34178658153, 17776.466705998842, 17889.28442862271, 17935.551611209823, 17936.19287132082, 17963.910180449013, 13163.73672526544, 13196.670083247996, 13223.735525289632, 13238.801417978739, 13258.668533286553, 19826.60346793056, 20172.39482815518, 20229.291974780812, 20238.595228095357, 20303.4924126898, 7386.2613738625705, 7545.434092443089, 7601.46789724725, 7625.542467451971, 7637.2362763724295, 961.8412961861214, 1041.250299784154, 1061.9787604248027, 1142.3831131189231, 1175.5239128153112, 33944.66055339464, 34228.48657270143, 34390.0, 34476.655233447345, 34937.0, 1123.836186927432, 1201.471352604851, 1202.4528839378063, 1219.3171823778534, 1220.536196245421, 17182.0, 17374.218160182823, 17478.0, 17564.946103233848, 18001.819981800276, 600149.0, 602606.0, 605090.0, 606743.0, 607330.0, 59820.401795982354, 61694.69152654208, 61721.38278617156, 61722.69138654368, 61807.381926181064, 1324.741675373293, 1338.7924871644911, 1360.054761940442, 1380.0822453068597, 1388.5417812121975, 31160.0, 33143.66856331406, 33368.33263334768, 33569.66430335665, 33834.154146146546, 53073.0, 53294.200586992, 53342.73328633332, 53717.731411344255, 53747.46252537581, 481037.0, 482062.0, 482682.0, 482783.68865245, 483369.0, 28848.42303153967, 29091.0, 29141.85429072841, 29223.269418264714, 45661.31508027316, 47685.5231447695, 48165.27752083651, 51561.0, 52009.7399513, 53210.201846971555, 44129.33805992977, 44500.0, 44506.0, 44633.10733785241, 44903.550964489936, 43459.26254024938, 44178.77910610555, 44197.0, 44398.55601443944, 44979.550204498846, 45088.54911450844, 45385.319220211066, 45800.54199458096, 46594.06811863812, 46724.532754672015, 40553.18893622052, 42528.787356063025, 43902.0, 45933.540664592925, 46154.53845461637, 35732.4640130393, 36449.0, 36652.26695466129, 36895.0, 36901.815490922374], "value": 21087.15203337362, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.72834818168536, 388.9436031775393, 389.75834982310965, 390.89445849620586, 408.92230476209517, 14308.427662893499, 18805.059747012645, 19940.202391904342, 20510.89744551277, 20562.38312850615, 18952.147153378097, 19500.51248718783, 19658.705119423183, 19797.40607781769, 19827.405177844652, 5725.112607545827, 5849.561282903778, 5870.88258234835, 5919.1713160157615, 5943.435373639497, 5170.689758614495, 5493.340799104093, 5710.172025056364, 5826.679532625704, 5855.4144585541535, 5427.294451721271, 5461.2354270402175, 5466.234727138204, 5500.559955203594, 5504.752286147133, 5340.679559226459, 5386.245925570423, 5391.137418013099, 5411.729413529328, 5589.301337332833, 4708.811647534095, 4934.80260789568, 5519.034169020446, 5539.806106786284, 5545.057340252127, 12553.184043037265, 12898.22610643355, 12951.546695865694, 13002.479900803957, 13109.344532773322, 2256.7743225677464, 2420.636904464327, 2835.560488124344, 2876.669183043956, 2891.7108289171124, 9475.857862132074, 9503.477308748015, 9657.130858222723, 9757.756056098584, 9843.950780246052, 1806.6206096719704, 1865.7947625761155, 1885.161103309028, 1903.4765439504108, 1939.0014142716511, 83920.0, 87321.56339218326, 87836.0, 88793.55603221942, 89082.55458722729, 10388.48057597117, 10489.527971241312, 10725.946370268099, 11101.44492775358, 11105.666829995112, 14956.700865982837, 14999.0, 15023.0, 15039.721623661893, 15116.773248401283, 8108.270255677017, 8278.544680042534, 8402.915970840335, 8448.619812108469, 8556.0, 8191.467554608931, 8221.218984196492, 8326.417150799507, 8406.747797566082, 8442.535660538606, 4476.485204201494, 4551.52209018055, 4635.235186194308, 4638.304254361805, 4652.371929789435, 1880.6083498211226, 1966.2626515056854, 1974.733410989498, 1984.8761824847275, 2009.1461129020108, 939.8543225799875, 955.8279509688323, 964.1226483899618, 1036.3522798251092, 1052.7894421115654, 19017.904910475634, 19885.304014359717, 19935.900320498306, 20003.299884504264, 20089.698654520194, 963.1043129889131, 981.1218959031627, 994.8507723841482, 1034.7930413917247, 1057.8416633785992, 10331.173506119492, 10971.067459266053, 11001.6149434771, 11004.339739615489, 11065.50205240766, 498365.0, 499663.0, 505426.0, 512630.0, 517380.0, 84386.0, 96501.0, 102009.0, 103350.48324758328, 103503.0, 1022.4172221833633, 1026.9691909242736, 1066.6106870992032, 1070.288258308232, 1076.4187338836941, 17076.146192690565, 17701.203445845225, 17739.0, 18134.81865181384, 18800.435986920413, 35227.29545409129, 42948.78525607352, 43172.352414713176, 43308.0, 43998.560014399445, 55929.161062583276, 56725.71637141788, 57563.4243657558, 58826.0, 59047.70476147764, 8128.796780080545, 8250.958745206235, 8272.462289951134, 8289.212524810133, 8545.060043395097, 9241.907580924104, 12891.033172511912, 13070.54253101175, 13706.65733356674, 14121.2233327168, 11571.074314054687, 11587.710307242049, 11645.76708465809, 11825.408729563316, 11889.405529723652, 11806.409679516162, 11824.940875295568, 11858.11064170208, 11961.222520536137, 12230.694232644255, 11413.429328533706, 11781.882181178078, 12247.816282755588, 12314.876851231373, 12506.93746531298, 8296.668133274843, 8373.0, 8399.70601028961, 8426.578671066545, 8511.489310641382, 8102.675892964216, 11099.889001109885, 11507.769844603228, 11546.0, 11696.298222106701], "value": 9083.741971850863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.7205600795828, 1406.3530775843112, 1449.8985071045024, 1803.8827476214037, 1829.7072468405058, 7665.310122089011, 8186.5497397643185, 8582.184692454206, 8729.127087291276, 8752.081031491689, 8663.523506207157, 8889.111088891108, 8897.0, 8898.466092034483, 8954.059823718513, 2290.7022087128694, 2327.9185228517003, 2328.0, 2329.6621989811465, 2331.090874558915, 2103.1061798735554, 2105.768365479804, 2192.3970908000347, 2197.055266235518, 2203.636399993999, 2166.6100101981638, 2167.1764729402885, 2177.477405422695, 2186.125549780085, 2210.8452408331423, 2216.8891555422165, 2244.438890277431, 2248.190651365507, 2248.876311802842, 2253.357793028979, 2115.0, 2127.914883404662, 2145.731783527059, 2147.806697397242, 2151.601953638582, 8780.648774049094, 8922.553872306424, 8974.641014359418, 9005.774855628597, 9021.503817290046, 5038.647294689373, 5186.5850731941355, 5197.58419326453, 5202.947970520284, 5205.869853253699, 3188.3463889902514, 3225.4677978133814, 3294.8682052717863, 3336.699697027255, 3349.531065650811, 1103.9558417663284, 1107.1032463704344, 1122.5004872831594, 1122.5678113926115, 1125.3922881643903, 12304.507819687202, 12309.076819238593, 12366.134370594062, 12371.443285052193, 12402.06984476168, 4404.977975110104, 4409.404730361424, 4537.705049171794, 4566.45202575693, 4608.746518941423, 10456.058954694114, 10468.947655261674, 10508.894911050944, 10509.211809114347, 10510.421926794099, 5209.47905209476, 5224.764885580158, 5230.633855630145, 5234.685918844882, 5236.031334203185, 4273.97863010683, 4688.601468875116, 4821.63837712173, 4828.782704778293, 4853.733044682576, 3758.530183727034, 3857.1707082977296, 3884.126071633916, 3895.6883449323986, 3918.804059796999, 1181.438816562126, 1183.46743965216, 1202.2987472725995, 1222.2422098299112, 1255.0587059705222, 1018.2973748113926, 1043.4834756795435, 1043.546057465005, 1051.7580956380075, 1061.5806756331206, 6161.075838624152, 6182.598131121463, 6297.244330680348, 6341.143945567382, 6352.460040896575, 438.861758546057, 446.3639313977569, 451.62740738890545, 1042.9634962776267, 1095.1895597257972, 4358.389825424443, 4423.933640995388, 4424.380586717862, 4518.164139634178, 4536.296873984537, 10812.945935270272, 11143.944280278547, 11254.43727813606, 11255.831162532568, 11324.660260192208, 10331.32846364984, 10826.458677066115, 10859.83710244347, 11101.611443599435, 11177.83233251502, 8209.876851847228, 8247.628856701584, 8338.8332233355, 8383.748487545383, 8411.663533458715, 6263.592866463665, 6482.546221764431, 6488.383603557654, 6523.64119973387, 6543.836404089745, 10218.693439196835, 10281.640142594973, 10298.330608510423, 10336.844947325646, 10339.741506462398, 10486.16110711126, 10512.78974420492, 10604.8939510607, 10612.787744245226, 10634.149268058381, 6971.930280697331, 7720.227977202235, 8005.919940800517, 8014.799630009064, 8168.83662326762, 8733.868991964999, 8753.47479151253, 8785.692500762443, 8796.60415281301, 8827.337949653931, 7313.817154571178, 7446.0, 7868.881966770388, 7882.5270483771155, 8004.079530854026, 7504.549727016397, 7557.697692092254, 7562.546247225184, 7725.034370703662, 7772.261635144652, 7045.2954704531185, 7049.0, 7053.894191587233, 7055.611941343275, 7101.2898710128575, 5251.238570407346, 5291.894162116813, 5365.9463405367005, 5384.626920135341, 5449.0, 5286.550643195372, 5373.650712703662, 5406.351237851483, 5483.588730845282, 5617.32592088952], "value": 4614.879665522059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3409605731905, 315.3582459694521, 319.2354311424139, 320.1053056706505, 323.9595050618673, 5581.386047534768, 5588.7145956429995, 5596.972015139929, 5625.324961004685, 5631.971840140799, 5406.16204488304, 5459.836204913859, 5461.918071228924, 5493.093639549469, 5552.194931734896, 4032.507972050338, 4077.858199704073, 4219.746815191083, 4229.154169166164, 4248.150369926012, 4191.392248124021, 4202.222588821062, 4233.51314598822, 4235.851745188919, 4252.957470425287, 4212.094399704063, 4235.6187943085115, 4241.766702831343, 4249.851255206068, 4259.850905218318, 3973.0, 4178.435911151986, 4182.247195504808, 4198.958010419888, 4245.8089385977555, 3585.1933315004176, 3627.9455808162897, 3632.2553876455263, 3642.6721595056574, 3650.2881938022097, 5382.784688612451, 5460.590455715797, 5465.180222966547, 5509.173623956439, 5517.213807027466, 4662.160811054009, 4877.707337559757, 4896.436909755353, 4941.283513890502, 4945.8268960586565, 5838.569550460122, 5855.238818953551, 5867.266591676041, 5894.17481552583, 5901.586888917777, 4071.676705070864, 4079.1433798902267, 4082.5509193988933, 4083.0, 4100.17996400718, 5876.44173803488, 6002.669853158074, 6089.238845144357, 6096.237970253718, 6118.1434599156155, 4128.8852009957745, 4155.8753237402325, 4163.791810409467, 4168.458100446923, 4175.123224122968, 4165.333546632524, 4183.665306775511, 4208.179405016053, 4216.978915105405, 4230.64039556635, 4743.0, 4891.828785992544, 4911.189653707098, 4914.336564563738, 4940.827071052496, 5880.764769409261, 5880.941190588125, 5885.176075349455, 5898.115282707542, 5935.703214839241, 1444.2489905249422, 1450.8259008918785, 1456.271864067966, 1460.2041887171517, 1461.9766163685463, 897.3897749530252, 915.272358475014, 927.2396634759433, 939.3659279986118, 969.0860550412879, 5592.0, 5595.944040559623, 5597.496225339739, 5605.383407825218, 5619.325680918316, 5862.179294898718, 5886.970565147147, 5903.822885313448, 5939.13882487037, 5943.0, 5324.494173053554, 5538.446155384429, 5590.217369568264, 5627.606067575312, 5646.661200327993, 3158.652548219694, 3189.9362012759616, 3190.633077196152, 3205.5351973963643, 3210.5826242588782, 5865.94134058654, 6121.418465245794, 6139.846503837351, 6166.260048794174, 6268.373162683695, 6208.348123446973, 6239.282482514478, 6289.182406287154, 6296.0, 6297.73281618617, 6088.512918966383, 6218.502519798405, 6232.719527621268, 6299.811005669837, 6335.746570137143, 6046.790641871556, 6069.666168360783, 6089.756409743561, 6090.269167699905, 6115.471132216946, 5980.700964951648, 6008.158857760004, 6011.519078473799, 6037.124616930609, 6064.878702426015, 5921.963656360206, 6147.0, 6147.815565533041, 6191.721372538156, 6211.844703882439, 4147.2534943709215, 4184.8744537663915, 4199.580041995776, 4202.621764041251, 4213.452251207324, 6080.2399700037495, 6095.420935011167, 6142.293636231891, 6154.0, 6155.4767844731905, 5718.599698021265, 5815.2149459822385, 5869.559783016205, 5892.145638882253, 5919.881602368015, 5879.2944846618675, 5903.819236152701, 5913.822585322275, 5921.911171332519, 5949.52403807703, 5219.556337711337, 5738.942610574008, 5880.176775251382, 5884.411558844081, 5907.527397808251, 5919.6744179070565, 5932.8813423732145, 5939.613925094855, 5947.9702601486715, 6002.669853157943, 5619.494245517923, 5790.768369265183, 5893.882122357443, 5902.996490596523, 5908.734106965283], "value": 4410.309854030654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.2369280556138, 655.2988302516303, 707.2679776431395, 787.3548438149122, 819.946703464275, 15206.467773627925, 16148.111853848019, 16266.0, 16304.755428668564, 16501.17494125295, 15178.772318415233, 15236.923815380907, 15282.923585382057, 15923.84076159238, 16357.918210408961, 808.0384342632263, 818.8812622169781, 821.5235163605124, 825.0182283083112, 826.4256341842392, 806.4959400374765, 808.0989696488402, 831.6340810043562, 838.1827717974957, 841.6380956188837, 637.4358692557074, 641.4227195524019, 641.4451499452963, 641.8908785506475, 653.0563335979488, 636.7325723196245, 641.0352419608482, 647.4820143884897, 650.4243744286293, 651.6741629185407, 466.4985140973467, 466.6873194959351, 471.4036743519451, 474.43542184799975, 478.3064556393209, 15835.60410989723, 15948.441804536902, 15989.680206395924, 15996.280167392379, 16022.839771602252, 15039.548813535612, 15112.319945602474, 15188.392464301525, 15356.232188390535, 15440.150791706452, 12454.467298451058, 12501.0, 12521.12352135351, 12559.0, 12686.873131268754, 3806.695464362844, 3824.101336185994, 3931.9213615727526, 4031.9596804031876, 4033.737807042562, 80558.5702195451, 81393.59303203446, 81766.18233817646, 82284.0, 82859.0, 11727.4136293185, 11733.4133293335, 11886.108541859396, 12016.699582510508, 12515.374231288399, 21617.459563510725, 21629.675554866688, 21639.242626508312, 21672.674909876365, 21689.891550542463, 8373.623186956602, 8463.23830855226, 8569.614367353484, 8611.956940215385, 8915.063918288615, 4631.9536804631525, 4682.695624784446, 4699.224627936421, 4706.88232794176, 4708.858734237979, 3682.3371793076967, 3751.756135851161, 3767.962320376816, 3782.6973842092566, 3796.1648437343742, 609.4514936557046, 617.6170774119985, 622.3372108704216, 624.9312575616678, 635.4027214418431, 650.9804705858737, 710.4210068793916, 723.6996646391793, 732.9816754581071, 746.2015643261658, 9609.375390599589, 9614.0, 9659.613615455444, 9961.651342202988, 10046.296759226783, 589.7906243283659, 693.3690341788948, 696.571608460793, 701.4458577723541, 703.6763088979025, 4503.684742068024, 4582.473015603182, 4623.329617205553, 4748.074125545486, 4774.976125119421, 94285.0, 114504.42747786375, 115801.42099289618, 116730.0, 117975.41012295055, 58757.41242587605, 59740.0, 87079.0, 88784.5560772192, 97641.02358976462, 57318.426815731305, 85326.57336713401, 86788.0, 89147.55426222828, 91614.0, 9949.751256218653, 10234.948825255826, 10386.948065259625, 10450.372977621368, 10604.416757078434, 49650.75174624104, 49903.500964989886, 50388.24417633665, 50862.491375085774, 52332.47667523276, 72985.27014729785, 79046.6047669758, 79594.6020269895, 80054.19945800467, 80060.19939800528, 13747.862521374658, 13799.655008624864, 13950.162990220619, 13995.650108747363, 14019.439222430989, 15230.44305302391, 15425.691486170439, 15634.0, 16431.26059327309, 16482.175891205632, 14233.288335582973, 14251.0, 14431.278436078364, 14672.779908301598, 14917.179555124572, 14096.718065638835, 14571.34428950721, 14583.343749531508, 15100.54698359051, 15616.609584760472, 13904.721905562035, 13982.860171398155, 14483.927580362031, 14513.564593062225, 14885.330160143036, 11686.649400517997, 11799.174057816213, 12082.0, 12094.697632559257, 12225.938870305592, 10737.389391591012, 11562.0, 11714.824277636013, 11828.40857957116, 11893.108016898941], "value": 7520.451054553854, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 105.0, 114.0, 114.0, 113.0, 114.0, 113.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 146.0, 164.0, 118.0, 150.0, 144.0, 120.0, 188.0, 122.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 164.0, 165.0, 167.0, 165.0, 172.0, 163.0, 160.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 130.0, 75.0, 76.0, 75.0, 74.0, 182.0, 76.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 142.0, 84.0, 84.0, 84.0, 132.0, 84.0, 83.0, 156.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 54.0, 52.0, 52.0, 55.0, 52.0, 52.0, 51.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 63.0, 63.0, 62.0, 62.0, 64.0, 64.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 75.0, 76.0, 75.0, 75.0, 76.0, 81.0, 77.0, 82.0, 81.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 131.0, 126.0, 122.0, 130.0, 132.0, 129.0, 155.0, 137.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 160.0, 158.0, 160.0, 162.0, 160.0, 160.0, 157.0, 157.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 62.0, 63.0], "value": 64.0, "unit": "score"}]}]} 04:29:48 INFO - Return code: 0 04:29:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:48 ERROR - # TBPL SUCCESS # 04:29:48 INFO - Running post-action listener: _resource_record_post_action 04:29:48 INFO - ##### 04:29:48 INFO - ##### Finished run-tests step (success) 04:29:48 INFO - ##### 04:29:48 INFO - Running post-run listener: _resource_record_post_run 04:29:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555073536; Read time: 8; Write time: 581340 04:29:48 INFO - TinderboxPrint: CPU usage
13.3% 04:29:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:29:48 INFO - TinderboxPrint: I/O write bytes / time
555,073,536 / 581,340 04:29:48 INFO - TinderboxPrint: CPU idle
8,231.0 (86.7%) 04:29:48 INFO - TinderboxPrint: CPU user
1,209.9 (12.7%) 04:29:48 INFO - TinderboxPrint: Swap in / out
0 / 0 04:29:48 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257142784; Read time: 0; Write time: 355848 04:29:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297648128; Read time: 0; Write time: 225472 04:29:48 INFO - Running post-run listener: _upload_blobber_files 04:29:48 INFO - Blob upload gear active. 04:29:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:48 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 04:29:48 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'] 04:29:48 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 04:29:49 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:50 INFO - (blobuploader) - INFO - Done attempting. 04:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:50 INFO - (blobuploader) - INFO - Done attempting. 04:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:58 INFO - (blobuploader) - INFO - Done attempting. 04:29:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:58 INFO - Return code: 0 04:29:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e86ac9bc2c7c4daa415317cac38c85cee585874961230207aabd1d81e9dbc24dbf56b947aaaf1ef401ad3b379f8602cac30722cabe2940884a4b0e58e8a2bea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17a3c7c6c430340964c2d5f6265c346118f19698102988a224bcc734f21e2711aee0503ae4f9fe2c2e1bfa580d85792f1636991a0653a89f780555d796a19ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c29993b801f30cd5edb2b6311324a44cd619faeddb79f68cef6fdb31732fe8cdc256ddb11803ea9caca14c290d8caacd7ab8d4ef2e2a7627945821d8952f15a6"} 04:29:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:58 INFO - Contents: 04:29:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e86ac9bc2c7c4daa415317cac38c85cee585874961230207aabd1d81e9dbc24dbf56b947aaaf1ef401ad3b379f8602cac30722cabe2940884a4b0e58e8a2bea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17a3c7c6c430340964c2d5f6265c346118f19698102988a224bcc734f21e2711aee0503ae4f9fe2c2e1bfa580d85792f1636991a0653a89f780555d796a19ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c29993b801f30cd5edb2b6311324a44cd619faeddb79f68cef6fdb31732fe8cdc256ddb11803ea9caca14c290d8caacd7ab8d4ef2e2a7627945821d8952f15a6"} 04:29:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:58 INFO - Copying logs to upload dir... 04:29:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.403253 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 04:29:58.310679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 04:29:58.314349) ========= 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-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e86ac9bc2c7c4daa415317cac38c85cee585874961230207aabd1d81e9dbc24dbf56b947aaaf1ef401ad3b379f8602cac30722cabe2940884a4b0e58e8a2bea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17a3c7c6c430340964c2d5f6265c346118f19698102988a224bcc734f21e2711aee0503ae4f9fe2c2e1bfa580d85792f1636991a0653a89f780555d796a19ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c29993b801f30cd5edb2b6311324a44cd619faeddb79f68cef6fdb31732fe8cdc256ddb11803ea9caca14c290d8caacd7ab8d4ef2e2a7627945821d8952f15a6"} build_url:https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/SBplwyDDRoOqh9UAbiAo8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e86ac9bc2c7c4daa415317cac38c85cee585874961230207aabd1d81e9dbc24dbf56b947aaaf1ef401ad3b379f8602cac30722cabe2940884a4b0e58e8a2bea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17a3c7c6c430340964c2d5f6265c346118f19698102988a224bcc734f21e2711aee0503ae4f9fe2c2e1bfa580d85792f1636991a0653a89f780555d796a19ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c29993b801f30cd5edb2b6311324a44cd619faeddb79f68cef6fdb31732fe8cdc256ddb11803ea9caca14c290d8caacd7ab8d4ef2e2a7627945821d8952f15a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 04:29:58.346571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:29:58.346894) ========= 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-1468926343.258948-2127461917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 04:29:58.433594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 04:29:58.434339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 04:29:58.435005) ========= ========= Total master_lag: 0.20 =========