builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1468434948.2 results: success (0) buildid: 20160713073201 builduid: f4a63f0f426c4835a92d4f02f319e0a8 revision: dcb7835534e21a62cebdd5d1205d4e81f6bc6946 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.198320) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.198783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.199059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.214402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.214680) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 11:35:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-13 11:35:48 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.354126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.354455) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.405339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:48.405691) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dcb7835534e21a62cebdd5d1205d4e81f6bc6946 --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 dcb7835534e21a62cebdd5d1205d4e81f6bc6946 --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=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 11:35:48,510 truncating revision to first 12 chars 2016-07-13 11:35:48,510 Setting DEBUG logging. 2016-07-13 11:35:48,510 attempt 1/10 2016-07-13 11:35:48,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dcb7835534e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 11:35:49,130 unpacking tar archive at: mozilla-inbound-dcb7835534e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:49.397354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:49.397664) ========= script_repo_revision: dcb7835534e21a62cebdd5d1205d4e81f6bc6946 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:49.398051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:49.398331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 11:35:49.409512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-13 11:35:49.409900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:35:49 INFO - MultiFileLogger online at 20160713 11:35:49 in /builds/slave/test 11:35:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:35:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:49 INFO - {'append_to_log': False, 11:35:49 INFO - 'base_work_dir': '/builds/slave/test', 11:35:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:35:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:49 INFO - 'branch': 'Mozilla-Inbound', 11:35:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:49 INFO - 'config_files': ('talos/linux_config.py',), 11:35:49 INFO - 'default_actions': ('clobber', 11:35:49 INFO - 'read-buildbot-config', 11:35:49 INFO - 'download-and-extract', 11:35:49 INFO - 'populate-webroot', 11:35:49 INFO - 'create-virtualenv', 11:35:49 INFO - 'install', 11:35:49 INFO - 'run-tests'), 11:35:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:49 INFO - 'download_minidump_stackwalk': True, 11:35:49 INFO - 'download_symbols': 'ondemand', 11:35:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:35:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:35:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:35:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:35:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:49 INFO - 'installer_path': 'installer.exe', 11:35:49 INFO - 'log_level': 'info', 11:35:49 INFO - 'log_name': 'talos', 11:35:49 INFO - 'log_to_console': True, 11:35:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:35:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:35:49 INFO - 'opt_config_files': (), 11:35:49 INFO - 'pip_index': False, 11:35:49 INFO - 'sps_profile': False, 11:35:49 INFO - 'sps_profile_interval': 0, 11:35:49 INFO - 'suite': 'dromaeojs', 11:35:49 INFO - 'system_bits': '32', 11:35:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:49 INFO - 'title': 'talos-linux64-ix-011', 11:35:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:49 INFO - 'use_talos_json': True, 11:35:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:49 INFO - 'work_dir': 'build'} 11:35:49 INFO - ##### 11:35:49 INFO - ##### Running clobber step. 11:35:49 INFO - ##### 11:35:49 INFO - Running pre-action listener: _resource_record_pre_action 11:35:49 INFO - Running main action method: clobber 11:35:49 INFO - rmtree: /builds/slave/test/build 11:35:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:50 INFO - Running post-action listener: _resource_record_post_action 11:35:50 INFO - ##### 11:35:50 INFO - ##### Finished clobber step (success) 11:35:50 INFO - ##### 11:35:50 INFO - ##### 11:35:50 INFO - ##### Running read-buildbot-config step. 11:35:50 INFO - ##### 11:35:50 INFO - Running pre-action listener: _resource_record_pre_action 11:35:50 INFO - Running main action method: read_buildbot_config 11:35:50 INFO - Using buildbot properties: 11:35:50 INFO - { 11:35:50 INFO - "project": "", 11:35:50 INFO - "product": "firefox", 11:35:50 INFO - "script_repo_revision": "production", 11:35:50 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:35:50 INFO - "repository": "", 11:35:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:35:50 INFO - "buildid": "20160713073201", 11:35:50 INFO - "pgo_build": "True", 11:35:50 INFO - "basedir": "/builds/slave/test", 11:35:50 INFO - "buildnumber": 1329, 11:35:50 INFO - "slavename": "talos-linux64-ix-011", 11:35:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:35:50 INFO - "platform": "ubuntu64_hw", 11:35:50 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:35:50 INFO - "branch": "mozilla-inbound", 11:35:50 INFO - "repo_path": "integration/mozilla-inbound", 11:35:50 INFO - "revision": "dcb7835534e21a62cebdd5d1205d4e81f6bc6946", 11:35:50 INFO - "stage_platform": "linux64-pgo", 11:35:50 INFO - "builduid": "f4a63f0f426c4835a92d4f02f319e0a8", 11:35:50 INFO - "slavebuilddir": "test" 11:35:50 INFO - } 11:35:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:35:50 INFO - Running post-action listener: _resource_record_post_action 11:35:50 INFO - ##### 11:35:50 INFO - ##### Finished read-buildbot-config step (success) 11:35:50 INFO - ##### 11:35:50 INFO - ##### 11:35:50 INFO - ##### Running download-and-extract step. 11:35:50 INFO - ##### 11:35:50 INFO - Running pre-action listener: _resource_record_pre_action 11:35:50 INFO - Running main action method: download_and_extract 11:35:50 INFO - mkdir: /builds/slave/test/build/tests 11:35: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')]} 11:35:50 INFO - https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:51 INFO - Downloaded 1361 bytes. 11:35:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:35:51 INFO - Using the following test package requirements: 11:35:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:35:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:35:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:35:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'jsshell-linux-x86_64.zip'], 11:35:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:35:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:35:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:35:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:35:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:35:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:35:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:35:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:35:51 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')]} 11:35:51 INFO - https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:52 INFO - Downloaded 24326088 bytes. 11:35:52 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'] 11:35:52 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 11:35:54 INFO - Return code: 0 11:35:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:54 INFO - https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:55 INFO - Downloaded 24326088 bytes. 11:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:35:57 INFO - Return code: 0 11:35: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')]} 11:35:57 INFO - https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:57 INFO - Downloaded 14403317 bytes. 11:35:57 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'] 11:35:57 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 11:35:58 INFO - Return code: 0 11:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:58 INFO - https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdPPIH8NSm6jxsoo4b215Q/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 11:35:59 INFO - Downloaded 60851647 bytes. 11:35:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:35:59 INFO - mkdir: /builds/slave/test/properties 11:35:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:35:59 INFO - Writing to file /builds/slave/test/properties/build_url 11:35:59 INFO - Contents: 11:35:59 INFO - build_url:https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:36:00 INFO - Running post-action listener: _resource_record_post_action 11:36:00 INFO - Running post-action listener: set_extra_try_arguments 11:36:00 INFO - ##### 11:36:00 INFO - ##### Finished download-and-extract step (success) 11:36:00 INFO - ##### 11:36:00 INFO - ##### 11:36:00 INFO - ##### Running populate-webroot step. 11:36:00 INFO - ##### 11:36:00 INFO - Running pre-action listener: _resource_record_pre_action 11:36:00 INFO - Running main action method: populate_webroot 11:36:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:36:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:36:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:36:00 INFO - '--tppagecycles', 11:36:00 INFO - '7'], 11:36:00 INFO - 'tests': ['tsvgm']}}, 11:36:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:36:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:36:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:36:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:36:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['damp', 'tps']}, 11:36:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'tests': ['damp', 'tps']}, 11:36:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['dromaeo_dom']}, 11:36:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:36:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['basic_compositor_video']}, 11:36:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:36:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'other-e10s': {'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['a11yr', 11:36:00 INFO - 'ts_paint', 11:36:00 INFO - 'tpaint', 11:36:00 INFO - 'sessionrestore', 11:36:00 INFO - 'sessionrestore_no_auto_restore', 11:36:00 INFO - 'tabpaint']}, 11:36:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['tsvgx', 11:36:00 INFO - 'tsvgr_opacity', 11:36:00 INFO - 'tart', 11:36:00 INFO - 'tscrollx', 11:36:00 INFO - 'cart']}, 11:36:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:36:00 INFO - 'tsvgr_opacity', 11:36:00 INFO - 'tart', 11:36:00 INFO - 'tscrollx', 11:36:00 INFO - 'cart']}, 11:36:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'talos_options': ['--disable-e10s'], 11:36:00 INFO - 'tests': ['tp5o']}, 11:36:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'tests': ['tp5o']}, 11:36:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'talos_options': ['--disable-e10s', 11:36:00 INFO - '--xperf_path', 11:36:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:00 INFO - 'tests': ['tp5n']}, 11:36:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:00 INFO - 'talos_options': ['--xperf_path', 11:36:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:00 INFO - 'tests': ['tp5n']}}, 11:36:00 INFO - 'talos.zip': {'path': '', 11:36:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:36:00 INFO - Running post-action listener: _resource_record_post_action 11:36:00 INFO - ##### 11:36:00 INFO - ##### Finished populate-webroot step (success) 11:36:00 INFO - ##### 11:36:00 INFO - ##### 11:36:00 INFO - ##### Running create-virtualenv step. 11:36:00 INFO - ##### 11:36:00 INFO - Running pre-action listener: _resource_record_pre_action 11:36:00 INFO - Running main action method: create_virtualenv 11:36:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:36:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:36:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:36:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:36:00 INFO - Using real prefix '/usr' 11:36:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:36:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:02 INFO - Installing pip.................done. 11:36:02 INFO - Return code: 0 11:36:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:02 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')]} 11:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:02 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')]} 11:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:02 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 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:02 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 11:36:02 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 11:36:02 INFO - Using env: {'DISPLAY': ':0', 11:36:02 INFO - 'HOME': '/home/cltbld', 11:36:02 INFO - 'LANG': 'en_US.UTF-8', 11:36:02 INFO - 'LANGUAGE': 'en_US:en', 11:36:02 INFO - 'LOGNAME': 'cltbld', 11:36:02 INFO - 'MAIL': '/var/mail/cltbld', 11:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:02 INFO - 'MOZ_NO_REMOTE': '1', 11:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:02 INFO - 'NO_EM_RESTART': '1', 11:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:02 INFO - 'PWD': '/builds/slave/test', 11:36:02 INFO - 'SHELL': '/bin/bash', 11:36:02 INFO - 'SHLVL': '1', 11:36:02 INFO - 'TERM': 'linux', 11:36:02 INFO - 'TMOUT': '86400', 11:36:02 INFO - 'USER': 'cltbld', 11:36:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:02 INFO - '_': '/tools/buildbot/bin/python'} 11:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:36:03 INFO - Cleaning up... 11:36:03 INFO - Return code: 0 11:36:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:36:03 INFO - Using env: {'DISPLAY': ':0', 11:36:03 INFO - 'HOME': '/home/cltbld', 11:36:03 INFO - 'LANG': 'en_US.UTF-8', 11:36:03 INFO - 'LANGUAGE': 'en_US:en', 11:36:03 INFO - 'LOGNAME': 'cltbld', 11:36:03 INFO - 'MAIL': '/var/mail/cltbld', 11:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:03 INFO - 'MOZ_NO_REMOTE': '1', 11:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:03 INFO - 'NO_EM_RESTART': '1', 11:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:03 INFO - 'PWD': '/builds/slave/test', 11:36:03 INFO - 'SHELL': '/bin/bash', 11:36:03 INFO - 'SHLVL': '1', 11:36:03 INFO - 'TERM': 'linux', 11:36:03 INFO - 'TMOUT': '86400', 11:36:03 INFO - 'USER': 'cltbld', 11:36:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:03 INFO - '_': '/tools/buildbot/bin/python'} 11:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:03 INFO - Downloading/unpacking psutil>=3.1.1 11:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:05 INFO - Installing collected packages: psutil 11:36:05 INFO - Running setup.py install for psutil 11:36:05 INFO - building 'psutil._psutil_linux' extension 11:36:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:36:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:36:05 INFO - building 'psutil._psutil_posix' extension 11:36:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:36:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:05 INFO - Successfully installed psutil 11:36:05 INFO - Cleaning up... 11:36:05 INFO - Return code: 0 11:36:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:36:05 INFO - Using env: {'DISPLAY': ':0', 11:36:05 INFO - 'HOME': '/home/cltbld', 11:36:05 INFO - 'LANG': 'en_US.UTF-8', 11:36:05 INFO - 'LANGUAGE': 'en_US:en', 11:36:05 INFO - 'LOGNAME': 'cltbld', 11:36:05 INFO - 'MAIL': '/var/mail/cltbld', 11:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:05 INFO - 'MOZ_NO_REMOTE': '1', 11:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:05 INFO - 'NO_EM_RESTART': '1', 11:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:05 INFO - 'PWD': '/builds/slave/test', 11:36:05 INFO - 'SHELL': '/bin/bash', 11:36:05 INFO - 'SHLVL': '1', 11:36:05 INFO - 'TERM': 'linux', 11:36:05 INFO - 'TMOUT': '86400', 11:36:05 INFO - 'USER': 'cltbld', 11:36:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:05 INFO - '_': '/tools/buildbot/bin/python'} 11:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:36:09 INFO - Installing collected packages: mozsystemmonitor 11:36:09 INFO - Running setup.py install for mozsystemmonitor 11:36:09 INFO - Successfully installed mozsystemmonitor 11:36:09 INFO - Cleaning up... 11:36:09 INFO - Return code: 0 11:36:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:36:09 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')]} 11:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:09 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')]} 11:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:09 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 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:09 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 11:36:09 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 11:36:09 INFO - Using env: {'DISPLAY': ':0', 11:36:09 INFO - 'HOME': '/home/cltbld', 11:36:09 INFO - 'LANG': 'en_US.UTF-8', 11:36:09 INFO - 'LANGUAGE': 'en_US:en', 11:36:09 INFO - 'LOGNAME': 'cltbld', 11:36:09 INFO - 'MAIL': '/var/mail/cltbld', 11:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:09 INFO - 'MOZ_NO_REMOTE': '1', 11:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:09 INFO - 'NO_EM_RESTART': '1', 11:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:09 INFO - 'PWD': '/builds/slave/test', 11:36:09 INFO - 'SHELL': '/bin/bash', 11:36:09 INFO - 'SHLVL': '1', 11:36:09 INFO - 'TERM': 'linux', 11:36:09 INFO - 'TMOUT': '86400', 11:36:09 INFO - 'USER': 'cltbld', 11:36:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:09 INFO - '_': '/tools/buildbot/bin/python'} 11:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:09 INFO - Downloading/unpacking jsonschema==2.5.1 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:11 INFO - warning: no files found matching '*.txt' 11:36:11 INFO - no previously-included directories found matching 'build' 11:36:11 INFO - no previously-included directories found matching 'dist' 11:36:11 INFO - no previously-included directories found matching '.git*' 11:36:11 INFO - Installing collected packages: jsonschema, functools32 11:36:11 INFO - Running setup.py install for functools32 11:36:11 INFO - warning: no files found matching '*.txt' 11:36:11 INFO - no previously-included directories found matching 'build' 11:36:11 INFO - no previously-included directories found matching 'dist' 11:36:11 INFO - no previously-included directories found matching '.git*' 11:36:11 INFO - Successfully installed jsonschema functools32 11:36:11 INFO - Cleaning up... 11:36:11 INFO - Return code: 0 11:36:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:36:11 INFO - Using env: {'DISPLAY': ':0', 11:36:11 INFO - 'HOME': '/home/cltbld', 11:36:11 INFO - 'LANG': 'en_US.UTF-8', 11:36:11 INFO - 'LANGUAGE': 'en_US:en', 11:36:11 INFO - 'LOGNAME': 'cltbld', 11:36:11 INFO - 'MAIL': '/var/mail/cltbld', 11:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:11 INFO - 'MOZ_NO_REMOTE': '1', 11:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:11 INFO - 'NO_EM_RESTART': '1', 11:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:11 INFO - 'PWD': '/builds/slave/test', 11:36:11 INFO - 'SHELL': '/bin/bash', 11:36:11 INFO - 'SHLVL': '1', 11:36:11 INFO - 'TERM': 'linux', 11:36:11 INFO - 'TMOUT': '86400', 11:36:11 INFO - 'USER': 'cltbld', 11:36:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:11 INFO - '_': '/tools/buildbot/bin/python'} 11:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:12 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 11:36:12 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 11:36:12 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 11:36:12 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 11:36:12 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 11:36:12 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 11:36:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 INFO - Downloading docopt-0.6.1.tar.gz 11:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:14 INFO - Running setup.py install for blobuploader 11:36:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:14 INFO - Running setup.py install for requests 11:36:15 INFO - Running setup.py install for docopt 11:36:15 INFO - Successfully installed blobuploader requests docopt 11:36:15 INFO - Cleaning up... 11:36:15 INFO - Return code: 0 11:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:15 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 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:15 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 11:36:15 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 11:36:15 INFO - Using env: {'DISPLAY': ':0', 11:36:15 INFO - 'HOME': '/home/cltbld', 11:36:15 INFO - 'LANG': 'en_US.UTF-8', 11:36:15 INFO - 'LANGUAGE': 'en_US:en', 11:36:15 INFO - 'LOGNAME': 'cltbld', 11:36:15 INFO - 'MAIL': '/var/mail/cltbld', 11:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:15 INFO - 'MOZ_NO_REMOTE': '1', 11:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:15 INFO - 'NO_EM_RESTART': '1', 11:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:15 INFO - 'PWD': '/builds/slave/test', 11:36:15 INFO - 'SHELL': '/bin/bash', 11:36:15 INFO - 'SHLVL': '1', 11:36:15 INFO - 'TERM': 'linux', 11:36:15 INFO - 'TMOUT': '86400', 11:36:15 INFO - 'USER': 'cltbld', 11:36:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:15 INFO - '_': '/tools/buildbot/bin/python'} 11:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:15 INFO - Running setup.py (path:/tmp/pip-sy1_je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:15 INFO - Running setup.py (path:/tmp/pip-elNbv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:15 INFO - Running setup.py (path:/tmp/pip-5C6B1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:15 INFO - Running setup.py (path:/tmp/pip-z7jWmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:15 INFO - Running setup.py (path:/tmp/pip-JjnzTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:15 INFO - Running setup.py (path:/tmp/pip-M1Lrd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:15 INFO - Running setup.py (path:/tmp/pip-JzB9hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:16 INFO - Running setup.py (path:/tmp/pip-lBRfdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:16 INFO - Running setup.py (path:/tmp/pip-rG_r3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:16 INFO - Running setup.py (path:/tmp/pip-iLN32w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:16 INFO - Running setup.py (path:/tmp/pip-VDnBbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:16 INFO - Running setup.py (path:/tmp/pip-ew74AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:16 INFO - Running setup.py (path:/tmp/pip-m7bxkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:16 INFO - Running setup.py (path:/tmp/pip-tMA_n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:16 INFO - Running setup.py (path:/tmp/pip-Y8AZlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:16 INFO - Running setup.py (path:/tmp/pip-3okt1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:16 INFO - Running setup.py (path:/tmp/pip-Nt4OZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:16 INFO - Running setup.py install for manifestparser 11:36:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:16 INFO - Running setup.py install for mozcrash 11:36:16 INFO - Running setup.py install for mozdebug 11:36:17 INFO - Running setup.py install for mozdevice 11:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for mozfile 11:36:17 INFO - Running setup.py install for mozhttpd 11:36:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for mozinfo 11:36:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for mozInstall 11:36:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for mozleak 11:36:17 INFO - Running setup.py install for mozlog 11:36:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for moznetwork 11:36:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:17 INFO - Running setup.py install for mozprocess 11:36:17 INFO - Running setup.py install for mozprofile 11:36:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:18 INFO - Running setup.py install for mozrunner 11:36:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:18 INFO - Running setup.py install for mozscreenshot 11:36:18 INFO - Running setup.py install for moztest 11:36:18 INFO - Running setup.py install for mozversion 11:36:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:18 INFO - Cleaning up... 11:36:18 INFO - Return code: 0 11:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:18 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')]} 11:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:18 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')]} 11:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:18 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 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:18 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 11:36:18 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 11:36:18 INFO - Using env: {'DISPLAY': ':0', 11:36:18 INFO - 'HOME': '/home/cltbld', 11:36:18 INFO - 'LANG': 'en_US.UTF-8', 11:36:18 INFO - 'LANGUAGE': 'en_US:en', 11:36:18 INFO - 'LOGNAME': 'cltbld', 11:36:18 INFO - 'MAIL': '/var/mail/cltbld', 11:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:18 INFO - 'MOZ_NO_REMOTE': '1', 11:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:18 INFO - 'NO_EM_RESTART': '1', 11:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:18 INFO - 'PWD': '/builds/slave/test', 11:36:18 INFO - 'SHELL': '/bin/bash', 11:36:18 INFO - 'SHLVL': '1', 11:36:18 INFO - 'TERM': 'linux', 11:36:18 INFO - 'TMOUT': '86400', 11:36:18 INFO - 'USER': 'cltbld', 11:36:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:18 INFO - '_': '/tools/buildbot/bin/python'} 11:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:18 INFO - Running setup.py (path:/tmp/pip-38uuyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:18 INFO - Running setup.py (path:/tmp/pip-HVw5_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:18 INFO - Running setup.py (path:/tmp/pip-k2hHMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:19 INFO - Running setup.py (path:/tmp/pip-Ameo6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:19 INFO - Running setup.py (path:/tmp/pip-jRvNGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:19 INFO - Running setup.py (path:/tmp/pip-qQnQwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:19 INFO - Running setup.py (path:/tmp/pip-O8Za3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:19 INFO - Running setup.py (path:/tmp/pip-dqLD2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:19 INFO - Running setup.py (path:/tmp/pip-K2lxhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:19 INFO - Running setup.py (path:/tmp/pip-44b7KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:19 INFO - Running setup.py (path:/tmp/pip-qssEi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:19 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)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:19 INFO - Running setup.py (path:/tmp/pip-oAv32h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:19 INFO - Running setup.py (path:/tmp/pip-ffAFiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:19 INFO - Running setup.py (path:/tmp/pip-CIwd5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:19 INFO - Running setup.py (path:/tmp/pip-B3o6Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:19 INFO - Running setup.py (path:/tmp/pip-LNORkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:19 INFO - Running setup.py (path:/tmp/pip-TWI8WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:20 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)) 11:36:20 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)) 11:36:20 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)) 11:36:20 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)) 11:36:20 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)) 11:36:20 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)) 11:36:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:21 INFO - Downloading blessings-1.6.tar.gz 11:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:21 INFO - Installing collected packages: blessings 11:36:21 INFO - Running setup.py install for blessings 11:36:22 INFO - Successfully installed blessings 11:36:22 INFO - Cleaning up... 11:36:22 INFO - Return code: 0 11:36:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:22 INFO - Reading from file tmpfile_stdout 11:36:22 INFO - Current package versions: 11:36:22 INFO - argparse == 1.2.1 11:36:22 INFO - blessings == 1.6 11:36:22 INFO - blobuploader == 1.2.4 11:36:22 INFO - docopt == 0.6.1 11:36:22 INFO - functools32 == 3.2.3-2 11:36:22 INFO - jsonschema == 2.5.1 11:36:22 INFO - manifestparser == 1.1 11:36:22 INFO - mozInstall == 1.12 11:36:22 INFO - mozcrash == 0.17 11:36:22 INFO - mozdebug == 0.1 11:36:22 INFO - mozdevice == 0.48 11:36:22 INFO - mozfile == 1.2 11:36:22 INFO - mozhttpd == 0.7 11:36:22 INFO - mozinfo == 0.9 11:36:22 INFO - mozleak == 0.1 11:36:22 INFO - mozlog == 3.2 11:36:22 INFO - moznetwork == 0.27 11:36:22 INFO - mozprocess == 0.23 11:36:22 INFO - mozprofile == 0.28 11:36:22 INFO - mozrunner == 6.12 11:36:22 INFO - mozscreenshot == 0.1 11:36:22 INFO - mozsystemmonitor == 0.3 11:36:22 INFO - moztest == 0.7 11:36:22 INFO - mozversion == 1.4 11:36:22 INFO - psutil == 3.1.1 11:36:22 INFO - requests == 1.2.3 11:36:22 INFO - wsgiref == 0.1.2 11:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 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 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:22 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 11:36:22 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 11:36:22 INFO - Using env: {'DISPLAY': ':0', 11:36:22 INFO - 'HOME': '/home/cltbld', 11:36:22 INFO - 'LANG': 'en_US.UTF-8', 11:36:22 INFO - 'LANGUAGE': 'en_US:en', 11:36:22 INFO - 'LOGNAME': 'cltbld', 11:36:22 INFO - 'MAIL': '/var/mail/cltbld', 11:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:22 INFO - 'MOZ_NO_REMOTE': '1', 11:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:22 INFO - 'NO_EM_RESTART': '1', 11:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:22 INFO - 'PWD': '/builds/slave/test', 11:36:22 INFO - 'SHELL': '/bin/bash', 11:36:22 INFO - 'SHLVL': '1', 11:36:22 INFO - 'TERM': 'linux', 11:36:22 INFO - 'TMOUT': '86400', 11:36:22 INFO - 'USER': 'cltbld', 11:36:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:22 INFO - '_': '/tools/buildbot/bin/python'} 11:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 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)) 11:36:22 INFO - Cleaning up... 11:36:22 INFO - Return code: 0 11:36:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', '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 11:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:36:22 INFO - Using env: {'DISPLAY': ':0', 11:36:22 INFO - 'HOME': '/home/cltbld', 11:36:22 INFO - 'LANG': 'en_US.UTF-8', 11:36:22 INFO - 'LANGUAGE': 'en_US:en', 11:36:22 INFO - 'LOGNAME': 'cltbld', 11:36:22 INFO - 'MAIL': '/var/mail/cltbld', 11:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:22 INFO - 'MOZ_NO_REMOTE': '1', 11:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:22 INFO - 'NO_EM_RESTART': '1', 11:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:22 INFO - 'PWD': '/builds/slave/test', 11:36:22 INFO - 'SHELL': '/bin/bash', 11:36:22 INFO - 'SHLVL': '1', 11:36:22 INFO - 'TERM': 'linux', 11:36:22 INFO - 'TMOUT': '86400', 11:36:22 INFO - 'USER': 'cltbld', 11:36:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:22 INFO - '_': '/tools/buildbot/bin/python'} 11:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:22 INFO - Cleaning up... 11:36:22 INFO - Return code: 0 11:36:22 INFO - Running post-action listener: _resource_record_post_action 11:36:22 INFO - Running post-action listener: _start_resource_monitoring 11:36:22 INFO - Starting resource monitoring. 11:36:22 INFO - ##### 11:36:22 INFO - ##### Finished create-virtualenv step (success) 11:36:22 INFO - ##### 11:36:22 INFO - ##### 11:36:22 INFO - ##### Running install step. 11:36:22 INFO - ##### 11:36:22 INFO - Running pre-action listener: _resource_record_pre_action 11:36:22 INFO - Running main action method: install 11:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:23 INFO - Reading from file tmpfile_stdout 11:36:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:23 INFO - Reading from file tmpfile_stdout 11:36:23 INFO - Output received: 11:36:23 INFO - Usage: mozinstall [options] installer 11:36:23 INFO - Options: 11:36:23 INFO - -h, --help show this help message and exit 11:36:23 INFO - -d DEST, --destination=DEST 11:36:23 INFO - Directory to install application into. [default: 11:36:23 INFO - "/builds/slave/test"] 11:36:23 INFO - --app=APP Application being installed. [default: firefox] 11:36:23 INFO - mkdir: /builds/slave/test/build/application 11:36:23 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'] 11:36:23 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 11:36:40 INFO - Reading from file tmpfile_stdout 11:36:40 INFO - Output received: 11:36:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:36:40 INFO - Running post-action listener: _resource_record_post_action 11:36:40 INFO - ##### 11:36:40 INFO - ##### Finished install step (success) 11:36:40 INFO - ##### 11:36:40 INFO - ##### 11:36:40 INFO - ##### Running run-tests step. 11:36:40 INFO - ##### 11:36:40 INFO - Running pre-action listener: _resource_record_pre_action 11:36:40 INFO - Running main action method: run_tests 11:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:40 INFO - Python 2.7.3 11:36:40 INFO - Return code: 0 11:36:40 INFO - grabbing minidump binary from tooltool 11:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:40 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 0x10be3b0>, '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 0x10bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:40 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 11:36:40 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 11:36:40 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 11:36:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:40 INFO - Return code: 0 11:36:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:36:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:36:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:36:40 INFO - Using env: {'DISPLAY': ':0', 11:36:40 INFO - 'HOME': '/home/cltbld', 11:36:40 INFO - 'LANG': 'en_US.UTF-8', 11:36:40 INFO - 'LANGUAGE': 'en_US:en', 11:36:40 INFO - 'LOGNAME': 'cltbld', 11:36:40 INFO - 'MAIL': '/var/mail/cltbld', 11:36:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:40 INFO - 'MOZ_NO_REMOTE': '1', 11:36:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:40 INFO - 'NO_EM_RESTART': '1', 11:36:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:40 INFO - 'PWD': '/builds/slave/test', 11:36:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:40 INFO - 'SHELL': '/bin/bash', 11:36:40 INFO - 'SHLVL': '1', 11:36:40 INFO - 'TERM': 'linux', 11:36:40 INFO - 'TMOUT': '86400', 11:36:40 INFO - 'USER': 'cltbld', 11:36:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515', 11:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:40 INFO - '_': '/tools/buildbot/bin/python'} 11:36:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:36:41 INFO - mozversion application_buildid: 20160713073201 11:36:41 INFO - mozversion application_changeset: dcb7835534e21a62cebdd5d1205d4e81f6bc6946 11:36:41 INFO - mozversion application_display_name: Nightly 11:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:41 INFO - mozversion application_name: Firefox 11:36:41 INFO - mozversion application_remotingname: firefox 11:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:36:41 INFO - mozversion application_vendor: Mozilla 11:36:41 INFO - mozversion application_version: 50.0a1 11:36:41 INFO - mozversion platform_buildid: 20160713073201 11:36:41 INFO - mozversion platform_changeset: dcb7835534e21a62cebdd5d1205d4e81f6bc6946 11:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:36:41 INFO - mozversion platform_version: 50.0a1 11:36:41 INFO - using testdate: 1468435001 11:36:41 INFO - actual date: 1468435001 11:36:41 INFO - starting webserver on 'localhost:38389' 11:36:41 INFO - SUITE-START | Running 2 tests 11:36:41 INFO - TEST-START | dromaeo_css 11:36:41 INFO - operating with platform_type : linux_ 11:36:41 INFO - Initialising browser for dromaeo_css test... 11:36:41 INFO - TEST-INFO | started process 10837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDeSKz/profile http://localhost:38389/getInfo.html) 11:36:45 INFO - PROCESS | 10837 | __metrics Screen width/height:1600/1200 11:36:45 INFO - PROCESS | 10837 | colorDepth:24 11:36:45 INFO - PROCESS | 10837 | Browser inner width/height: 1024/697 11:36:45 INFO - PROCESS | 10837 | __metrics 11:36:47 INFO - PROCESS | 10837 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:36:47 INFO - PROCESS | 10837 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:48 INFO - TEST-INFO | 10837: exit 0 11:36:48 INFO - Browser initialized. 11:36:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:36:48 INFO - TEST-INFO | started process 10919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDeSKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:59 INFO - PROCESS | 10919 | RSS: Main: 157872128 11:36:59 INFO - PROCESS | 10919 | 11:37:51 INFO - PROCESS | 10919 | 1468435071553 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] 11:39:59 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38389/tests/dromaeo/cssquery-ext.html) 11:40:00 INFO - PROCESS | 10919 | RSS: Main: 253587456 11:40:00 INFO - PROCESS | 10919 | 11:43:03 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-ext.html (next: http://localhost:38389/tests/dromaeo/cssquery-jquery.html) 11:43:04 INFO - PROCESS | 10919 | RSS: Main: 242061312 11:43:04 INFO - PROCESS | 10919 | 11:46:06 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38389/tests/dromaeo/cssquery-mootools.html) 11:46:06 INFO - PROCESS | 10919 | RSS: Main: 241238016 11:46:06 INFO - PROCESS | 10919 | 11:49:08 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38389/tests/dromaeo/cssquery-prototype.html) 11:49:09 INFO - PROCESS | 10919 | RSS: Main: 244592640 11:49:09 INFO - PROCESS | 10919 | 11:52:11 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38389/tests/dromaeo/cssquery-yui.html) 11:52:12 INFO - PROCESS | 10919 | RSS: Main: 221425664 11:52:12 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:38389/tests/dromaeo/cssquery-yui.html (next: http://localhost:38389/tests/dromaeo/cssquery-dojo.html) 11:55:15 INFO - PROCESS | 10919 | RSS: Main: 279556096 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | __start_tp_report 11:55:15 INFO - PROCESS | 10919 | _x_x_mozilla_page_load 11:55:15 INFO - PROCESS | 10919 | _x_x_mozilla_page_load_details 11:55:15 INFO - PROCESS | 10919 | |i|pagename|runs| 11:55:15 INFO - PROCESS | 10919 | |0;dojo.html;3055.9236019099535;3067.386522695461;3083.3833233353334;3102.270966322914;3102.8758849646015;5260.868478288045;5361.142217245241;5369.167778994257;5444.9183262251045;5468.535174510162;5333.786648534064;5342.1452567589195;5364.785408583652;5378.139497680362;5440.537554307889;4786.688865223767;4846.951530484703;4875.317455556207;4885.389326334208;5073.923891141636;4976.726280054596;4998.7250701211415;5035.370578677665;5058.2412638104215;5059.544640982311;4826.710397376169;4840.612750979931;4875.7074575525585;4886.63350248731;4914.631402644816;4832.323474713543;4878.682885612424;4884.169691152512;4924.581410580069;4981.053599816023;4894.657373983787;4901.534354236342;4911.140550403701;4915.2872833439305;4920.704757714549;5269.051570717269;5338.599605029638;5441.564674826004;5465.508104270635;5490.313710786152;5810.157527158538;5812.099124635688;5829.038208695561;5831.562632802515;5836.941630583725;5570.387257401682;5875.412458754133;5879.2944846618675;5879.441453061952;5893.5579831512805;5328.866778330573;5404.864878378033;5410.161424979135;5418.160185171305;5462.0441422751255;5999.310079340931;6003;6008.158857759917;6009.978303688296;6010.579259451796;5522.420145884705;5625.746841392147;5686.60193786431;5722.7424765885635;5735.913961290584;5777.046787280052;5861.443162899518;5868.383819698955;5880.970595147082;5884.970575147183;5753.395893431213;5776.855578610568;5788.363280039192;5792.1311803229855;5793.536517078624;5598.972005139948;5626.662400255997;5696.715164241771;5786.07422812348;5806.1581070744505;4372.038151606642;4376.081022985209;4378.956210437918;4410.713303635253;4412.514623391425;3895.0651843557343;3915.099527108724;3915.686745060388;3940.940885886714;3941.7437866538585;5300.867478313073;5395.595330350239;5399.271098401744;5434.673919564839;5447.073997420448;5790.334111577223;5793.188953546507;5796.449337312949;5811.738471768696;5837.620554663933;5451.972740136274;5453;5453.372862120827;5467.781288748485;5469.726513674301;4821.5178482151505;4967.627427942919;5027.497250274943;5029.170186919117;5030.195168773052;5924.14099955504;5937.10943358491;5942.316633587193;5946.435088666656;5951.880962380728;5771.624844385102;5788.450097240755;5799.101139323411;5806.709664516842;5813.04084825999;5666.121751128581;5848.2689663792025;5853.239078919713;5899.085641725539;5937.584369094122;5636.802711905064;5657.4059723728415;5660.20757093999;5699.601027928171;5710.114932185518;5667.149927510906;5783.19035335045;5796.913046304393;5808.73860676279;5834.15404766298;5568.16477528374;5633.915491267552;5637.267155269788;5650.660960342392;5658;5588.552915766648;5639.915401269066;5641.802536911188;5642.802501912413;5647.265855438766;5460.972695136499;5561.5272701820795;5571.832845014656;5578.721063946868;5586.86032849182;5700.857478562903;5721.685307308138;5758.596898217084;5795.623284486495;5805.825825225081;5571.9721401392735;5604.439556044363;5614.550835933034;5620.100783874561;5623.184638227516 11:55:15 INFO - PROCESS | 10919 | |1;ext.html;589.3811497927176;606.915031895535;624.7875722254432;634.7238951056291;646.6960528551582;33385.66614333856;43863.342049869236;44293.55706442935;44307.89230269249;44351.77824110875;46970.53029469704;47320.76339618306;47339.289910651365;47361;47397;8021.318187954031;8852.468851868893;8998.955005224965;9001.77495562613;10592.629257975972;10529.15766738663;10955.890441095607;10965.342079475256;10966.232363734502;10966.890331096707;11055.557777688922;11094.55621775128;11101.666949991513;11102.389368584725;11103.278286911365;10991.340519568812;11027.779444411148;11046.447677616086;11054.115670746321;11060;10766.084882784973;10815.080718138968;10826.079783218436;10830.350178989285;10830.891691083067;45567.31649025267;45973.54026459759;45998.77000615009;46015;46024.539754602694;3360.2775403288165;3383.780054296463;3506.1234691327168;3606.206634540397;4041.2927737646087;33964.49053264203;34247.31505369879;34845;34886;34945.47581786275;4512.616427603658;4545.2954792007295;4556.612687921531;4644.256918892995;4763.095011947754;406321;407457.96271018754;408424;408476;409541;31686.841565792023;63265.36734632687;63304.68347658325;63569.682151588946;63656.862303950096;37416.62583374186;37467.253274672315;37500.81249593789;37614.43578346327;37677.43483847744;15690.764638530203;15729.764053539206;15816.446424375092;15819.446319378767;15837.604059898595;11920.344381058952;12937.870621293667;13122.868771312356;13159.60521184366;13305.600831975056;8279.668813247403;8288.046874609376;8288.21261980111;8368.497890126611;8389.203025712548;2993.3115383461927;3175.17445464181;3204.070819462376;3205.5512228288057;3226.7418606511424;951.9714408567615;960.4573416019927;1006.5973610555836;1058.333250052462;1112.0522146380317;31781.882391671817;32954;33296.833515832266;33307.333853322794;33371.83314083414;1055.472263868066;1086.1528008153653;1124.2074337591978;1133.665568657248;1158.8261760735957;16452.917735411247;16903.23935422909;17067.914660426868;17092.2308496118;17275.481735547703;571424;576637;577555;580828;580894;62025.689871550356;62368.06447903285;62495.375046249865;62509;62528;1204.2172587817988;1325.6619562011626;1353.1948490648049;1380.2132784312846;1389.7637401641948;33295.33409331751;34419;34451.310973780885;34468.310633786685;34778.478322825686;53539.19691204557;53653.39039828812;54328.72835635955;54387.45612543824;54482.72758636181;438643;441309;441751;441904;442637;25083;27361.726382735917;28387.71612283851;28505.857470712515;29910.850445747634;50045.249321259485;50550.241746373096;51127.74436127795;51983.48016519786;52044.47955520548;43024.78487607667;43202.78398607987;43433.565664342954;43504;44754.3286850704;42992.570074298856;43083.05515420308;43185.78407107944;43333;43358.78320608377;41539;42656.78671606622;42751.3587296197;43094.78452607842;43277.56722432861;35639.64360356363;37899.62100378961;37911.43132853065;38176.2766063762;38633.80683096567;28342.433151336445;28805.27986800347;28831.42337153287;28865.278368040126;29176.416471670873 11:55:15 INFO - PROCESS | 10919 | |2;jquery.html;369.59529315399647;373.70664028737446;374.5916950523928;386.27380524613756;389.1011762827868;18816.247350105998;19381.515462113435;20167;20323.898380508075;20341.288054918063;11688.7662246755;11913.106517011238;11925.940370298158;11936.880631193686;12737.745245095093;5231.712255825938;5374.408815030343;5412.539934105586;5415.10650742627;5419.295491586108;3963.1479231965122;5860.73626686798;6093.603915745484;6104.175936248616;6210.378962103799;6066.998945174063;6149.108379285001;6223.284322302925;6231.408016238473;6558.1802274715665;6584.341565843401;6618.172728408949;6636.070950066995;6653.234877989044;6671.199456065255;3794.3359912015285;5429.886873190986;5667.234923285345;5677.716114194273;5715.199872017879;14127.576172714835;14207.644808879757;14279;14321.498747543787;14537;2190.397640648818;2270.2281224383623;2326.3835083702834;2390.9760902390926;2458.5697502936914;10478.423686697228;10489.527971241312;10502.78994420115;10846.457677116192;11024;1929.0740444586677;2018;2021.4946263434142;2052.7741948385665;2096.7483901931864;84939.57530212309;85000.57499712461;85454.14545854524;87221;88138.5593072037;10347.948260258801;10436;10443.530041148166;10770.599822023087;10849.457527123612;14231.359588818528;14301.713965720628;14306.928465357814;14312.713745725026;14369;7534.962325188339;7758.922410775933;7787.260210280015;7803.648835802403;7834.647440865175;7496.587687677121;7506.737264195727;7662.846743065219;7666.310032097026;7708.922910770821;4322.243607368698;4396.076823867023;4402.405675233803;4514.45826500822;4516.751578663205;1660.800703915538;1802.8107048759953;1817.0620550340984;1844.62185252023;1915.358354951079;888.7244954064261;971.4414211828085;984.4929861121528;1033.679559336608;1043.6190790361616;18747.812521874606;19543.218271269274;19656.508587285432;19725.40823775289;19971.60056798856;974.9805003899883;990.7275499237767;996.1582462819051;1012.4026824173773;1017.165923942375;10656.147508199325;10965.451727413598;11839.704007399712;11964.521419143312;11980.940095299642;558894;583141;589433;595670;598909;97537.51231243799;97973;103157.48421257846;103677.48161259145;104807.4759626197;460.69363873024065;472.36466951949575;475.25859658931483;476.5925134010441;476.9475357710649;10906.890931090587;11429.828552571551;11588.594399195988;11789.292642441482;11961.940190298992;40895.795521022206;43080.78459607682;43122.353164703185;43230.783846080565;44039.55960440483;59069.40930590811;60120.699396502736;61403.385966139766;61521.692391537756;62200;8336.916630833613;8407.579621019047;8480.406371553932;8739.737807865775;8744.912550874664;8450.450720703135;10409.271351005356;12607.306598137191;12791.168574042658;13345.266010369523;11018.724531886766;11126.221164518729;11527.884721153017;11596.76806463849;12009.099317551394;11089.112870970464;11309.660710178709;11438.94280528592;11692.766144676889;11721.531138754355;11391.316521008766;11843.703907402383;11894.643160705193;12045;12126.33305168189;8293.917060829315;8545.529995850287;8718.302535796995;8919.509426981578;8931.106889311017;10306.227032972407;11325.603603874155;11709.88290117122;11790.587329443428;11807.645770626896 11:55:15 INFO - PROCESS | 10919 | |3;mootools.html;1321.1412581821808;1393.5679939218842;1504.6614511734858;1637.6315329050965;1801.9909900450505;8217.6302066407;8529.189726975936;8560.914390856098;8637.52493612851;8723.47659140452;8462.23839854413;8655.567221638925;8657.350698697592;8659.69691060813;8662.783430414243;1913.1199648161862;1966.2331690640663;2170.2295685031822;2183.1376606240565;2204.2836078274627;2219.223271854854;2230.1413955627118;2232.1406258590396;2234.6089434349005;2238.8992495337748;2221.544583360407;2229.8104661103825;2246.3036458697775;2249.0329158461855;2249.3701763506247;1863.9906800465978;2110.5462325599915;2121.9045142968525;2169.7721739217313;2170.066871245364;2202.449387653087;2218.3566765637947;2224.065892325227;2224.944376390587;2226.7105276313973;8773.034966153718;8811.206991370807;8811.691590794355;8816.8677469838;8816.911830881672;5035.395752509686;5145.76844042019;5152.716600586966;5158.7420628968775;5162.3030890830005;3283.7208837248622;3357.3285342931513;3473.6352682968177;3489.8080605566684;3498.4227602445567;1066.8797762349502;1077.4181941751444;1086.6685660873432;1090.9345439273668;1091.0562363555546;12702.618921432371;12786;12815.935920320338;12817.679558011125;12830.230186188859;4464.732116073046;4541;4694.577488026026;4711.646626503026;4719.83480578185;10731.946340268249;10747.731306717395;10761.730956726144;10765.407902565277;10770.353778773298;5288.153895376799;5308.177232528964;5347.438518955531;5347.491988261109;5366.409694933554;4215.620594146541;4691.39011928454;4845.927311090337;4853.6602437829715;4929.580985616191;3866.903327416837;3927.92144157121;3983.8605648802154;4029.8388064477094;4047.392891066305;1142.4915912418894;1228.4656174564093;1230.833837431953;1232.679503329123;1274.4965738533228;925.8981512033671;934.3179478980246;939.2110627073155;945.4658118163215;985.0395864032654;5904.439078287556;6032.728527216286;6061.696915154224;6226.813195604049;6361.077643741632;978.4814048554277;986.5708416838698;987.456898705709;992.5434300221979;997.4613708597276;4006.2988976929505;4036.5761595032686;4074.714769966074;4086.713930024929;4103.097318589906;10591.311564748266;10942.507587158598;11008.834867476995;11011.559537618567;11036.172287078502;10872.836907446395;10897.67306980792;10901.291416057931;10903.29128606638;10911.563537458413;7828.765137045898;7994.64024118916;8084.22147127631;8123.715669951642;8129.634166462523;6061.818145455643;6220;6236.844078898064;6370.522210834299;6393.7122829471855;10288.2798204125;10386.169106471616;10604.575816967235;10641.574337026743;10644.467776611293;10489.52797124116;10701.518431670438;10703.197260205672;10918.12654987615;10928.726781830517;8245.350929814182;8259.545724985184;8298.253157215879;8419.579021049045;8427.662893484438;8914.598843052208;8922.420042697204;8923;8960.820783584422;8974.551272436222;7797.7660670179985;7931.246531579491;8051.8792218115605;8102;8109.878351824609;7527.172011078667;7637.312641862259;7674.731384401743;7800.414968877243;8037.638306276114;7368.889466657897;7420.925790742023;7452.403807695479;7502.812429689301;7514.661840217313;5278.97360513195;5332.06688829461;5348.251244825806;5472.890542189054;5481.698506582176;4987.700737955734;5016.573591244785;5037.118504261666;5146.25379320004;5179.404368497671 11:55:15 INFO - PROCESS | 10919 | |4;prototype.html;315.46056243823074;317.189580621512;321.3091852517088;322.63542197317037;323.09855503146224;5358.544523715484;5384.919226211605;5400.189971504272;5406.783728650849;5452.454754524546;5338.813141540047;5354.544863686581;5375.139977603584;5393.379761327448;5422.267993820833;4021.658159056484;4038.2125485530332;4221.514525829522;4228.175505776375;4262.680298977573;4185.2048110859;4204.66362690984;4214.136102099078;4215.515215750182;4245.150969806051;3993.9201215975663;4160.812763425638;4174.916501669964;4209.726367786099;4218.894527636819;3993;3998.1371752442433;4109.712320137576;4200.1179752251755;4201.327787553977;3646.2707458508403;3652.7990960497164;3675.117971686803;3680.4479328100733;3684.5578530576236;5178.948210517884;5187.636865419422;5210.114280572274;5247.47525247476;5249;4519.1245633062235;4742.193827049376;4751.809927602892;4752.215884379073;4793.44875339337;5600.663960162403;5606.383297837235;5618.101103823368;5638.351589567212;5660.971695141539;3988.4615576897327;3990.8004599769897;3993.820278087493;4002.8198731057173;4009.1781184857036;5635.506590753454;5814.924239015753;5822.912656310159;5829.979753543113;5836.074095548502;4034.6973976951845;4045.110075783323;4056.9391459128137;4085.6935729820384;4091.3862920562156;4127.9587204128175;4133.565975572582;4140.730852494578;4146.3158578834755;4149.232392007489;4544.523234837022;4754.049190161982;4755.9286610700865;4766.118268120409;4771;5609.709766753669;5620.775168993277;5632.887342253132;5646.6612003279115;5716.1997320375185;1420.1550077703955;1420.94849811139;1425.180521200314;1425.664968732347;1438.1155589312498;905.5019739143445;909.2862103248918;913.954302284883;916.3997581584073;929.8093890752515;5345.599080069011;5475.425080366584;5483.75323110461;5490.615656904059;5496.917546236809;5805.303363596396;5810;5815.331236907809;5840.912386314209;5874.236349274567;5195.246689230041;5450.809221677222;5461.525388145178;5475.233467314579;5484.177373394023;3058.388322335542;3079.476488996876;3100.906887850692;3104.798188117765;3113.2061324362594;5825.50483208932;5966.433188847052;5978.8206353809455;6009.969950150221;6011.759529618854;5967.433093856077;5973.761049557969;5977.760889564455;5983.025601551478;5994.610350327215;5876.296903424387;5978.070745334841;5986.191864098291;6029.065494848393;6053.515718742402;5510.228568000403;5824.737886795019;5836.182934389104;5844.590878638624;5852.970735146297;5767.68277744728;5786.85532861665;5790.884182316246;5805.477507024388;5808.970955145197;5823.505002074701;5993.730282137227;6051.969740151271;6076.787312444043;6085.2393450818645;4093.7543747375253;4107.240160570304;4123.752574845519;4127.8854709228945;4154.4183814265425;5908.852278692895;5932.851678708067;5943.465088142088;5953.553483488669;5957.374475680164;5436.565074794086;5702.914456283076;5747;5786;5792.913106303325;5644.6613203207935;5661.179129026185;5671.914921276101;5677.914831277451;5685.51673107774;5379.193121031876;5584.664920104807;5612.522935550361;5675.404082571271;5678.488935995615;5457.20870473787;5712.514436272963;5715.657060576379;5722.914156287742;5729.4843464088435;5594.776208951596;5601.663900166003;5607.971960140173;5679.77280908759;5698.401667824819 11:55:15 INFO - PROCESS | 10919 | |5;yui.html;772.582805285146;799.1888233443054;800.0759123212688;820.585604269844;859.8968123825142;15390.923045384772;16050.59873503163;16072.839271607281;16372.345106195768;16524.83475165248;16105.436309729163;16188.595285117877;16214.51356459308;16268;16434.260458279376;658.4699317049773;793.0602236349915;799.8200404908893;820.8891799607067;831.580052073702;812.0701796443069;816.4692949582759;816.9264766171043;817.239966830847;817.6851912013858;838.6603425612606;839.2111415269627;839.6473481137937;839.8740188971673;839.8992120945495;692.3146085375492;834.1616675241344;837.4431003382743;867.7179916527091;869.5565261716507;615.8460384903774;622.0451606783611;622.8660837919869;623.7785586116954;623.9313675495691;14008.509702160376;14035.228062456561;14048.648783780385;14150.716985660332;14209.00536962413;15105.39578416862;15454.150021748912;15480.380784768597;15695.372185112581;15697.529074127795;12139.393030348536;12303.384830758427;12596.81104783429;13152.21086734799;13672.726545469135;3857.1128640412862;3910.2179564087014;3922.8430862765454;3965.6827453803917;4084.81618327173;81670.59164704198;82174;83067.5846620769;84271.15728842694;84971.15028849694;11710.590129345603;11996.940015299868;12123.939380303218;12483.625491235278;12502.874971250352;23704.525909482058;23760.643590346157;23762.405939851644;23793.52412951731;23795.40511487227;8462.323014158852;8641.222289993804;8791.07693692166;8834.293256539462;8880.51157186348;4697.459792123881;4751.144793937125;4794.976025119852;4976;5221.530062294411;3310.6192787829227;3401.965980340165;3409.062507810372;3411.3688967541084;3411.573553305837;604.9546284028715;607.3713706314032;622.9221347331584;632.0550776589029;637.9457746091541;678.8133263352618;684.6576711644178;749.6514120933792;766.7592008621026;774.4578794843632;8817.515036673045;9853.118132004807;10008.549615267331;10008.79982400348;10102.393856368495;595.4016213705285;686.5983399711225;702.5714314268292;774.8024253815241;775.7750252426733;4626.583607475276;4714.316424118484;4886.267059941038;5118.232265160255;5120.564751996048;111373.44313278382;111876;112130.43934780436;112909;113978.43010784894;62104.689476552325;87562;97638;99115;99426.50286748665;89430.55284723535;90495.84508272429;93732;93753.5312323434;95902.5204873985;8773.166549177819;8913.449687909775;9025.593848276974;9039.68361107358;9043.638254469748;51447.48552514577;52603.47396525986;52848.09335486585;53835.19247211217;55616.72191639016;55984.72007639936;72187;74307.2569274322;76643;76932;11391.145664075062;11726.355050472306;12337.198082124632;12620;13243.404046817725;13091.758624117781;13354.666133346744;13354.866451335361;13590.524331648345;13624.591262262147;14073.718525629634;14312.355943982753;14335.56993290203;14460.421583136556;14504.782428263796;14321;14453.277336132942;14720.631984200481;14899.404023838924;15339.463118791235;13627.566391987402;14112.153270803785;14195.351427690517;14395.784063239269;14460.778245951187;11029.172812038969;11041.558337666725;11117.166212534254;11573.537058517564;12058.216215945935;11488.827667584826;11510.194286399872;11735.47190376418;11787.41062946832;12138.817917731065 11:55:15 INFO - PROCESS | 10919 | __end_tp_report 11:55:15 INFO - PROCESS | 10919 | __start_cc_report 11:55:15 INFO - PROCESS | 10919 | _x_x_mozilla_cycle_collect,873 11:55:15 INFO - PROCESS | 10919 | __end_cc_report 11:55:15 INFO - PROCESS | 10919 | __startTimestamp1468436115768__endTimestamp 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | ------- Summary: start ------- 11:55:15 INFO - PROCESS | 10919 | Number of tests: 6 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#0] dojo.html Cycles:165 Average:5364.77 Median:5578.72 stddev:618.28 (11.1%) stddev-sans-first:593.05 11:55:15 INFO - PROCESS | 10919 | Values: 3055.9 3067.4 3083.4 3102.3 3102.9 5260.9 5361.1 5369.2 5444.9 5468.5 5333.8 5342.1 5364.8 5378.1 5440.5 4786.7 4847.0 4875.3 4885.4 5073.9 4976.7 4998.7 5035.4 5058.2 5059.5 4826.7 4840.6 4875.7 4886.6 4914.6 4832.3 4878.7 4884.2 4924.6 4981.1 4894.7 4901.5 4911.1 4915.3 4920.7 5269.1 5338.6 5441.6 5465.5 5490.3 5810.2 5812.1 5829.0 5831.6 5836.9 5570.4 5875.4 5879.3 5879.4 5893.6 5328.9 5404.9 5410.2 5418.2 5462.0 5999.3 6003.0 6008.2 6010.0 6010.6 5522.4 5625.7 5686.6 5722.7 5735.9 5777.0 5861.4 5868.4 5881.0 5885.0 5753.4 5776.9 5788.4 5792.1 5793.5 5599.0 5626.7 5696.7 5786.1 5806.2 4372.0 4376.1 4379.0 4410.7 4412.5 3895.1 3915.1 3915.7 3940.9 3941.7 5300.9 5395.6 5399.3 5434.7 5447.1 5790.3 5793.2 5796.4 5811.7 5837.6 5452.0 5453.0 5453.4 5467.8 5469.7 4821.5 4967.6 5027.5 5029.2 5030.2 5924.1 5937.1 5942.3 5946.4 5951.9 5771.6 5788.5 5799.1 5806.7 5813.0 5666.1 5848.3 5853.2 5899.1 5937.6 5636.8 5657.4 5660.2 5699.6 5710.1 5667.1 5783.2 5796.9 5808.7 5834.2 5568.2 5633.9 5637.3 5650.7 5658.0 5588.6 5639.9 5641.8 5642.8 5647.3 5461.0 5561.5 5571.8 5578.7 5586.9 5700.9 5721.7 5758.6 5795.6 5805.8 5572.0 5604.4 5614.6 5620.1 5623.2 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#1] ext.html Cycles:180 Average:63113.14 Median:37788.53 stddev:127845.71 (338.3%) stddev-sans-first:128118.17 11:55:15 INFO - PROCESS | 10919 | Values: 589.4 606.9 624.8 634.7 646.7 33385.7 43863.3 44293.6 44307.9 44351.8 46970.5 47320.8 47339.3 47361.0 47397.0 8021.3 8852.5 8999.0 9001.8 10592.6 10529.2 10955.9 10965.3 10966.2 10966.9 11055.6 11094.6 11101.7 11102.4 11103.3 10991.3 11027.8 11046.4 11054.1 11060.0 10766.1 10815.1 10826.1 10830.4 10830.9 45567.3 45973.5 45998.8 46015.0 46024.5 3360.3 3383.8 3506.1 3606.2 4041.3 33964.5 34247.3 34845.0 34886.0 34945.5 4512.6 4545.3 4556.6 4644.3 4763.1 406321.0 407458.0 408424.0 408476.0 409541.0 31686.8 63265.4 63304.7 63569.7 63656.9 37416.6 37467.3 37500.8 37614.4 37677.4 15690.8 15729.8 15816.4 15819.4 15837.6 11920.3 12937.9 13122.9 13159.6 13305.6 8279.7 8288.0 8288.2 8368.5 8389.2 2993.3 3175.2 3204.1 3205.6 3226.7 952.0 960.5 1006.6 1058.3 1112.1 31781.9 32954.0 33296.8 33307.3 33371.8 1055.5 1086.2 1124.2 1133.7 1158.8 16452.9 16903.2 17067.9 17092.2 17275.5 571424.0 576637.0 577555.0 580828.0 580894.0 62025.7 62368.1 62495.4 62509.0 62528.0 1204.2 1325.7 1353.2 1380.2 1389.8 33295.3 34419.0 34451.3 34468.3 34778.5 53539.2 53653.4 54328.7 54387.5 54482.7 438643.0 441309.0 441751.0 441904.0 442637.0 25083.0 27361.7 28387.7 28505.9 29910.9 50045.2 50550.2 51127.7 51983.5 52044.5 43024.8 43202.8 43433.6 43504.0 44754.3 42992.6 43083.1 43185.8 43333.0 43358.8 41539.0 42656.8 42751.4 43094.8 43277.6 35639.6 37899.6 37911.4 38176.3 38633.8 28342.4 28805.3 28831.4 28865.3 29176.4 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#2] jquery.html Cycles:180 Average:31488.40 Median:1414.08 stddev:96475.01 (6822.4%) stddev-sans-first:96717.35 11:55:15 INFO - PROCESS | 10919 | Values: 369.6 373.7 374.6 386.3 389.1 18816.2 19381.5 20167.0 20323.9 20341.3 11688.8 11913.1 11925.9 11936.9 12737.7 5231.7 5374.4 5412.5 5415.1 5419.3 3963.1 5860.7 6093.6 6104.2 6210.4 6067.0 6149.1 6223.3 6231.4 6558.2 6584.3 6618.2 6636.1 6653.2 6671.2 3794.3 5429.9 5667.2 5677.7 5715.2 14127.6 14207.6 14279.0 14321.5 14537.0 2190.4 2270.2 2326.4 2391.0 2458.6 10478.4 10489.5 10502.8 10846.5 11024.0 1929.1 2018.0 2021.5 2052.8 2096.7 84939.6 85000.6 85454.1 87221.0 88138.6 10347.9 10436.0 10443.5 10770.6 10849.5 14231.4 14301.7 14306.9 14312.7 14369.0 7535.0 7758.9 7787.3 7803.6 7834.6 7496.6 7506.7 7662.8 7666.3 7708.9 4322.2 4396.1 4402.4 4514.5 4516.8 1660.8 1802.8 1817.1 1844.6 1915.4 888.7 971.4 984.5 1033.7 1043.6 18747.8 19543.2 19656.5 19725.4 19971.6 975.0 990.7 996.2 1012.4 1017.2 10656.1 10965.5 11839.7 11964.5 11980.9 558894.0 583141.0 589433.0 595670.0 598909.0 97537.5 97973.0 103157.5 103677.5 104807.5 460.7 472.4 475.3 476.6 476.9 10906.9 11429.8 11588.6 11789.3 11961.9 40895.8 43080.8 43122.4 43230.8 44039.6 59069.4 60120.7 61403.4 61521.7 62200.0 8336.9 8407.6 8480.4 8739.7 8744.9 8450.5 10409.3 12607.3 12791.2 13345.3 11018.7 11126.2 11527.9 11596.8 12009.1 11089.1 11309.7 11438.9 11692.8 11721.5 11391.3 11843.7 11894.6 12045.0 12126.3 8293.9 8545.5 8718.3 8919.5 8931.1 10306.2 11325.6 11709.9 11790.6 11807.6 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#3] mootools.html Cycles:180 Average:5882.87 Median:4715.74 stddev:3423.84 (72.6%) stddev-sans-first:3416.28 11:55:15 INFO - PROCESS | 10919 | Values: 1321.1 1393.6 1504.7 1637.6 1802.0 8217.6 8529.2 8560.9 8637.5 8723.5 8462.2 8655.6 8657.4 8659.7 8662.8 1913.1 1966.2 2170.2 2183.1 2204.3 2219.2 2230.1 2232.1 2234.6 2238.9 2221.5 2229.8 2246.3 2249.0 2249.4 1864.0 2110.5 2121.9 2169.8 2170.1 2202.4 2218.4 2224.1 2224.9 2226.7 8773.0 8811.2 8811.7 8816.9 8816.9 5035.4 5145.8 5152.7 5158.7 5162.3 3283.7 3357.3 3473.6 3489.8 3498.4 1066.9 1077.4 1086.7 1090.9 1091.1 12702.6 12786.0 12815.9 12817.7 12830.2 4464.7 4541.0 4694.6 4711.6 4719.8 10731.9 10747.7 10761.7 10765.4 10770.4 5288.2 5308.2 5347.4 5347.5 5366.4 4215.6 4691.4 4845.9 4853.7 4929.6 3866.9 3927.9 3983.9 4029.8 4047.4 1142.5 1228.5 1230.8 1232.7 1274.5 925.9 934.3 939.2 945.5 985.0 5904.4 6032.7 6061.7 6226.8 6361.1 978.5 986.6 987.5 992.5 997.5 4006.3 4036.6 4074.7 4086.7 4103.1 10591.3 10942.5 11008.8 11011.6 11036.2 10872.8 10897.7 10901.3 10903.3 10911.6 7828.8 7994.6 8084.2 8123.7 8129.6 6061.8 6220.0 6236.8 6370.5 6393.7 10288.3 10386.2 10604.6 10641.6 10644.5 10489.5 10701.5 10703.2 10918.1 10928.7 8245.4 8259.5 8298.3 8419.6 8427.7 8914.6 8922.4 8923.0 8960.8 8974.6 7797.8 7931.2 8051.9 8102.0 8109.9 7527.2 7637.3 7674.7 7800.4 8037.6 7368.9 7420.9 7452.4 7502.8 7514.7 5279.0 5332.1 5348.3 5472.9 5481.7 4987.7 5016.6 5037.1 5146.3 5179.4 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#4] prototype.html Cycles:180 Average:4756.29 Median:5459.37 stddev:1419.63 (26.0%) stddev-sans-first:1383.93 11:55:15 INFO - PROCESS | 10919 | Values: 315.5 317.2 321.3 322.6 323.1 5358.5 5384.9 5400.2 5406.8 5452.5 5338.8 5354.5 5375.1 5393.4 5422.3 4021.7 4038.2 4221.5 4228.2 4262.7 4185.2 4204.7 4214.1 4215.5 4245.2 3993.9 4160.8 4174.9 4209.7 4218.9 3993.0 3998.1 4109.7 4200.1 4201.3 3646.3 3652.8 3675.1 3680.4 3684.6 5178.9 5187.6 5210.1 5247.5 5249.0 4519.1 4742.2 4751.8 4752.2 4793.4 5600.7 5606.4 5618.1 5638.4 5661.0 3988.5 3990.8 3993.8 4002.8 4009.2 5635.5 5814.9 5822.9 5830.0 5836.1 4034.7 4045.1 4056.9 4085.7 4091.4 4128.0 4133.6 4140.7 4146.3 4149.2 4544.5 4754.0 4755.9 4766.1 4771.0 5609.7 5620.8 5632.9 5646.7 5716.2 1420.2 1420.9 1425.2 1425.7 1438.1 905.5 909.3 914.0 916.4 929.8 5345.6 5475.4 5483.8 5490.6 5496.9 5805.3 5810.0 5815.3 5840.9 5874.2 5195.2 5450.8 5461.5 5475.2 5484.2 3058.4 3079.5 3100.9 3104.8 3113.2 5825.5 5966.4 5978.8 6010.0 6011.8 5967.4 5973.8 5977.8 5983.0 5994.6 5876.3 5978.1 5986.2 6029.1 6053.5 5510.2 5824.7 5836.2 5844.6 5853.0 5767.7 5786.9 5790.9 5805.5 5809.0 5823.5 5993.7 6052.0 6076.8 6085.2 4093.8 4107.2 4123.8 4127.9 4154.4 5908.9 5932.9 5943.5 5953.6 5957.4 5436.6 5702.9 5747.0 5786.0 5792.9 5644.7 5661.2 5671.9 5677.9 5685.5 5379.2 5584.7 5612.5 5675.4 5678.5 5457.2 5712.5 5715.7 5722.9 5729.5 5594.8 5601.7 5608.0 5679.8 5698.4 11:55:15 INFO - PROCESS | 10919 | 11:55:15 INFO - PROCESS | 10919 | [#5] yui.html Cycles:180 Average:20997.48 Median:4732.73 stddev:29808.83 (629.8%) stddev-sans-first:29853.77 11:55:15 INFO - PROCESS | 10919 | Values: 772.6 799.2 800.1 820.6 859.9 15390.9 16050.6 16072.8 16372.3 16524.8 16105.4 16188.6 16214.5 16268.0 16434.3 658.5 793.1 799.8 820.9 831.6 812.1 816.5 816.9 817.2 817.7 838.7 839.2 839.6 839.9 839.9 692.3 834.2 837.4 867.7 869.6 615.8 622.0 622.9 623.8 623.9 14008.5 14035.2 14048.6 14150.7 14209.0 15105.4 15454.2 15480.4 15695.4 15697.5 12139.4 12303.4 12596.8 13152.2 13672.7 3857.1 3910.2 3922.8 3965.7 4084.8 81670.6 82174.0 83067.6 84271.2 84971.2 11710.6 11996.9 12123.9 12483.6 12502.9 23704.5 23760.6 23762.4 23793.5 23795.4 8462.3 8641.2 8791.1 8834.3 8880.5 4697.5 4751.1 4795.0 4976.0 5221.5 3310.6 3402.0 3409.1 3411.4 3411.6 605.0 607.4 622.9 632.1 637.9 678.8 684.7 749.7 766.8 774.5 8817.5 9853.1 10008.5 10008.8 10102.4 595.4 686.6 702.6 774.8 775.8 4626.6 4714.3 4886.3 5118.2 5120.6 111373.4 111876.0 112130.4 112909.0 113978.4 62104.7 87562.0 97638.0 99115.0 99426.5 89430.6 90495.8 93732.0 93753.5 95902.5 8773.2 8913.4 9025.6 9039.7 9043.6 51447.5 52603.5 52848.1 53835.2 55616.7 55984.7 72187.0 74307.3 76643.0 76932.0 11391.1 11726.4 12337.2 12620.0 13243.4 13091.8 13354.7 13354.9 13590.5 13624.6 14073.7 14312.4 14335.6 14460.4 14504.8 14321.0 14453.3 14720.6 14899.4 15339.5 13627.6 14112.2 14195.4 14395.8 14460.8 11029.2 11041.6 11117.2 11573.5 12058.2 11488.8 11510.2 11735.5 11787.4 12138.8 11:55:15 INFO - PROCESS | 10919 | -------- Summary: end -------- 11:55:15 INFO - PROCESS | 10919 | 11:55:16 INFO - TEST-INFO | 10919: exit 0 11:55:16 INFO - TEST-OK | dromaeo_css | took 1115671ms 11:55:16 INFO - TEST-START | kraken 11:55:16 INFO - operating with platform_type : linux_ 11:55:16 INFO - Initialising browser for kraken test... 11:55:16 INFO - TEST-INFO | started process 11106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKGqTD/profile http://localhost:38389/getInfo.html) 11:55:21 INFO - PROCESS | 11106 | __metrics Screen width/height:1600/1200 11:55:21 INFO - PROCESS | 11106 | colorDepth:24 11:55:21 INFO - PROCESS | 11106 | Browser inner width/height: 1024/697 11:55:21 INFO - PROCESS | 11106 | __metrics 11:55:22 INFO - PROCESS | 11106 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:55:22 INFO - PROCESS | 11106 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:23 INFO - PROCESS | 11106 | console.error: PushService: 11:55:23 INFO - PROCESS | 11106 | stateChangeProcessEnqueue: Error transitioning state 11:55:23 INFO - PROCESS | 11106 | UnknownError 11:55:23 INFO - TEST-INFO | 11106: exit 0 11:55:23 INFO - Browser initialized. 11:55:23 INFO - Running cycle 1/1 for kraken test... 11:55:23 INFO - TEST-INFO | started process 11191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKGqTD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:35 INFO - PROCESS | 11191 | RSS: Main: 157618176 11:55:35 INFO - PROCESS | 11191 | 11:55:37 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38389/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:38 INFO - PROCESS | 11191 | RSS: Main: 216416256 11:55:38 INFO - PROCESS | 11191 | 11:55:41 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38389/tests/kraken/driver.html?testName=audio-dft) 11:55:41 INFO - PROCESS | 11191 | RSS: Main: 203829248 11:55:41 INFO - PROCESS | 11191 | 11:55:45 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38389/tests/kraken/driver.html?testName=audio-fft) 11:55:45 INFO - PROCESS | 11191 | RSS: Main: 269692928 11:55:45 INFO - PROCESS | 11191 | 11:55:47 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38389/tests/kraken/driver.html?testName=audio-oscillator) 11:55:48 INFO - PROCESS | 11191 | RSS: Main: 181112832 11:55:48 INFO - PROCESS | 11191 | 11:55:50 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:51 INFO - PROCESS | 11191 | RSS: Main: 185724928 11:55:51 INFO - PROCESS | 11191 | 11:55:53 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38389/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:54 INFO - PROCESS | 11191 | RSS: Main: 219664384 11:55:54 INFO - PROCESS | 11191 | 11:55:57 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38389/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:58 INFO - PROCESS | 11191 | RSS: Main: 221855744 11:55:58 INFO - PROCESS | 11191 | 11:56:01 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38389/tests/kraken/driver.html?testName=json-parse-financial) 11:56:01 INFO - PROCESS | 11191 | RSS: Main: 221716480 11:56:01 INFO - PROCESS | 11191 | 11:56:03 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:56:04 INFO - PROCESS | 11191 | RSS: Main: 209567744 11:56:04 INFO - PROCESS | 11191 | 11:56:05 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:06 INFO - PROCESS | 11191 | RSS: Main: 213557248 11:56:06 INFO - PROCESS | 11191 | 11:56:08 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:09 INFO - PROCESS | 11191 | RSS: Main: 211992576 11:56:09 INFO - PROCESS | 11191 | 11:56:11 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:12 INFO - PROCESS | 11191 | RSS: Main: 224030720 11:56:12 INFO - PROCESS | 11191 | 11:56:14 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:15 INFO - PROCESS | 11191 | RSS: Main: 224522240 11:56:15 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | Cycle 1(1): loaded http://localhost:38389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38389/tests/kraken/driver.html?testName=ai-astar) 11:56:17 INFO - PROCESS | 11191 | RSS: Main: 267005952 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | __start_tp_report 11:56:17 INFO - PROCESS | 11191 | _x_x_mozilla_page_load 11:56:17 INFO - PROCESS | 11191 | _x_x_mozilla_page_load_details 11:56:17 INFO - PROCESS | 11191 | |i|pagename|runs| 11:56:17 INFO - PROCESS | 11191 | |0;ai-astar;102;112;110;113;112;110;112;110;109;109 11:56:17 INFO - PROCESS | 11191 | |1;audio-beat-detection;141;120;118;167;115;119;143;121;146;116 11:56:17 INFO - PROCESS | 11191 | |2;audio-dft;160;159;160;161;159;163;161;160;161;162 11:56:17 INFO - PROCESS | 11191 | |3;audio-fft;75;73;75;102;75;76;73;74;97;75 11:56:17 INFO - PROCESS | 11191 | |4;audio-oscillator;83;83;117;83;83;83;115;84;84;130 11:56:17 INFO - PROCESS | 11191 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;117;116 11:56:17 INFO - PROCESS | 11191 | |6;imaging-darkroom;145;147;145;146;145;146;145;146;147;147 11:56:17 INFO - PROCESS | 11191 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;94 11:56:17 INFO - PROCESS | 11191 | |8;json-parse-financial;55;51;54;51;53;52;52;51;50;52 11:56:17 INFO - PROCESS | 11191 | |9;json-stringify-tinderbox;63;64;62;61;62;62;62;62;63;63 11:56:17 INFO - PROCESS | 11191 | |10;stanford-crypto-aes;76;81;75;74;76;74;77;83;75;84 11:56:17 INFO - PROCESS | 11191 | |11;stanford-crypto-ccm;119;122;117;120;120;119;122;117;159;122 11:56:17 INFO - PROCESS | 11191 | |12;stanford-crypto-pbkdf2;159;159;158;157;155;158;159;158;157;155 11:56:17 INFO - PROCESS | 11191 | |13;stanford-crypto-sha256-iterative;63;62;64;64;62;63;65;63;62;63 11:56:17 INFO - PROCESS | 11191 | __end_tp_report 11:56:17 INFO - PROCESS | 11191 | __start_cc_report 11:56:17 INFO - PROCESS | 11191 | _x_x_mozilla_cycle_collect,1647 11:56:17 INFO - PROCESS | 11191 | __end_cc_report 11:56:17 INFO - PROCESS | 11191 | __startTimestamp1468436177320__endTimestamp 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | ------- Summary: start ------- 11:56:17 INFO - PROCESS | 11191 | Number of tests: 14 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.11 (2.8%) stddev-sans-first:1.48 11:56:17 INFO - PROCESS | 11191 | Values: 102.0 112.0 110.0 113.0 112.0 110.0 112.0 110.0 109.0 109.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:131.00 stddev:17.57 (13.4%) stddev-sans-first:18.23 11:56:17 INFO - PROCESS | 11191 | Values: 141.0 120.0 118.0 167.0 115.0 119.0 143.0 121.0 146.0 116.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 11:56:17 INFO - PROCESS | 11191 | Values: 160.0 159.0 160.0 161.0 159.0 163.0 161.0 160.0 161.0 162.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#3] audio-fft Cycles:10 Average:79.50 Median:75.00 stddev:10.65 (14.2%) stddev-sans-first:11.17 11:56:17 INFO - PROCESS | 11191 | Values: 75.0 73.0 75.0 102.0 75.0 76.0 73.0 74.0 97.0 75.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:18.46 (22.2%) stddev-sans-first:19.11 11:56:17 INFO - PROCESS | 11191 | Values: 83.0 83.0 117.0 83.0 83.0 83.0 115.0 84.0 84.0 130.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:56:17 INFO - PROCESS | 11191 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 11:56:17 INFO - PROCESS | 11191 | Values: 145.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 147.0 147.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:56:17 INFO - PROCESS | 11191 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.52 (2.9%) stddev-sans-first:1.20 11:56:17 INFO - PROCESS | 11191 | Values: 55.0 51.0 54.0 51.0 53.0 52.0 52.0 51.0 50.0 52.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 11:56:17 INFO - PROCESS | 11191 | Values: 63.0 64.0 62.0 61.0 62.0 62.0 62.0 62.0 63.0 63.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.75 (4.9%) stddev-sans-first:3.94 11:56:17 INFO - PROCESS | 11191 | Values: 76.0 81.0 75.0 74.0 76.0 74.0 77.0 83.0 75.0 84.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:121.00 stddev:12.54 (10.4%) stddev-sans-first:13.19 11:56:17 INFO - PROCESS | 11191 | Values: 119.0 122.0 117.0 120.0 120.0 119.0 122.0 117.0 159.0 122.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.00 stddev:1.51 (1.0%) stddev-sans-first:1.50 11:56:17 INFO - PROCESS | 11191 | Values: 159.0 159.0 158.0 157.0 155.0 158.0 159.0 158.0 157.0 155.0 11:56:17 INFO - PROCESS | 11191 | 11:56:17 INFO - PROCESS | 11191 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 11:56:17 INFO - PROCESS | 11191 | Values: 63.0 62.0 64.0 64.0 62.0 63.0 65.0 63.0 62.0 63.0 11:56:17 INFO - PROCESS | 11191 | -------- Summary: end -------- 11:56:17 INFO - PROCESS | 11191 | 11:56:18 INFO - TEST-INFO | 11191: exit 0 11:56:18 INFO - TEST-OK | kraken | took 61667ms 11:56:18 INFO - SUITE-END | took 1177s 11:56:18 INFO - Completed test suite (00:19:37) 11:56:18 INFO - javascript benchmark 11:56:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.9236019099535, 3067.386522695461, 3083.3833233353334, 3102.270966322914, 3102.8758849646015, 5260.868478288045, 5361.142217245241, 5369.167778994257, 5444.9183262251045, 5468.535174510162, 5333.786648534064, 5342.1452567589195, 5364.785408583652, 5378.139497680362, 5440.537554307889, 4786.688865223767, 4846.951530484703, 4875.317455556207, 4885.389326334208, 5073.923891141636, 4976.726280054596, 4998.7250701211415, 5035.370578677665, 5058.2412638104215, 5059.544640982311, 4826.710397376169, 4840.612750979931, 4875.7074575525585, 4886.63350248731, 4914.631402644816, 4832.323474713543, 4878.682885612424, 4884.169691152512, 4924.581410580069, 4981.053599816023, 4894.657373983787, 4901.534354236342, 4911.140550403701, 4915.2872833439305, 4920.704757714549, 5269.051570717269, 5338.599605029638, 5441.564674826004, 5465.508104270635, 5490.313710786152, 5810.157527158538, 5812.099124635688, 5829.038208695561, 5831.562632802515, 5836.941630583725, 5570.387257401682, 5875.412458754133, 5879.2944846618675, 5879.441453061952, 5893.5579831512805, 5328.866778330573, 5404.864878378033, 5410.161424979135, 5418.160185171305, 5462.0441422751255, 5999.310079340931, 6003.0, 6008.158857759917, 6009.978303688296, 6010.579259451796, 5522.420145884705, 5625.746841392147, 5686.60193786431, 5722.7424765885635, 5735.913961290584, 5777.046787280052, 5861.443162899518, 5868.383819698955, 5880.970595147082, 5884.970575147183, 5753.395893431213, 5776.855578610568, 5788.363280039192, 5792.1311803229855, 5793.536517078624, 5598.972005139948, 5626.662400255997, 5696.715164241771, 5786.07422812348, 5806.1581070744505, 4372.038151606642, 4376.081022985209, 4378.956210437918, 4410.713303635253, 4412.514623391425, 3895.0651843557343, 3915.099527108724, 3915.686745060388, 3940.940885886714, 3941.7437866538585, 5300.867478313073, 5395.595330350239, 5399.271098401744, 5434.673919564839, 5447.073997420448, 5790.334111577223, 5793.188953546507, 5796.449337312949, 5811.738471768696, 5837.620554663933, 5451.972740136274, 5453.0, 5453.372862120827, 5467.781288748485, 5469.726513674301, 4821.5178482151505, 4967.627427942919, 5027.497250274943, 5029.170186919117, 5030.195168773052, 5924.14099955504, 5937.10943358491, 5942.316633587193, 5946.435088666656, 5951.880962380728, 5771.624844385102, 5788.450097240755, 5799.101139323411, 5806.709664516842, 5813.04084825999, 5666.121751128581, 5848.2689663792025, 5853.239078919713, 5899.085641725539, 5937.584369094122, 5636.802711905064, 5657.4059723728415, 5660.20757093999, 5699.601027928171, 5710.114932185518, 5667.149927510906, 5783.19035335045, 5796.913046304393, 5808.73860676279, 5834.15404766298, 5568.16477528374, 5633.915491267552, 5637.267155269788, 5650.660960342392, 5658.0, 5588.552915766648, 5639.915401269066, 5641.802536911188, 5642.802501912413, 5647.265855438766, 5460.972695136499, 5561.5272701820795, 5571.832845014656, 5578.721063946868, 5586.86032849182, 5700.857478562903, 5721.685307308138, 5758.596898217084, 5795.623284486495, 5805.825825225081, 5571.9721401392735, 5604.439556044363, 5614.550835933034, 5620.100783874561, 5623.184638227516], "value": 5322.134079181709, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.3811497927176, 606.915031895535, 624.7875722254432, 634.7238951056291, 646.6960528551582, 33385.66614333856, 43863.342049869236, 44293.55706442935, 44307.89230269249, 44351.77824110875, 46970.53029469704, 47320.76339618306, 47339.289910651365, 47361.0, 47397.0, 8021.318187954031, 8852.468851868893, 8998.955005224965, 9001.77495562613, 10592.629257975972, 10529.15766738663, 10955.890441095607, 10965.342079475256, 10966.232363734502, 10966.890331096707, 11055.557777688922, 11094.55621775128, 11101.666949991513, 11102.389368584725, 11103.278286911365, 10991.340519568812, 11027.779444411148, 11046.447677616086, 11054.115670746321, 11060.0, 10766.084882784973, 10815.080718138968, 10826.079783218436, 10830.350178989285, 10830.891691083067, 45567.31649025267, 45973.54026459759, 45998.77000615009, 46015.0, 46024.539754602694, 3360.2775403288165, 3383.780054296463, 3506.1234691327168, 3606.206634540397, 4041.2927737646087, 33964.49053264203, 34247.31505369879, 34845.0, 34886.0, 34945.47581786275, 4512.616427603658, 4545.2954792007295, 4556.612687921531, 4644.256918892995, 4763.095011947754, 406321.0, 407457.96271018754, 408424.0, 408476.0, 409541.0, 31686.841565792023, 63265.36734632687, 63304.68347658325, 63569.682151588946, 63656.862303950096, 37416.62583374186, 37467.253274672315, 37500.81249593789, 37614.43578346327, 37677.43483847744, 15690.764638530203, 15729.764053539206, 15816.446424375092, 15819.446319378767, 15837.604059898595, 11920.344381058952, 12937.870621293667, 13122.868771312356, 13159.60521184366, 13305.600831975056, 8279.668813247403, 8288.046874609376, 8288.21261980111, 8368.497890126611, 8389.203025712548, 2993.3115383461927, 3175.17445464181, 3204.070819462376, 3205.5512228288057, 3226.7418606511424, 951.9714408567615, 960.4573416019927, 1006.5973610555836, 1058.333250052462, 1112.0522146380317, 31781.882391671817, 32954.0, 33296.833515832266, 33307.333853322794, 33371.83314083414, 1055.472263868066, 1086.1528008153653, 1124.2074337591978, 1133.665568657248, 1158.8261760735957, 16452.917735411247, 16903.23935422909, 17067.914660426868, 17092.2308496118, 17275.481735547703, 571424.0, 576637.0, 577555.0, 580828.0, 580894.0, 62025.689871550356, 62368.06447903285, 62495.375046249865, 62509.0, 62528.0, 1204.2172587817988, 1325.6619562011626, 1353.1948490648049, 1380.2132784312846, 1389.7637401641948, 33295.33409331751, 34419.0, 34451.310973780885, 34468.310633786685, 34778.478322825686, 53539.19691204557, 53653.39039828812, 54328.72835635955, 54387.45612543824, 54482.72758636181, 438643.0, 441309.0, 441751.0, 441904.0, 442637.0, 25083.0, 27361.726382735917, 28387.71612283851, 28505.857470712515, 29910.850445747634, 50045.249321259485, 50550.241746373096, 51127.74436127795, 51983.48016519786, 52044.47955520548, 43024.78487607667, 43202.78398607987, 43433.565664342954, 43504.0, 44754.3286850704, 42992.570074298856, 43083.05515420308, 43185.78407107944, 43333.0, 43358.78320608377, 41539.0, 42656.78671606622, 42751.3587296197, 43094.78452607842, 43277.56722432861, 35639.64360356363, 37899.62100378961, 37911.43132853065, 38176.2766063762, 38633.80683096567, 28342.433151336445, 28805.27986800347, 28831.42337153287, 28865.278368040126, 29176.416471670873], "value": 19934.571368294924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.59529315399647, 373.70664028737446, 374.5916950523928, 386.27380524613756, 389.1011762827868, 18816.247350105998, 19381.515462113435, 20167.0, 20323.898380508075, 20341.288054918063, 11688.7662246755, 11913.106517011238, 11925.940370298158, 11936.880631193686, 12737.745245095093, 5231.712255825938, 5374.408815030343, 5412.539934105586, 5415.10650742627, 5419.295491586108, 3963.1479231965122, 5860.73626686798, 6093.603915745484, 6104.175936248616, 6210.378962103799, 6066.998945174063, 6149.108379285001, 6223.284322302925, 6231.408016238473, 6558.1802274715665, 6584.341565843401, 6618.172728408949, 6636.070950066995, 6653.234877989044, 6671.199456065255, 3794.3359912015285, 5429.886873190986, 5667.234923285345, 5677.716114194273, 5715.199872017879, 14127.576172714835, 14207.644808879757, 14279.0, 14321.498747543787, 14537.0, 2190.397640648818, 2270.2281224383623, 2326.3835083702834, 2390.9760902390926, 2458.5697502936914, 10478.423686697228, 10489.527971241312, 10502.78994420115, 10846.457677116192, 11024.0, 1929.0740444586677, 2018.0, 2021.4946263434142, 2052.7741948385665, 2096.7483901931864, 84939.57530212309, 85000.57499712461, 85454.14545854524, 87221.0, 88138.5593072037, 10347.948260258801, 10436.0, 10443.530041148166, 10770.599822023087, 10849.457527123612, 14231.359588818528, 14301.713965720628, 14306.928465357814, 14312.713745725026, 14369.0, 7534.962325188339, 7758.922410775933, 7787.260210280015, 7803.648835802403, 7834.647440865175, 7496.587687677121, 7506.737264195727, 7662.846743065219, 7666.310032097026, 7708.922910770821, 4322.243607368698, 4396.076823867023, 4402.405675233803, 4514.45826500822, 4516.751578663205, 1660.800703915538, 1802.8107048759953, 1817.0620550340984, 1844.62185252023, 1915.358354951079, 888.7244954064261, 971.4414211828085, 984.4929861121528, 1033.679559336608, 1043.6190790361616, 18747.812521874606, 19543.218271269274, 19656.508587285432, 19725.40823775289, 19971.60056798856, 974.9805003899883, 990.7275499237767, 996.1582462819051, 1012.4026824173773, 1017.165923942375, 10656.147508199325, 10965.451727413598, 11839.704007399712, 11964.521419143312, 11980.940095299642, 558894.0, 583141.0, 589433.0, 595670.0, 598909.0, 97537.51231243799, 97973.0, 103157.48421257846, 103677.48161259145, 104807.4759626197, 460.69363873024065, 472.36466951949575, 475.25859658931483, 476.5925134010441, 476.9475357710649, 10906.890931090587, 11429.828552571551, 11588.594399195988, 11789.292642441482, 11961.940190298992, 40895.795521022206, 43080.78459607682, 43122.353164703185, 43230.783846080565, 44039.55960440483, 59069.40930590811, 60120.699396502736, 61403.385966139766, 61521.692391537756, 62200.0, 8336.916630833613, 8407.579621019047, 8480.406371553932, 8739.737807865775, 8744.912550874664, 8450.450720703135, 10409.271351005356, 12607.306598137191, 12791.168574042658, 13345.266010369523, 11018.724531886766, 11126.221164518729, 11527.884721153017, 11596.76806463849, 12009.099317551394, 11089.112870970464, 11309.660710178709, 11438.94280528592, 11692.766144676889, 11721.531138754355, 11391.316521008766, 11843.703907402383, 11894.643160705193, 12045.0, 12126.33305168189, 8293.917060829315, 8545.529995850287, 8718.302535796995, 8919.509426981578, 8931.106889311017, 10306.227032972407, 11325.603603874155, 11709.88290117122, 11790.587329443428, 11807.645770626896], "value": 8727.965075932409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.1412581821808, 1393.5679939218842, 1504.6614511734858, 1637.6315329050965, 1801.9909900450505, 8217.6302066407, 8529.189726975936, 8560.914390856098, 8637.52493612851, 8723.47659140452, 8462.23839854413, 8655.567221638925, 8657.350698697592, 8659.69691060813, 8662.783430414243, 1913.1199648161862, 1966.2331690640663, 2170.2295685031822, 2183.1376606240565, 2204.2836078274627, 2219.223271854854, 2230.1413955627118, 2232.1406258590396, 2234.6089434349005, 2238.8992495337748, 2221.544583360407, 2229.8104661103825, 2246.3036458697775, 2249.0329158461855, 2249.3701763506247, 1863.9906800465978, 2110.5462325599915, 2121.9045142968525, 2169.7721739217313, 2170.066871245364, 2202.449387653087, 2218.3566765637947, 2224.065892325227, 2224.944376390587, 2226.7105276313973, 8773.034966153718, 8811.206991370807, 8811.691590794355, 8816.8677469838, 8816.911830881672, 5035.395752509686, 5145.76844042019, 5152.716600586966, 5158.7420628968775, 5162.3030890830005, 3283.7208837248622, 3357.3285342931513, 3473.6352682968177, 3489.8080605566684, 3498.4227602445567, 1066.8797762349502, 1077.4181941751444, 1086.6685660873432, 1090.9345439273668, 1091.0562363555546, 12702.618921432371, 12786.0, 12815.935920320338, 12817.679558011125, 12830.230186188859, 4464.732116073046, 4541.0, 4694.577488026026, 4711.646626503026, 4719.83480578185, 10731.946340268249, 10747.731306717395, 10761.730956726144, 10765.407902565277, 10770.353778773298, 5288.153895376799, 5308.177232528964, 5347.438518955531, 5347.491988261109, 5366.409694933554, 4215.620594146541, 4691.39011928454, 4845.927311090337, 4853.6602437829715, 4929.580985616191, 3866.903327416837, 3927.92144157121, 3983.8605648802154, 4029.8388064477094, 4047.392891066305, 1142.4915912418894, 1228.4656174564093, 1230.833837431953, 1232.679503329123, 1274.4965738533228, 925.8981512033671, 934.3179478980246, 939.2110627073155, 945.4658118163215, 985.0395864032654, 5904.439078287556, 6032.728527216286, 6061.696915154224, 6226.813195604049, 6361.077643741632, 978.4814048554277, 986.5708416838698, 987.456898705709, 992.5434300221979, 997.4613708597276, 4006.2988976929505, 4036.5761595032686, 4074.714769966074, 4086.713930024929, 4103.097318589906, 10591.311564748266, 10942.507587158598, 11008.834867476995, 11011.559537618567, 11036.172287078502, 10872.836907446395, 10897.67306980792, 10901.291416057931, 10903.29128606638, 10911.563537458413, 7828.765137045898, 7994.64024118916, 8084.22147127631, 8123.715669951642, 8129.634166462523, 6061.818145455643, 6220.0, 6236.844078898064, 6370.522210834299, 6393.7122829471855, 10288.2798204125, 10386.169106471616, 10604.575816967235, 10641.574337026743, 10644.467776611293, 10489.52797124116, 10701.518431670438, 10703.197260205672, 10918.12654987615, 10928.726781830517, 8245.350929814182, 8259.545724985184, 8298.253157215879, 8419.579021049045, 8427.662893484438, 8914.598843052208, 8922.420042697204, 8923.0, 8960.820783584422, 8974.551272436222, 7797.7660670179985, 7931.246531579491, 8051.8792218115605, 8102.0, 8109.878351824609, 7527.172011078667, 7637.312641862259, 7674.731384401743, 7800.414968877243, 8037.638306276114, 7368.889466657897, 7420.925790742023, 7452.403807695479, 7502.812429689301, 7514.661840217313, 5278.97360513195, 5332.06688829461, 5348.251244825806, 5472.890542189054, 5481.698506582176, 4987.700737955734, 5016.573591244785, 5037.118504261666, 5146.25379320004, 5179.404368497671], "value": 4646.865209800359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.46056243823074, 317.189580621512, 321.3091852517088, 322.63542197317037, 323.09855503146224, 5358.544523715484, 5384.919226211605, 5400.189971504272, 5406.783728650849, 5452.454754524546, 5338.813141540047, 5354.544863686581, 5375.139977603584, 5393.379761327448, 5422.267993820833, 4021.658159056484, 4038.2125485530332, 4221.514525829522, 4228.175505776375, 4262.680298977573, 4185.2048110859, 4204.66362690984, 4214.136102099078, 4215.515215750182, 4245.150969806051, 3993.9201215975663, 4160.812763425638, 4174.916501669964, 4209.726367786099, 4218.894527636819, 3993.0, 3998.1371752442433, 4109.712320137576, 4200.1179752251755, 4201.327787553977, 3646.2707458508403, 3652.7990960497164, 3675.117971686803, 3680.4479328100733, 3684.5578530576236, 5178.948210517884, 5187.636865419422, 5210.114280572274, 5247.47525247476, 5249.0, 4519.1245633062235, 4742.193827049376, 4751.809927602892, 4752.215884379073, 4793.44875339337, 5600.663960162403, 5606.383297837235, 5618.101103823368, 5638.351589567212, 5660.971695141539, 3988.4615576897327, 3990.8004599769897, 3993.820278087493, 4002.8198731057173, 4009.1781184857036, 5635.506590753454, 5814.924239015753, 5822.912656310159, 5829.979753543113, 5836.074095548502, 4034.6973976951845, 4045.110075783323, 4056.9391459128137, 4085.6935729820384, 4091.3862920562156, 4127.9587204128175, 4133.565975572582, 4140.730852494578, 4146.3158578834755, 4149.232392007489, 4544.523234837022, 4754.049190161982, 4755.9286610700865, 4766.118268120409, 4771.0, 5609.709766753669, 5620.775168993277, 5632.887342253132, 5646.6612003279115, 5716.1997320375185, 1420.1550077703955, 1420.94849811139, 1425.180521200314, 1425.664968732347, 1438.1155589312498, 905.5019739143445, 909.2862103248918, 913.954302284883, 916.3997581584073, 929.8093890752515, 5345.599080069011, 5475.425080366584, 5483.75323110461, 5490.615656904059, 5496.917546236809, 5805.303363596396, 5810.0, 5815.331236907809, 5840.912386314209, 5874.236349274567, 5195.246689230041, 5450.809221677222, 5461.525388145178, 5475.233467314579, 5484.177373394023, 3058.388322335542, 3079.476488996876, 3100.906887850692, 3104.798188117765, 3113.2061324362594, 5825.50483208932, 5966.433188847052, 5978.8206353809455, 6009.969950150221, 6011.759529618854, 5967.433093856077, 5973.761049557969, 5977.760889564455, 5983.025601551478, 5994.610350327215, 5876.296903424387, 5978.070745334841, 5986.191864098291, 6029.065494848393, 6053.515718742402, 5510.228568000403, 5824.737886795019, 5836.182934389104, 5844.590878638624, 5852.970735146297, 5767.68277744728, 5786.85532861665, 5790.884182316246, 5805.477507024388, 5808.970955145197, 5823.505002074701, 5993.730282137227, 6051.969740151271, 6076.787312444043, 6085.2393450818645, 4093.7543747375253, 4107.240160570304, 4123.752574845519, 4127.8854709228945, 4154.4183814265425, 5908.852278692895, 5932.851678708067, 5943.465088142088, 5953.553483488669, 5957.374475680164, 5436.565074794086, 5702.914456283076, 5747.0, 5786.0, 5792.913106303325, 5644.6613203207935, 5661.179129026185, 5671.914921276101, 5677.914831277451, 5685.51673107774, 5379.193121031876, 5584.664920104807, 5612.522935550361, 5675.404082571271, 5678.488935995615, 5457.20870473787, 5712.514436272963, 5715.657060576379, 5722.914156287742, 5729.4843464088435, 5594.776208951596, 5601.663900166003, 5607.971960140173, 5679.77280908759, 5698.401667824819], "value": 4294.989411965083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.582805285146, 799.1888233443054, 800.0759123212688, 820.585604269844, 859.8968123825142, 15390.923045384772, 16050.59873503163, 16072.839271607281, 16372.345106195768, 16524.83475165248, 16105.436309729163, 16188.595285117877, 16214.51356459308, 16268.0, 16434.260458279376, 658.4699317049773, 793.0602236349915, 799.8200404908893, 820.8891799607067, 831.580052073702, 812.0701796443069, 816.4692949582759, 816.9264766171043, 817.239966830847, 817.6851912013858, 838.6603425612606, 839.2111415269627, 839.6473481137937, 839.8740188971673, 839.8992120945495, 692.3146085375492, 834.1616675241344, 837.4431003382743, 867.7179916527091, 869.5565261716507, 615.8460384903774, 622.0451606783611, 622.8660837919869, 623.7785586116954, 623.9313675495691, 14008.509702160376, 14035.228062456561, 14048.648783780385, 14150.716985660332, 14209.00536962413, 15105.39578416862, 15454.150021748912, 15480.380784768597, 15695.372185112581, 15697.529074127795, 12139.393030348536, 12303.384830758427, 12596.81104783429, 13152.21086734799, 13672.726545469135, 3857.1128640412862, 3910.2179564087014, 3922.8430862765454, 3965.6827453803917, 4084.81618327173, 81670.59164704198, 82174.0, 83067.5846620769, 84271.15728842694, 84971.15028849694, 11710.590129345603, 11996.940015299868, 12123.939380303218, 12483.625491235278, 12502.874971250352, 23704.525909482058, 23760.643590346157, 23762.405939851644, 23793.52412951731, 23795.40511487227, 8462.323014158852, 8641.222289993804, 8791.07693692166, 8834.293256539462, 8880.51157186348, 4697.459792123881, 4751.144793937125, 4794.976025119852, 4976.0, 5221.530062294411, 3310.6192787829227, 3401.965980340165, 3409.062507810372, 3411.3688967541084, 3411.573553305837, 604.9546284028715, 607.3713706314032, 622.9221347331584, 632.0550776589029, 637.9457746091541, 678.8133263352618, 684.6576711644178, 749.6514120933792, 766.7592008621026, 774.4578794843632, 8817.515036673045, 9853.118132004807, 10008.549615267331, 10008.79982400348, 10102.393856368495, 595.4016213705285, 686.5983399711225, 702.5714314268292, 774.8024253815241, 775.7750252426733, 4626.583607475276, 4714.316424118484, 4886.267059941038, 5118.232265160255, 5120.564751996048, 111373.44313278382, 111876.0, 112130.43934780436, 112909.0, 113978.43010784894, 62104.689476552325, 87562.0, 97638.0, 99115.0, 99426.50286748665, 89430.55284723535, 90495.84508272429, 93732.0, 93753.5312323434, 95902.5204873985, 8773.166549177819, 8913.449687909775, 9025.593848276974, 9039.68361107358, 9043.638254469748, 51447.48552514577, 52603.47396525986, 52848.09335486585, 53835.19247211217, 55616.72191639016, 55984.72007639936, 72187.0, 74307.2569274322, 76643.0, 76932.0, 11391.145664075062, 11726.355050472306, 12337.198082124632, 12620.0, 13243.404046817725, 13091.758624117781, 13354.666133346744, 13354.866451335361, 13590.524331648345, 13624.591262262147, 14073.718525629634, 14312.355943982753, 14335.56993290203, 14460.421583136556, 14504.782428263796, 14321.0, 14453.277336132942, 14720.631984200481, 14899.404023838924, 15339.463118791235, 13627.566391987402, 14112.153270803785, 14195.351427690517, 14395.784063239269, 14460.778245951187, 11029.172812038969, 11041.558337666725, 11117.166212534254, 11573.537058517564, 12058.216215945935, 11488.827667584826, 11510.194286399872, 11735.47190376418, 11787.41062946832, 12138.817917731065], "value": 7668.734346602833, "unit": "score"}], "name": "dromaeo_css", "value": 7220.753317169442, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 113.0, 112.0, 110.0, 112.0, 110.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 120.0, 118.0, 167.0, 115.0, 119.0, 143.0, 121.0, 146.0, 116.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 159.0, 163.0, 161.0, 160.0, 161.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 102.0, 75.0, 76.0, 73.0, 74.0, 97.0, 75.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 83.0, 83.0, 115.0, 84.0, 84.0, 130.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 54.0, 51.0, 53.0, 52.0, 52.0, 51.0, 50.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 75.0, 74.0, 76.0, 74.0, 77.0, 83.0, 75.0, 84.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 117.0, 120.0, 120.0, 119.0, 122.0, 117.0, 159.0, 122.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 158.0, 157.0, 155.0, 158.0, 159.0, 158.0, 157.0, 155.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 62.0, 63.0, 65.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1468.6000000000001, "alertThreshold": 2.0}]} 11:56:18 INFO - Return code: 0 11:56:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:18 INFO - # TBPL SUCCESS # 11:56:18 INFO - Running post-action listener: _resource_record_post_action 11:56:18 INFO - ##### 11:56:18 INFO - ##### Finished run-tests step (success) 11:56:18 INFO - ##### 11:56:18 INFO - Running post-run listener: _resource_record_post_run 11:56:18 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 221184; Write bytes: 553254912; Read time: 64; Write time: 1068448 11:56:18 INFO - TinderboxPrint: CPU usage
13.1% 11:56:18 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 64 11:56:18 INFO - TinderboxPrint: I/O write bytes / time
553,254,912 / 1,068,448 11:56:18 INFO - TinderboxPrint: CPU idle
8,291.7 (86.9%) 11:56:18 INFO - TinderboxPrint: CPU user
1,194.5 (12.5%) 11:56:18 INFO - TinderboxPrint: Swap in / out
0 / 0 11:56:18 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 0; Write bytes: 263835648; Read time: 0; Write time: 662900 11:56:18 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 221184; Write bytes: 289366016; Read time: 64; Write time: 405520 11:56:19 INFO - Running post-run listener: _upload_blobber_files 11:56:19 INFO - Blob upload gear active. 11:56:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:19 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 11:56:19 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'] 11:56:19 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 11:56:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:56:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:20 INFO - (blobuploader) - INFO - Done attempting. 11:56:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:56:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:21 INFO - (blobuploader) - INFO - Done attempting. 11:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:25 INFO - (blobuploader) - INFO - Done attempting. 11:56:25 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:25 INFO - Return code: 0 11:56:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44c0dab72405963b983ec4cfe5f23cfa38f3d7ce4e6aef7747b127551e5ebdf8d3a71ccb8a937eb64f4dd2614412841381471694b849726099eb5a7c14302a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb797f2d70bde08faaee88ae5414696427c9943b98aa72e24fb322490b97fa6984aaba31d1b2496dae500b5079eca700a210108853d1aca994417de19ac6ed76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c883e5ea65fbbdbf093185aa7fade17bf08ed2e06f534475a13b48c40a292a21ef04ade1425f316190912b8417b80ec2142d44d059a1fada3eef4d559f1c6bfb"} 11:56:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:25 INFO - Contents: 11:56:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44c0dab72405963b983ec4cfe5f23cfa38f3d7ce4e6aef7747b127551e5ebdf8d3a71ccb8a937eb64f4dd2614412841381471694b849726099eb5a7c14302a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb797f2d70bde08faaee88ae5414696427c9943b98aa72e24fb322490b97fa6984aaba31d1b2496dae500b5079eca700a210108853d1aca994417de19ac6ed76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c883e5ea65fbbdbf093185aa7fade17bf08ed2e06f534475a13b48c40a292a21ef04ade1425f316190912b8417b80ec2142d44d059a1fada3eef4d559f1c6bfb"} 11:56:25 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:25 INFO - Copying logs to upload dir... 11:56:25 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.726369 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-13 11:56:25.160093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 11:56:25.167687) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44c0dab72405963b983ec4cfe5f23cfa38f3d7ce4e6aef7747b127551e5ebdf8d3a71ccb8a937eb64f4dd2614412841381471694b849726099eb5a7c14302a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb797f2d70bde08faaee88ae5414696427c9943b98aa72e24fb322490b97fa6984aaba31d1b2496dae500b5079eca700a210108853d1aca994417de19ac6ed76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c883e5ea65fbbdbf093185aa7fade17bf08ed2e06f534475a13b48c40a292a21ef04ade1425f316190912b8417b80ec2142d44d059a1fada3eef4d559f1c6bfb"} build_url:https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/HdPPIH8NSm6jxsoo4b215Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44c0dab72405963b983ec4cfe5f23cfa38f3d7ce4e6aef7747b127551e5ebdf8d3a71ccb8a937eb64f4dd2614412841381471694b849726099eb5a7c14302a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb797f2d70bde08faaee88ae5414696427c9943b98aa72e24fb322490b97fa6984aaba31d1b2496dae500b5079eca700a210108853d1aca994417de19ac6ed76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c883e5ea65fbbdbf093185aa7fade17bf08ed2e06f534475a13b48c40a292a21ef04ade1425f316190912b8417b80ec2142d44d059a1fada3eef4d559f1c6bfb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 11:56:25.192808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:56:25.193129) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468434947.35418-74288515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:56:25.276235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 11:56:25.276589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 11:56:25.276908) ========= ========= Total master_lag: 0.18 =========