builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1469527779.64 results: success (0) buildid: 20160726002841 builduid: f509fe4255714734ae53a9fdec164b99 revision: d7988da78c417062fd44170fe8881308b9803dbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.641856) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.642300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.642594) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.657298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.657674) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 03:09:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.1M=0s 2016-07-26 03:09:40 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.747013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.747353) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:39.797254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 03:09:39.797658) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7988da78c417062fd44170fe8881308b9803dbc --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 d7988da78c417062fd44170fe8881308b9803dbc --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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 03:09:40,154 truncating revision to first 12 chars 2016-07-26 03:09:40,154 Setting DEBUG logging. 2016-07-26 03:09:40,154 attempt 1/10 2016-07-26 03:09:40,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d7988da78c41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 03:09:40,904 unpacking tar archive at: mozilla-inbound-d7988da78c41/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 03:09:40.927640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:40.927964) ========= script_repo_revision: d7988da78c417062fd44170fe8881308b9803dbc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:40.928356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:40.928634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:09:40.939235) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-26 03:09:40.939523) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:41 INFO - MultiFileLogger online at 20160726 03:09:41 in /builds/slave/test 03:09:41 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 03:09:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:41 INFO - {'append_to_log': False, 03:09:41 INFO - 'base_work_dir': '/builds/slave/test', 03:09:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:09:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:41 INFO - 'branch': 'Mozilla-Inbound', 03:09:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:41 INFO - 'config_files': ('talos/linux_config.py',), 03:09:41 INFO - 'default_actions': ('clobber', 03:09:41 INFO - 'read-buildbot-config', 03:09:41 INFO - 'download-and-extract', 03:09:41 INFO - 'populate-webroot', 03:09:41 INFO - 'create-virtualenv', 03:09:41 INFO - 'install', 03:09:41 INFO - 'run-tests'), 03:09:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:41 INFO - 'download_minidump_stackwalk': True, 03:09:41 INFO - 'download_symbols': 'ondemand', 03:09:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:41 INFO - 'installer_path': 'installer.exe', 03:09:41 INFO - 'log_level': 'info', 03:09:41 INFO - 'log_name': 'talos', 03:09:41 INFO - 'log_to_console': True, 03:09:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:41 INFO - 'opt_config_files': (), 03:09:41 INFO - 'pip_index': False, 03:09:41 INFO - 'sps_profile': False, 03:09:41 INFO - 'sps_profile_interval': 0, 03:09:41 INFO - 'suite': 'dromaeojs', 03:09:41 INFO - 'system_bits': '32', 03:09:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:41 INFO - 'title': 'talos-linux64-ix-057', 03:09:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:41 INFO - 'use_talos_json': True, 03:09:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:41 INFO - 'work_dir': 'build'} 03:09:41 INFO - [mozharness: 2016-07-26 10:09:41.386061Z] Running clobber step. 03:09:41 INFO - Running pre-action listener: _resource_record_pre_action 03:09:41 INFO - Running main action method: clobber 03:09:41 INFO - rmtree: /builds/slave/test/build 03:09:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:41 INFO - Running post-action listener: _resource_record_post_action 03:09:41 INFO - [mozharness: 2016-07-26 10:09:41.868266Z] Finished clobber step (success) 03:09:41 INFO - [mozharness: 2016-07-26 10:09:41.868368Z] Running read-buildbot-config step. 03:09:41 INFO - Running pre-action listener: _resource_record_pre_action 03:09:41 INFO - Running main action method: read_buildbot_config 03:09:41 INFO - Using buildbot properties: 03:09:41 INFO - { 03:09:41 INFO - "project": "", 03:09:41 INFO - "product": "firefox", 03:09:41 INFO - "script_repo_revision": "production", 03:09:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:09:41 INFO - "repository": "", 03:09:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:09:41 INFO - "buildid": "20160726002841", 03:09:41 INFO - "pgo_build": "True", 03:09:41 INFO - "basedir": "/builds/slave/test", 03:09:41 INFO - "buildnumber": 2131, 03:09:41 INFO - "slavename": "talos-linux64-ix-057", 03:09:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:09:41 INFO - "platform": "ubuntu64_hw", 03:09:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:09:41 INFO - "branch": "mozilla-inbound", 03:09:41 INFO - "repo_path": "integration/mozilla-inbound", 03:09:41 INFO - "revision": "d7988da78c417062fd44170fe8881308b9803dbc", 03:09:41 INFO - "stage_platform": "linux64-pgo", 03:09:41 INFO - "builduid": "f509fe4255714734ae53a9fdec164b99", 03:09:41 INFO - "slavebuilddir": "test" 03:09:41 INFO - } 03:09:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:09:41 INFO - Running post-action listener: _resource_record_post_action 03:09:41 INFO - [mozharness: 2016-07-26 10:09:41.870826Z] Finished read-buildbot-config step (success) 03:09:41 INFO - [mozharness: 2016-07-26 10:09:41.870916Z] Running download-and-extract step. 03:09:41 INFO - Running pre-action listener: _resource_record_pre_action 03:09:41 INFO - Running main action method: download_and_extract 03:09:41 INFO - mkdir: /builds/slave/test/build/tests 03:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:41 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:42 INFO - Downloaded 1361 bytes. 03:09:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:42 INFO - Using the following test package requirements: 03:09:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:09:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'jsshell-linux-x86_64.zip'], 03:09:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:09:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:09:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09:42 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')]} 03:09:42 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:43 INFO - Downloaded 24349044 bytes. 03:09:43 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'] 03:09:43 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 03:09:44 INFO - Return code: 0 03:09:44 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 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:44 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:46 INFO - Downloaded 24349044 bytes. 03:09:46 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'] 03:09:46 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 03:09:47 INFO - Return code: 0 03:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:47 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:48 INFO - Downloaded 14403317 bytes. 03:09:48 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'] 03:09:48 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 03:09:48 INFO - Return code: 0 03:09:48 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')]} 03:09:48 INFO - https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWMO5fP6QSKftOzfOmLEbw/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 03:09:50 INFO - Downloaded 60890670 bytes. 03:09:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:09:50 INFO - mkdir: /builds/slave/test/properties 03:09:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:50 INFO - Contents: 03:09:50 INFO - build_url:https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:09:50 INFO - Running post-action listener: _resource_record_post_action 03:09:50 INFO - Running post-action listener: set_extra_try_arguments 03:09:50 INFO - [mozharness: 2016-07-26 10:09:50.834113Z] Finished download-and-extract step (success) 03:09:50 INFO - [mozharness: 2016-07-26 10:09:50.834348Z] Running populate-webroot step. 03:09:50 INFO - Running pre-action listener: _resource_record_pre_action 03:09:50 INFO - Running main action method: populate_webroot 03:09:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:50 INFO - '--tppagecycles', 03:09:50 INFO - '7'], 03:09:50 INFO - 'tests': ['tsvgm']}}, 03:09:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['damp', 'tps']}, 03:09:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'tests': ['damp', 'tps']}, 03:09:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['dromaeo_dom']}, 03:09:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['basic_compositor_video']}, 03:09:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:09:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['a11yr', 03:09:50 INFO - 'ts_paint', 03:09:50 INFO - 'tpaint', 03:09:50 INFO - 'sessionrestore', 03:09:50 INFO - 'sessionrestore_no_auto_restore', 03:09:50 INFO - 'tabpaint']}, 03:09:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['tsvgx', 03:09:50 INFO - 'tsvgr_opacity', 03:09:50 INFO - 'tart', 03:09:50 INFO - 'tscrollx', 03:09:50 INFO - 'cart']}, 03:09:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:50 INFO - 'tsvgr_opacity', 03:09:50 INFO - 'tart', 03:09:50 INFO - 'tscrollx', 03:09:50 INFO - 'cart']}, 03:09:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'talos_options': ['--disable-e10s'], 03:09:50 INFO - 'tests': ['tp5o']}, 03:09:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'tests': ['tp5o']}, 03:09:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'talos_options': ['--disable-e10s', 03:09:50 INFO - '--xperf_path', 03:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:50 INFO - 'tests': ['tp5n']}, 03:09:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:50 INFO - 'talos_options': ['--xperf_path', 03:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:50 INFO - 'tests': ['tp5n']}}, 03:09:50 INFO - 'talos.zip': {'path': '', 03:09:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:50 INFO - Running post-action listener: _resource_record_post_action 03:09:50 INFO - [mozharness: 2016-07-26 10:09:50.852320Z] Finished populate-webroot step (success) 03:09:50 INFO - [mozharness: 2016-07-26 10:09:50.852410Z] Running create-virtualenv step. 03:09:50 INFO - Running pre-action listener: _resource_record_pre_action 03:09:50 INFO - Running main action method: create_virtualenv 03:09:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:50 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 03:09:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:51 INFO - Using real prefix '/usr' 03:09:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:53 INFO - Installing pip.................done. 03:09:53 INFO - Return code: 0 03:09:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:53 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:09:53 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 03:09:53 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 03:09:53 INFO - Using env: {'DISPLAY': ':0', 03:09:53 INFO - 'HOME': '/home/cltbld', 03:09:53 INFO - 'LANG': 'en_US.UTF-8', 03:09:53 INFO - 'LANGUAGE': 'en_US:en', 03:09:53 INFO - 'LOGNAME': 'cltbld', 03:09:53 INFO - 'MAIL': '/var/mail/cltbld', 03:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:53 INFO - 'MOZ_NO_REMOTE': '1', 03:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:53 INFO - 'NO_EM_RESTART': '1', 03:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:53 INFO - 'PWD': '/builds/slave/test', 03:09:53 INFO - 'SHELL': '/bin/bash', 03:09:53 INFO - 'SHLVL': '1', 03:09:53 INFO - 'TERM': 'linux', 03:09:53 INFO - 'TMOUT': '86400', 03:09:53 INFO - 'USER': 'cltbld', 03:09:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:53 INFO - '_': '/tools/buildbot/bin/python'} 03:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:53 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 03:09:53 INFO - Cleaning up... 03:09:53 INFO - Return code: 0 03:09:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:53 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:09:53 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 03:09:53 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 03:09:53 INFO - Using env: {'DISPLAY': ':0', 03:09:53 INFO - 'HOME': '/home/cltbld', 03:09:53 INFO - 'LANG': 'en_US.UTF-8', 03:09:53 INFO - 'LANGUAGE': 'en_US:en', 03:09:53 INFO - 'LOGNAME': 'cltbld', 03:09:53 INFO - 'MAIL': '/var/mail/cltbld', 03:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:53 INFO - 'MOZ_NO_REMOTE': '1', 03:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:53 INFO - 'NO_EM_RESTART': '1', 03:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:53 INFO - 'PWD': '/builds/slave/test', 03:09:53 INFO - 'SHELL': '/bin/bash', 03:09:53 INFO - 'SHLVL': '1', 03:09:53 INFO - 'TERM': 'linux', 03:09:53 INFO - 'TMOUT': '86400', 03:09:53 INFO - 'USER': 'cltbld', 03:09:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:53 INFO - '_': '/tools/buildbot/bin/python'} 03:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:53 INFO - Downloading/unpacking psutil>=3.1.1 03:09:53 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 03:09:53 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 03:09:53 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 03:09:53 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 03:09:53 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 03:09:53 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 03:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:56 INFO - Installing collected packages: psutil 03:09:56 INFO - Running setup.py install for psutil 03:09:56 INFO - building 'psutil._psutil_linux' extension 03:09:56 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 03:09:56 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 03:09:56 INFO - building 'psutil._psutil_posix' extension 03:09:56 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 03:09:56 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 03:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:56 INFO - Successfully installed psutil 03:09:56 INFO - Cleaning up... 03:09:56 INFO - Return code: 0 03:09:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09:56 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')]} 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:56 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')]} 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:56 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:09:56 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 03:09:56 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 03:09:56 INFO - Using env: {'DISPLAY': ':0', 03:09:56 INFO - 'HOME': '/home/cltbld', 03:09:56 INFO - 'LANG': 'en_US.UTF-8', 03:09:56 INFO - 'LANGUAGE': 'en_US:en', 03:09:56 INFO - 'LOGNAME': 'cltbld', 03:09:56 INFO - 'MAIL': '/var/mail/cltbld', 03:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:56 INFO - 'MOZ_NO_REMOTE': '1', 03:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:56 INFO - 'NO_EM_RESTART': '1', 03:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:56 INFO - 'PWD': '/builds/slave/test', 03:09:56 INFO - 'SHELL': '/bin/bash', 03:09:56 INFO - 'SHLVL': '1', 03:09:56 INFO - 'TERM': 'linux', 03:09:56 INFO - 'TMOUT': '86400', 03:09:56 INFO - 'USER': 'cltbld', 03:09:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:56 INFO - '_': '/tools/buildbot/bin/python'} 03:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:58 INFO - Installing collected packages: mozsystemmonitor 03:09:58 INFO - Running setup.py install for mozsystemmonitor 03:09:58 INFO - Successfully installed mozsystemmonitor 03:09:58 INFO - Cleaning up... 03:09:58 INFO - Return code: 0 03:09:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:58 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:09:58 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 03:09:58 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 03:09:58 INFO - Using env: {'DISPLAY': ':0', 03:09:58 INFO - 'HOME': '/home/cltbld', 03:09:58 INFO - 'LANG': 'en_US.UTF-8', 03:09:58 INFO - 'LANGUAGE': 'en_US:en', 03:09:58 INFO - 'LOGNAME': 'cltbld', 03:09:58 INFO - 'MAIL': '/var/mail/cltbld', 03:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:58 INFO - 'MOZ_NO_REMOTE': '1', 03:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:58 INFO - 'NO_EM_RESTART': '1', 03:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:58 INFO - 'PWD': '/builds/slave/test', 03:09:58 INFO - 'SHELL': '/bin/bash', 03:09:58 INFO - 'SHLVL': '1', 03:09:58 INFO - 'TERM': 'linux', 03:09:58 INFO - 'TMOUT': '86400', 03:09:58 INFO - 'USER': 'cltbld', 03:09:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:58 INFO - '_': '/tools/buildbot/bin/python'} 03:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10:00 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 03:10:00 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 03:10:00 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 03:10:00 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 03:10:00 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 03:10:00 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 03:10:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:01 INFO - warning: no files found matching '*.txt' 03:10:01 INFO - no previously-included directories found matching 'build' 03:10:01 INFO - no previously-included directories found matching 'dist' 03:10:01 INFO - no previously-included directories found matching '.git*' 03:10:01 INFO - Installing collected packages: jsonschema, functools32 03:10:01 INFO - Running setup.py install for functools32 03:10:01 INFO - warning: no files found matching '*.txt' 03:10:01 INFO - no previously-included directories found matching 'build' 03:10:01 INFO - no previously-included directories found matching 'dist' 03:10:01 INFO - no previously-included directories found matching '.git*' 03:10:01 INFO - Successfully installed jsonschema functools32 03:10:01 INFO - Cleaning up... 03:10:01 INFO - Return code: 0 03:10:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:01 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:10:01 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 03:10:01 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 03:10:01 INFO - Using env: {'DISPLAY': ':0', 03:10:01 INFO - 'HOME': '/home/cltbld', 03:10:01 INFO - 'LANG': 'en_US.UTF-8', 03:10:01 INFO - 'LANGUAGE': 'en_US:en', 03:10:01 INFO - 'LOGNAME': 'cltbld', 03:10:01 INFO - 'MAIL': '/var/mail/cltbld', 03:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:01 INFO - 'MOZ_NO_REMOTE': '1', 03:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:01 INFO - 'NO_EM_RESTART': '1', 03:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:01 INFO - 'PWD': '/builds/slave/test', 03:10:01 INFO - 'SHELL': '/bin/bash', 03:10:01 INFO - 'SHLVL': '1', 03:10:01 INFO - 'TERM': 'linux', 03:10:01 INFO - 'TMOUT': '86400', 03:10:01 INFO - 'USER': 'cltbld', 03:10:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:01 INFO - '_': '/tools/buildbot/bin/python'} 03:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:01 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 03:10:01 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 03:10:01 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 03:10:01 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 03:10:01 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 03:10:01 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 03:10:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 INFO - Downloading docopt-0.6.1.tar.gz 03:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:04 INFO - Running setup.py install for blobuploader 03:10:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:04 INFO - Running setup.py install for requests 03:10:04 INFO - Running setup.py install for docopt 03:10:04 INFO - Successfully installed blobuploader requests docopt 03:10:04 INFO - Cleaning up... 03:10:04 INFO - Return code: 0 03:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:04 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:10:04 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 03:10:04 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 03:10:04 INFO - Using env: {'DISPLAY': ':0', 03:10:04 INFO - 'HOME': '/home/cltbld', 03:10:04 INFO - 'LANG': 'en_US.UTF-8', 03:10:04 INFO - 'LANGUAGE': 'en_US:en', 03:10:04 INFO - 'LOGNAME': 'cltbld', 03:10:04 INFO - 'MAIL': '/var/mail/cltbld', 03:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:04 INFO - 'MOZ_NO_REMOTE': '1', 03:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:04 INFO - 'NO_EM_RESTART': '1', 03:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:04 INFO - 'PWD': '/builds/slave/test', 03:10:04 INFO - 'SHELL': '/bin/bash', 03:10:04 INFO - 'SHLVL': '1', 03:10:04 INFO - 'TERM': 'linux', 03:10:04 INFO - 'TMOUT': '86400', 03:10:04 INFO - 'USER': 'cltbld', 03:10:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:04 INFO - '_': '/tools/buildbot/bin/python'} 03:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:05 INFO - Running setup.py (path:/tmp/pip-jE0tQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:05 INFO - Running setup.py (path:/tmp/pip-ekdxr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:05 INFO - Running setup.py (path:/tmp/pip-Hj7ajc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:05 INFO - Running setup.py (path:/tmp/pip-39Ux2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:05 INFO - Running setup.py (path:/tmp/pip-6eAO04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:05 INFO - Running setup.py (path:/tmp/pip-wPHjwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:05 INFO - Running setup.py (path:/tmp/pip-UR73qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:05 INFO - Running setup.py (path:/tmp/pip-GmL5Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:05 INFO - Running setup.py (path:/tmp/pip-KqqT4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:05 INFO - Running setup.py (path:/tmp/pip-6vqW5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:05 INFO - Running setup.py (path:/tmp/pip-ikAHfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:05 INFO - Running setup.py (path:/tmp/pip-2SDnUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:06 INFO - Running setup.py (path:/tmp/pip-SUe6SI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:06 INFO - Running setup.py (path:/tmp/pip-JSq0PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:06 INFO - Running setup.py (path:/tmp/pip-l3TRuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:06 INFO - Running setup.py (path:/tmp/pip-6_k9AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:06 INFO - Running setup.py (path:/tmp/pip-32WQqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:06 INFO - Running setup.py install for manifestparser 03:10:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:06 INFO - Running setup.py install for mozcrash 03:10:06 INFO - Running setup.py install for mozdebug 03:10:06 INFO - Running setup.py install for mozdevice 03:10:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:06 INFO - Running setup.py install for mozfile 03:10:06 INFO - Running setup.py install for mozhttpd 03:10:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozinfo 03:10:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozInstall 03:10:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozleak 03:10:07 INFO - Running setup.py install for mozlog 03:10:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for moznetwork 03:10:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozprocess 03:10:07 INFO - Running setup.py install for mozprofile 03:10:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozrunner 03:10:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:07 INFO - Running setup.py install for mozscreenshot 03:10:08 INFO - Running setup.py install for moztest 03:10:08 INFO - Running setup.py install for mozversion 03:10:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:08 INFO - Cleaning up... 03:10:08 INFO - Return code: 0 03:10:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:08 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:10:08 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 03:10:08 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 03:10:08 INFO - Using env: {'DISPLAY': ':0', 03:10:08 INFO - 'HOME': '/home/cltbld', 03:10:08 INFO - 'LANG': 'en_US.UTF-8', 03:10:08 INFO - 'LANGUAGE': 'en_US:en', 03:10:08 INFO - 'LOGNAME': 'cltbld', 03:10:08 INFO - 'MAIL': '/var/mail/cltbld', 03:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:08 INFO - 'MOZ_NO_REMOTE': '1', 03:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:08 INFO - 'NO_EM_RESTART': '1', 03:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:08 INFO - 'PWD': '/builds/slave/test', 03:10:08 INFO - 'SHELL': '/bin/bash', 03:10:08 INFO - 'SHLVL': '1', 03:10:08 INFO - 'TERM': 'linux', 03:10:08 INFO - 'TMOUT': '86400', 03:10:08 INFO - 'USER': 'cltbld', 03:10:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:08 INFO - '_': '/tools/buildbot/bin/python'} 03:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:08 INFO - Running setup.py (path:/tmp/pip-tkqknz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:08 INFO - Running setup.py (path:/tmp/pip-VT395K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:08 INFO - Running setup.py (path:/tmp/pip-GYbijx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:08 INFO - Running setup.py (path:/tmp/pip-AMrklw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:08 INFO - Running setup.py (path:/tmp/pip-VQHdKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:08 INFO - Running setup.py (path:/tmp/pip-XcLwsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:08 INFO - Running setup.py (path:/tmp/pip-9DE0MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:08 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)) 03:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:08 INFO - Running setup.py (path:/tmp/pip-3QNWdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:09 INFO - Running setup.py (path:/tmp/pip-qqfcOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:09 INFO - Running setup.py (path:/tmp/pip-PZiSQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:09 INFO - Running setup.py (path:/tmp/pip-mdDqVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:09 INFO - Running setup.py (path:/tmp/pip-0W8jkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:09 INFO - Running setup.py (path:/tmp/pip-4gmWWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:09 INFO - Running setup.py (path:/tmp/pip-6eo7iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:09 INFO - Running setup.py (path:/tmp/pip-NDv9Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:09 INFO - Running setup.py (path:/tmp/pip-MyhIeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:09 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)) 03:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:09 INFO - Running setup.py (path:/tmp/pip-4cGQmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:09 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)) 03:10:09 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)) 03:10:09 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)) 03:10:09 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)) 03:10:09 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)) 03:10:09 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)) 03:10:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:11 INFO - Downloading blessings-1.6.tar.gz 03:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:11 INFO - Installing collected packages: blessings 03:10:11 INFO - Running setup.py install for blessings 03:10:11 INFO - Successfully installed blessings 03:10:11 INFO - Cleaning up... 03:10:11 INFO - Return code: 0 03:10:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:12 INFO - Reading from file tmpfile_stdout 03:10:12 INFO - Current package versions: 03:10:12 INFO - argparse == 1.2.1 03:10:12 INFO - blessings == 1.6 03:10:12 INFO - blobuploader == 1.2.4 03:10:12 INFO - docopt == 0.6.1 03:10:12 INFO - functools32 == 3.2.3-2 03:10:12 INFO - jsonschema == 2.5.1 03:10:12 INFO - manifestparser == 1.1 03:10:12 INFO - mozInstall == 1.12 03:10:12 INFO - mozcrash == 0.17 03:10:12 INFO - mozdebug == 0.1 03:10:12 INFO - mozdevice == 0.48 03:10:12 INFO - mozfile == 1.2 03:10:12 INFO - mozhttpd == 0.7 03:10:12 INFO - mozinfo == 0.9 03:10:12 INFO - mozleak == 0.1 03:10:12 INFO - mozlog == 3.3 03:10:12 INFO - moznetwork == 0.27 03:10:12 INFO - mozprocess == 0.23 03:10:12 INFO - mozprofile == 0.28 03:10:12 INFO - mozrunner == 6.12 03:10:12 INFO - mozscreenshot == 0.1 03:10:12 INFO - mozsystemmonitor == 0.3 03:10:12 INFO - moztest == 0.7 03:10:12 INFO - mozversion == 1.4 03:10:12 INFO - psutil == 3.1.1 03:10:12 INFO - requests == 1.2.3 03:10:12 INFO - wsgiref == 0.1.2 03:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:12 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')]} 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 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')]} 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:10:12 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 03:10:12 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 03:10:12 INFO - Using env: {'DISPLAY': ':0', 03:10:12 INFO - 'HOME': '/home/cltbld', 03:10:12 INFO - 'LANG': 'en_US.UTF-8', 03:10:12 INFO - 'LANGUAGE': 'en_US:en', 03:10:12 INFO - 'LOGNAME': 'cltbld', 03:10:12 INFO - 'MAIL': '/var/mail/cltbld', 03:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:12 INFO - 'MOZ_NO_REMOTE': '1', 03:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:12 INFO - 'NO_EM_RESTART': '1', 03:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:12 INFO - 'PWD': '/builds/slave/test', 03:10:12 INFO - 'SHELL': '/bin/bash', 03:10:12 INFO - 'SHLVL': '1', 03:10:12 INFO - 'TERM': 'linux', 03:10:12 INFO - 'TMOUT': '86400', 03:10:12 INFO - 'USER': 'cltbld', 03:10:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:12 INFO - '_': '/tools/buildbot/bin/python'} 03:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 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)) 03:10:12 INFO - Cleaning up... 03:10:12 INFO - Return code: 0 03:10:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:12 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')]} 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 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')]} 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 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 0x2857030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', '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 03:10:12 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 03:10:12 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 03:10:12 INFO - Using env: {'DISPLAY': ':0', 03:10:12 INFO - 'HOME': '/home/cltbld', 03:10:12 INFO - 'LANG': 'en_US.UTF-8', 03:10:12 INFO - 'LANGUAGE': 'en_US:en', 03:10:12 INFO - 'LOGNAME': 'cltbld', 03:10:12 INFO - 'MAIL': '/var/mail/cltbld', 03:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:12 INFO - 'MOZ_NO_REMOTE': '1', 03:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:12 INFO - 'NO_EM_RESTART': '1', 03:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:12 INFO - 'PWD': '/builds/slave/test', 03:10:12 INFO - 'SHELL': '/bin/bash', 03:10:12 INFO - 'SHLVL': '1', 03:10:12 INFO - 'TERM': 'linux', 03:10:12 INFO - 'TMOUT': '86400', 03:10:12 INFO - 'USER': 'cltbld', 03:10:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:12 INFO - '_': '/tools/buildbot/bin/python'} 03:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:12 INFO - Cleaning up... 03:10:12 INFO - Return code: 0 03:10:12 INFO - Running post-action listener: _resource_record_post_action 03:10:12 INFO - Running post-action listener: _start_resource_monitoring 03:10:12 INFO - Starting resource monitoring. 03:10:12 INFO - [mozharness: 2016-07-26 10:10:12.527841Z] Finished create-virtualenv step (success) 03:10:12 INFO - [mozharness: 2016-07-26 10:10:12.528276Z] Running install step. 03:10:12 INFO - Running pre-action listener: _resource_record_pre_action 03:10:12 INFO - Running main action method: install 03:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:12 INFO - Reading from file tmpfile_stdout 03:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:12 INFO - Reading from file tmpfile_stdout 03:10:12 INFO - Output received: 03:10:12 INFO - Usage: mozinstall [options] installer 03:10:12 INFO - Options: 03:10:12 INFO - -h, --help show this help message and exit 03:10:12 INFO - -d DEST, --destination=DEST 03:10:12 INFO - Directory to install application into. [default: 03:10:12 INFO - "/builds/slave/test"] 03:10:12 INFO - --app=APP Application being installed. [default: firefox] 03:10:12 INFO - mkdir: /builds/slave/test/build/application 03:10:12 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'] 03:10:12 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 03:10:30 INFO - Reading from file tmpfile_stdout 03:10:30 INFO - Output received: 03:10:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:30 INFO - Running post-action listener: _resource_record_post_action 03:10:30 INFO - [mozharness: 2016-07-26 10:10:30.102352Z] Finished install step (success) 03:10:30 INFO - [mozharness: 2016-07-26 10:10:30.102633Z] Running run-tests step. 03:10:30 INFO - Running pre-action listener: _resource_record_pre_action 03:10:30 INFO - Running main action method: run_tests 03:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:30 INFO - Python 2.7.3 03:10:30 INFO - Return code: 0 03:10:30 INFO - grabbing minidump binary from tooltool 03:10:30 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')]} 03:10:30 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 0x2b163b0>, '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 0x2b172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:30 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 03:10:30 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 03:10:30 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 03:10:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:30 INFO - Return code: 0 03:10:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:30 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/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 03:10:30 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/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 03:10:30 INFO - Using env: {'DISPLAY': ':0', 03:10:30 INFO - 'HOME': '/home/cltbld', 03:10:30 INFO - 'LANG': 'en_US.UTF-8', 03:10:30 INFO - 'LANGUAGE': 'en_US:en', 03:10:30 INFO - 'LOGNAME': 'cltbld', 03:10:30 INFO - 'MAIL': '/var/mail/cltbld', 03:10:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:30 INFO - 'MOZ_NO_REMOTE': '1', 03:10:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:30 INFO - 'NO_EM_RESTART': '1', 03:10:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:30 INFO - 'PWD': '/builds/slave/test', 03:10:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:30 INFO - 'SHELL': '/bin/bash', 03:10:30 INFO - 'SHLVL': '1', 03:10:30 INFO - 'TERM': 'linux', 03:10:30 INFO - 'TMOUT': '86400', 03:10:30 INFO - 'USER': 'cltbld', 03:10:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326', 03:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:30 INFO - '_': '/tools/buildbot/bin/python'} 03:10:30 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/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 03:10:30 INFO - mozversion application_buildid: 20160726002841 03:10:30 INFO - mozversion application_changeset: d7988da78c417062fd44170fe8881308b9803dbc 03:10:30 INFO - mozversion application_display_name: Nightly 03:10:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:30 INFO - mozversion application_name: Firefox 03:10:30 INFO - mozversion application_remotingname: firefox 03:10:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:10:30 INFO - mozversion application_vendor: Mozilla 03:10:30 INFO - mozversion application_version: 50.0a1 03:10:30 INFO - mozversion platform_buildid: 20160726002841 03:10:30 INFO - mozversion platform_changeset: d7988da78c417062fd44170fe8881308b9803dbc 03:10:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:10:30 INFO - mozversion platform_version: 50.0a1 03:10:30 INFO - using testdate: 1469527830 03:10:30 INFO - actual date: 1469527830 03:10:30 INFO - starting webserver on 'localhost:44085' 03:10:30 INFO - SUITE-START | Running 2 tests 03:10:30 INFO - TEST-START | dromaeo_css 03:10:30 INFO - operating with platform_type : linux_ 03:10:30 INFO - Initialising browser for dromaeo_css test... 03:10:30 INFO - TEST-INFO | started process 25710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthczQj/profile http://localhost:44085/getInfo.html) 03:10:33 INFO - PROCESS | 25710 | JavaScript error: , line 0: uncaught exception: undefined 03:10:34 INFO - PROCESS | 25710 | __metrics Screen width/height:1600/1200 03:10:34 INFO - PROCESS | 25710 | colorDepth:24 03:10:34 INFO - PROCESS | 25710 | Browser inner width/height: 1024/697 03:10:34 INFO - PROCESS | 25710 | __metrics 03:10:35 INFO - PROCESS | 25710 | 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" 03:10:35 INFO - PROCESS | 25710 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:35 INFO - PROCESS | 25710 | console.error: PushService: 03:10:35 INFO - PROCESS | 25710 | stateChangeProcessEnqueue: Error transitioning state 03:10:35 INFO - PROCESS | 25710 | UnknownError 03:10:36 INFO - TEST-INFO | 25710: exit 0 03:10:36 INFO - Browser initialized. 03:10:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:36 INFO - TEST-INFO | started process 25796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthczQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:48 INFO - PROCESS | 25796 | RSS: Main: 158093312 03:10:48 INFO - PROCESS | 25796 | 03:11:39 INFO - PROCESS | 25796 | 1469527899810 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] 03:13:47 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44085/tests/dromaeo/cssquery-ext.html) 03:13:48 INFO - PROCESS | 25796 | RSS: Main: 257175552 03:13:48 INFO - PROCESS | 25796 | 03:16:51 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-ext.html (next: http://localhost:44085/tests/dromaeo/cssquery-jquery.html) 03:16:51 INFO - PROCESS | 25796 | RSS: Main: 250421248 03:16:51 INFO - PROCESS | 25796 | 03:19:53 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44085/tests/dromaeo/cssquery-mootools.html) 03:19:54 INFO - PROCESS | 25796 | RSS: Main: 184057856 03:19:54 INFO - PROCESS | 25796 | 03:22:56 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44085/tests/dromaeo/cssquery-prototype.html) 03:22:56 INFO - PROCESS | 25796 | RSS: Main: 238936064 03:22:56 INFO - PROCESS | 25796 | 03:25:59 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44085/tests/dromaeo/cssquery-yui.html) 03:26:00 INFO - PROCESS | 25796 | RSS: Main: 187609088 03:26:00 INFO - PROCESS | 25796 | 03:29:02 INFO - PROCESS | 25796 | Cycle 1(1): loaded http://localhost:44085/tests/dromaeo/cssquery-yui.html (next: http://localhost:44085/tests/dromaeo/cssquery-dojo.html) 03:29:03 INFO - PROCESS | 25796 | RSS: Main: 264757248 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | __start_tp_report 03:29:03 INFO - PROCESS | 25796 | _x_x_mozilla_page_load 03:29:03 INFO - PROCESS | 25796 | _x_x_mozilla_page_load_details 03:29:03 INFO - PROCESS | 25796 | |i|pagename|runs| 03:29:03 INFO - PROCESS | 25796 | |0;dojo.html;3065.5401689746536;3071.0786763970805;3073;3116.922076948076;3131.060681795462;5252.395974462938;5335.706536140511;5383.138697808351;5478.643888147268;5485.341758988922;5368.355797304329;5409.891802163955;5454.045542030139;5463.3717122530925;5502.0371434998915;4844.5882100021545;4938.827141050064;4943.678660887049;4958.330625365584;5124.359455068116;5025.572826309768;5054.620903432257;5074.568661663745;5091.745412729368;5093.643444958854;4864.416270047582;4895.069936712049;4900.436449808264;4936.33359496467;4987.650864439473;4888.388951381077;4891.217405215184;4897.363342765418;5034.219695947134;5037.0429618372755;4906.264060390934;4968.73415582221;4971.488954462101;4992.625553083533;4998.600111991032;5297.576193904479;5404.189371594253;5488.862778430531;5492.780288788444;5541.9168712469345;5793.855153621151;5880.882382352372;5889.057750759901;5893.823185304448;5895.322037965646;5855.677937713424;5858.062709966385;5924.496417804492;5930.347661757203;5931.614445061057;5249.921251181236;5402.108652072443;5417.106177480671;5526.972365138189;5528.889422211573;5963.582549221513;5964.7315870785915;6000.969995149996;6020.127081573148;6020.939790602038;5684.317881854204;5707.1153971134545;5707.571932105108;5752.626079304831;5754.712264386764;5621.4659607337235;5738.426157384228;5795.0727883539275;5834.299884013945;5846.123081537803;5824.912626310609;5867;5867.471927526458;5870.882582348415;5871.765129394862;5771.220885180531;5804.535637149018;5809.867075920155;5823.010088285002;5859.794907178229;4341.218580655449;4410.33844923264;4456.910861782746;4466.218411777926;4502.032063106448;3893.6106389361403;3939.1924655446137;3965.385365268388;3976.701747368959;3999.3601023836045;5562.443755624486;5576.1356989666665;5593.916091258634;5596.944030559724;5643.746031428595;5684.857878553069;5896.764129434775;5913.231279933667;5927;5979.790707325223;5505.587080968943;5555.2500412444615;5565.220869078333;5617.988762022876;5638.943610563924;5054.49455054499;5071.87320316995;5073.594112470993;5082.415522214993;5085.0338435697095;6098.32918378978;6104.023356263066;6106.969465152646;6109.694515274218;6121.540884433596;5668.51817595509;5826.883462330645;5868.853278668067;5893.9685555026845;5994.760209591567;5971.522278217645;5988.940110598838;5993.041113421831;5994.70026498682;5997.430244126801;5631.465010823965;5700.885982280248;5703.030484817674;5706.144078388275;5707.743151558273;5670.461306175906;5801.535877129904;5809.2738407699035;5837.591368604157;5910.1134829774155;5739.368669446441;5745.798897038583;5746.965546201724;5752.252207213203;5753.1370294456165;5721.427857214246;5729.799457018984;5733.799317023884;5734.2258795062135;5735.197072409783;5533.474319939599;5628;5637.098064309691;5639.3232812062815;5743.310802703702;5767.163761254511;5793.971030144822;5818.796342128006;5820.5925585210325;5825.94174058254;5659.603827732019;5665.178549110274;5667.03660377745;5667.376588575171;5675.943240567707 03:29:03 INFO - PROCESS | 25796 | |1;ext.html;585.9970700146501;600.3036477685883;626.8401557602812;637.4613451633368;642.6369101457673;31597.842010789944;44592.33111503326;45420.77289613555;45626.771866140625;45645.77177114114;45986;46148;46250.537494625045;46305.53694463063;46405;8938.642454301837;9070.909290907106;9074.63701451941;9078.500682462462;9078.954605226998;8949.284057275403;9015.27877769777;9032.729018129434;9042;9049.3665443419;9004.369694121415;9072.501012444312;9086.818263634756;9123.726288211332;9125.315601329894;8892.510911899843;8937.106289371011;8942.821143577125;8956.910430895672;8964.731058068202;8794.780130496725;8937.73186804397;8959.776005599848;8966.058563850767;8967;43637.345439818426;43828.3425748614;44044.33933491;44067.77966110149;44081.77959110216;3457.135716070982;3535;3607.332643460968;4142.91714165715;4355.825766969318;33575.160620984425;34028.82985585056;34134.31731365384;34609.826950865085;35065.29869402598;4257.701960862741;4345.217860785057;4404.273294906368;4412.0955204183065;4612.100640375128;385434.07282963686;386131;386492;388239;388360;35284.64715352865;36176;60598.394016060156;60665.393346065975;61100;37339.25321493555;37484.625153748115;37509.249815003546;37564.62435375666;37569.43645845314;15724.606884827743;15830.208489575476;15832.525024249291;15833.050016999017;15862.286197121157;13352.265625390697;13440.865591343962;13442.395092220873;13444.395002224923;13447.394867230802;8381.455205411628;8477.915220847835;8480.194381533744;8526.275266602408;8554.101819309008;3302.1579497228054;3315.4529502632276;3327.351166522505;3336.632970373257;3342.8829990950685;1023.7594165371132;1078.703356576932;1100.862392200975;1131.3438205840594;1210.425048102162;32391.35217295641;33397.3320533588;33747;34000.31999359999;34207.14482137917;1149.1611123879616;1154.5381847261162;1194.892459678633;1203.48851738011;1203.8615559210627;16673.583160420843;17650.23987775425;17688.380906668204;17771;17872.28510859577;599894;607732;607769;608727;609498;61878;62359;62509.68745156245;62666.68666656638;62770;1250.493550112206;1349.8380194376737;1388.6181300142541;1417.4188582681052;1421.9431222751182;32528.83735581307;34635.48046779351;34864.65135348614;35019.0078261684;35501;52203;52563;52677;52795.47204528059;52922;401390;401649;401727;402419.7822196016;403549;28412.147635570967;29565.85217073901;29806.403871922874;29866.402671946875;29889;49330.50669493259;50531;51001;51248.23127653014;51475;43102;43184.46563110828;43228.56771432245;43714;45472.31791523063;41438.58561414347;42601.786991064844;43244.56755432405;43951.78024109859;44378.334324984506;42081;42959.355609665254;43716.781416092716;43833.56166438422;44620.33069503895;35818;36862.44706329461;38582.861003343016;38710;39418.605813941496;27797.16608501748;29455.410891781616;29563.704362956094;29628.111156665334;29842 03:29:03 INFO - PROCESS | 25796 | |2;jquery.html;376.22122207031424;398.7786778338023;400.5573840905799;401.8633664554051;419.8341655046257;14521.854781452183;18049.278028878845;20171.29400470984;20215.49461263469;20352.898235508837;19551.902240488813;20118.09468573914;20127.094280757363;20313.796862031377;20437.386878393634;5525.806596769114;5641.68970706611;5811.651300921958;5863.560232982522;5863.824085277449;5809;5823;5840.561957853157;5846.678432686201;5850.210221620091;5737.512311453532;5824.796132135376;6543.705533250992;6637.601743895381;6689;5962.493188078975;6662.267150613428;6666.400023997815;6722.764703235388;6725;5655.773769049233;5697.03150464422;5697.943020569783;5703.7148142592705;5707.3721890592005;14565.126092434488;15026.699466010728;23039.654405183937;24112.75887241123;24625.38436539083;2189.1462329691435;2203.6143674856835;2278.054607337953;2309.06214869127;2375.543584085152;10513.632022879163;10514.21143414247;10612.469376531142;10743.194260430499;10832.079273261703;1857.1085878778263;1914.5309399197147;1922.865399422041;1939.6217737541185;1979.5150188203982;86915;86955;88466;88612.5569372149;89509;11058.723531911766;11123.666290011313;11290.661280161608;11358.716032099099;11432.256903301259;15727.292271847795;15777.842221577866;15786.105667319995;15818.130002849954;15827;8179.672813087529;8404.8319033619;8417.284530814826;8578.828423431622;8654.524001179996;7805.765827025199;7856.764297071097;7882.290593846581;8054.959725201454;8158.959205203936;4643.442786865598;4737.28940658897;4812.51874812516;4857.271409288564;4959.479254678279;1925.9614807703767;1986.7814540400545;2006.5786184901042;2022.1304838919407;2037.7350944377433;840.4915026408935;892.7946572288411;963.450833025183;1050.5115121468555;1074.033369967036;19270.90364548196;20221.49446263855;20455.488612784502;21574;21639.13443462244;1015.4059874973076;1015.9136473399695;1034.906858382749;1035.8756949165997;1060.8726952765717;10657.733556661145;11523.423828808525;11583.826242606368;11626.186166968231;11648;409052;413800;415258;541395;545360;78813.23508221;98552.50723746336;99060;103904.48047759713;105836;1013.2046343620223;1036.528379587286;1040.167865707431;1054.4991129213715;1054.6572363981736;17596.120193989995;17745.46763597094;18402.447926562225;18411.907940460213;18484.72272915934;33281;34410.48384274288;43401.56598433975;43576.56423435852;44827.32759008552;62466;63344;64303.67848160916;64487.67756161189;67021;8275.462094963808;8473.745787626382;8484.660613575388;8651.913480865363;9090.318226132935;12637.2417654941;12637.93681031589;13239.550683123653;14001.92999035039;14304;11641.185117041725;11698.649040528799;11796.115291353011;11911.702207444536;12261.570845020382;11895.94036115507;11954.641360759191;12018.218815776947;12089.455974480994;12136.271823690608;11892.405379731152;12146.75706485883;12180;12257;12514.31171285588;7725.22747725223;8081.676732930617;8915.108489151033;9025.729228123168;9100.954495227481;11414.086873050303;11807.704807379541;11992.220505667105;12035.277883327028;12100.334481603597 03:29:03 INFO - PROCESS | 25796 | |3;mootools.html;1478.5638236720163;1525.5804653720227;1653;1741.4601473543194;1778.3509019207993;8777.078406767285;9231.723048308544;9360.578773955163;9367.250619950404;9384.906150938488;7718.382529397649;8608.26829719473;8901.955490222539;8955.686550970717;9021.142991415822;2348.5772560939026;2407.157494876788;2411.0837881604966;2411.5176964607062;2413.6741539892155;2357.2928121563464;2387.5224955009066;2436.427439551704;2440.4264997725522;2441.389652586853;2077.366403247009;2134.6797980303;2135.6476181430044;2145.1633862793524;2347.225415612844;2379.119725701493;2400.6519054736964;2418.6734790803193;2420.92737217882;2424.684790977179;2382.1781485387514;2399.1003373734848;2400.255920664582;2403.2189538399916;2406.2540612410035;8911.821763564758;8922.375433719642;8928.06255343186;8957.328200384996;8998.685046023358;5345.518903298722;5519.724013799294;5568.554515638739;5608;5612.550995920316;3397.3035527717007;3540.964590354089;3587.9282414351565;3605.9278814423565;3608.657177568127;1138.1805100327751;1177.8233265010317;1187.554666999875;1194.7072967123024;1219.5609580550995;12253.632391028283;12339.444724987397;12348.753024939451;12618.432170552256;12681.556145534862;4896.657233993657;4913.0173965207105;4927.310176575283;4965.255211718271;5047.747612619428;10902.781944361068;10979.890201097887;10984.670459886056;11001.504932278067;11006.779864402668;5530.889382212334;5535.557155427556;5542.057850165482;5542.39033706292;5543.501084902378;4955.702657840541;5094.57351941457;5097.057044446715;5117.974410127926;5150.690958542499;3926;3959.742616729903;3996.200759848042;4036.0918793271867;4040.7575545467366;1282.0512820512754;1298.9805152922713;1308.2935214983993;1318.4067169773448;1325.350578216667;915.9908400915906;981.8134554434635;1012.8430093335545;1017.0897047142913;1033.1270076785104;6115.266168059772;6337.4613157882095;6343.207099112611;6344.746210151542;6444.291127975919;457.11776271795753;457.80085662736815;464.844277167146;466.08414465575305;466.16323698960446;4310.590493903074;4414.536473670282;4419.027813880941;4442.311441726538;4486.439195100613;11265.15511336653;11537.307761534335;11625.12811539121;11647.41762911868;11657.883421165849;10686.465676716289;11054.613088541862;11070.225084244026;11553.942230288794;11577.247478913843;8413.621387037598;8573.014103378067;8573.356998225157;8585.527795971282;8591.785205369915;6283.685815709287;6321.5258855586935;6345.270293916259;6390.169277993831;6665.633390163587;10142.949285253526;10517;10519.421431821323;10666.89333106659;10672.413017284123;10799;10901.945490272816;10905.18211134184;10906.236563440483;10922.617708380169;8238.423310368216;8309.750707478785;8391.076981531905;8391.202835730595;8413.07456179832;8672.739817805475;8715.782105447415;8819.470831750115;8827.24968377695;8833.29333653319;7660.655270512729;7818.687252509836;7959.124496305286;8017.358611310964;8084.959575202086;7629.885551716618;7636.312731853937;7709.537427754352;7764.805879853049;7962.163972782774;7173.677184526813;7183.820404489929;7191.42468602521;7248.782536523701;7289.5261807982315;5451.809186678447;5520.806771762969;5593.580481463988;5599.496045355938;5787.160861675117;5385.892282154413;5578.63738856973;5626;5673.290838645169;5702.800401985911 03:29:03 INFO - PROCESS | 25796 | |4;prototype.html;323.39363693075484;333.6162529988666;340.08686676274203;342.7035614193723;349.43391705437193;5029.1199040168;5217.825989152444;5306.336707911511;5329.173978033401;5331.386890507592;4993.4257560380565;5177.974110129454;5282.947170528294;5288.629795914288;5294.338207724035;4094.6219369020528;4107.13750112476;4111.342185250361;4113.506379234481;4121.340585506319;3966.5636779954184;4039.4142849286836;4078.286299897521;4083.8570650027104;4100.712950093494;4058.168075544521;4085.3259212229946;4090.836366545335;4092.7135100542973;4104.979475102636;4099.036726369301;4114.547399786021;4115.423840662324;4117.855875044359;4127.195196936598;3467.583889933199;3630.3283892479976;3647.434647629622;3649.543807024122;3657.9451308230396;5106.540411362958;5107.361579802525;5109.565686916617;5120.641555091145;5153.948460515385;4692.741899195543;4696.436427628706;4704;4708.929366059512;4722.881927951795;5222.817201397971;5449.64577302474;5506.256655351556;5518.2826232589905;5521.723913804293;3953.3872249801325;3961.6830653547936;3975.542812576533;3976.1848820991627;3979.422983667381;5650.491455769001;5674.943250567483;5681.801136960228;5682.886342273173;5713.771449142029;3921.745086569364;4018.6985976051915;4021.3766866135797;4031.879043628696;4070.816813243411;4040.1717647882115;4096.283150448719;4104.938425923614;4110.568390319033;4120.423140760296;4485.125400546862;4545.2954792007295;4603.148417542765;4632.513586073481;4644.349791029259;5426.620136590401;5454.191091587835;5458.836234912879;5466;5508.531774799107;1401.2363262022222;1422.9644258893404;1428.8856891448659;1430.3134495442039;1438.3527412664344;942.9815798937132;983.9212862970945;988.649029594498;992.8560358748085;995.7809281957958;5291.391489978701;5295.258663787073;5301.640769857377;5315.654482458628;5325.4142044375085;5599.188117722989;5638.351589567253;5642.153676948408;5645.80239691617;5664.348599911063;5194.68831870089;5249.97625463031;5269.683818970874;5283.1546952487415;5307.62846600742;2929.487339715541;2935.207493976657;2942.911712648624;2953.5126704094014;2964.985175074111;5475.780968761284;5670.121131224667;5740.818488974163;5747;5759.819237056394;5585.413531579125;5593.804216852391;5594.9720251398485;5607.41122182165;5636.915446268309;5646.520045796071;5680.488756011896;5681.147827825859;5708.857278568069;5739.942600573941;5369.436209197978;5457.290552228185;5509.531689806251;5518.227448157341;5553.527950124123;5427.077396842626;5482.205080263419;5488.615796894179;5493.862653433536;5498.5876059294915;5465.371482279589;5621.156826476062;5697.601167918372;5728.914066289092;5751.281089863767;3998.7600743955454;4018.6336645540655;4023.9195216094927;4041.91916161681;4058.857939972087;5371.274877891435;5371.382291036424;5535.778568857361;5570.860728481658;5577.637453565505;5392.487713667196;5394.136938089887;5433.174749130509;5451.563874890078;5469.863253418537;5417.8103766367985;5429.619926605258;5451.264079349396;5457.317835270591;5486;5177.8187763428095;5342.278792363137;5377.327834020747;5406.540444062299;5408.37748675388;5431.456854314695;5450.291462109901;5459.590530710292;5477.808276710455;5483;5262.605304602093;5287.462018231194;5327.573794096541;5381.304888959965;5382.757775900016 03:29:03 INFO - PROCESS | 25796 | |5;yui.html;729.9598522081284;748.6256871564218;766.6358479722132;772.9265719756623;877.8595424732042;15484;16273.430429934955;16691.499255022354;16729.247183876723;16738.497845064652;14540.781888271684;14667.706645867076;14816.333265003073;14855.480058197965;14892.851071489282;679.619413128647;806.0810675829545;826.8553003224441;827.7475370012144;827.7847759582522;801.7193982106274;822.268181318627;824.1552408780988;826.4710585225461;827.2513375395276;861.0356400831047;861.9698310559131;862.0904945282724;862.3230763850379;864.3042350907548;695.0755495191383;854.4915775113798;855.8117214212863;856.6616186606318;857.9485230886136;610.6031079798122;626.9968650156766;627.9277883043463;628.1802248066272;629.0784001437916;14291.57125286243;14335;14361;14366.13803171813;14413.063150895157;13922.37349319273;14173.503927362493;14599.78100328496;14601.196934168616;14815.703685926328;12620.55828046023;12818.871811281955;13222.537211197658;13414;13590.116642418212;4463.285874260136;4500.7299562026055;4503.459584849807;4580.0152967112235;4609.331646911212;79236;80674.5966270165;80837;81912;82961.17038829594;11241.662750117346;11324.32054076758;11426.942865285786;11547.018503427134;11699.941500292443;20742.481437964172;22299.665505017438;22366.77633223647;22388.32835014952;22425.21511747081;8698.34762392823;8917.687880924137;9021.909780902108;9029.097090290918;9041.90958090424;4827.541383568555;4844.854654360375;4927.9507204927495;4956.330895329156;5000.199968005102;3404.097914052778;3497.650234976482;3500.387432199355;3503.9474407883904;3506.807125608116;671.4963777167125;675.4191395399952;700.4221517248291;705.7847356556197;711.3846522757881;615.2063837649472;636.4367534731796;683.255251775567;722.663961258007;723.2297603052732;9874.753131171778;10139.7465063374;10429.9478502607;10809.135269178447;10932.289401188897;639.5619000984341;682.3483573187594;689.5414549324643;697.2881575731567;755.3768141283463;4449.399331090326;4748.169070412733;4753.453352864396;4788.754923719858;4818.879528011757;71643;75173;122974.62817147856;125685;134328;66135;91864.54067729619;111295.44352278186;111607;114011;59164;59892.401075989554;65638;97323;102143.48928255311;8936.46381217103;9168.174864262248;9245.861312080458;9246.0753924607;9301.813963720822;57439.712801437396;58664.120038198605;59178;59434;59847.40152598418;85530;86163.56918215369;87440;88476.5576172115;89430;11681.707957300796;11778.528858845893;11804.20780594404;12042.879571204527;12341.382930853242;13854.376553054935;14179.574612761633;14274.429022838971;14519;14521.491747788778;13116.278604676452;13124.40940157676;13443.89308785237;13447.193168409927;13886.444542218198;12816.743665126458;13070.281134537692;13394.732105358033;14314;14719.411223551366;14653;14744.410223590936;15365.231738413258;16069.035857848567;16135.435259765853;11524.423778811193;12229.205101668364;12313.322767247888;12584.874151258371;12657.746845063231;12576.434060467118;12788.936055319664;12856.164349317265;12877.42114549663;12928.547500837425 03:29:03 INFO - PROCESS | 25796 | __end_tp_report 03:29:03 INFO - PROCESS | 25796 | __start_cc_report 03:29:03 INFO - PROCESS | 25796 | _x_x_mozilla_cycle_collect,942 03:29:03 INFO - PROCESS | 25796 | __end_cc_report 03:29:03 INFO - PROCESS | 25796 | __startTimestamp1469528943086__endTimestamp 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | ------- Summary: start ------- 03:29:03 INFO - PROCESS | 25796 | Number of tests: 6 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#0] dojo.html Cycles:165 Average:5428.03 Median:5665.18 stddev:630.14 (11.1%) stddev-sans-first:604.20 03:29:03 INFO - PROCESS | 25796 | Values: 3065.5 3071.1 3073.0 3116.9 3131.1 5252.4 5335.7 5383.1 5478.6 5485.3 5368.4 5409.9 5454.0 5463.4 5502.0 4844.6 4938.8 4943.7 4958.3 5124.4 5025.6 5054.6 5074.6 5091.7 5093.6 4864.4 4895.1 4900.4 4936.3 4987.7 4888.4 4891.2 4897.4 5034.2 5037.0 4906.3 4968.7 4971.5 4992.6 4998.6 5297.6 5404.2 5488.9 5492.8 5541.9 5793.9 5880.9 5889.1 5893.8 5895.3 5855.7 5858.1 5924.5 5930.3 5931.6 5249.9 5402.1 5417.1 5527.0 5528.9 5963.6 5964.7 6001.0 6020.1 6020.9 5684.3 5707.1 5707.6 5752.6 5754.7 5621.5 5738.4 5795.1 5834.3 5846.1 5824.9 5867.0 5867.5 5870.9 5871.8 5771.2 5804.5 5809.9 5823.0 5859.8 4341.2 4410.3 4456.9 4466.2 4502.0 3893.6 3939.2 3965.4 3976.7 3999.4 5562.4 5576.1 5593.9 5596.9 5643.7 5684.9 5896.8 5913.2 5927.0 5979.8 5505.6 5555.3 5565.2 5618.0 5638.9 5054.5 5071.9 5073.6 5082.4 5085.0 6098.3 6104.0 6107.0 6109.7 6121.5 5668.5 5826.9 5868.9 5894.0 5994.8 5971.5 5988.9 5993.0 5994.7 5997.4 5631.5 5700.9 5703.0 5706.1 5707.7 5670.5 5801.5 5809.3 5837.6 5910.1 5739.4 5745.8 5747.0 5752.3 5753.1 5721.4 5729.8 5733.8 5734.2 5735.2 5533.5 5628.0 5637.1 5639.3 5743.3 5767.2 5794.0 5818.8 5820.6 5825.9 5659.6 5665.2 5667.0 5667.4 5675.9 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#1] ext.html Cycles:180 Average:61887.75 Median:42780.57 stddev:126684.46 (296.1%) stddev-sans-first:126956.24 03:29:03 INFO - PROCESS | 25796 | Values: 586.0 600.3 626.8 637.5 642.6 31597.8 44592.3 45420.8 45626.8 45645.8 45986.0 46148.0 46250.5 46305.5 46405.0 8938.6 9070.9 9074.6 9078.5 9079.0 8949.3 9015.3 9032.7 9042.0 9049.4 9004.4 9072.5 9086.8 9123.7 9125.3 8892.5 8937.1 8942.8 8956.9 8964.7 8794.8 8937.7 8959.8 8966.1 8967.0 43637.3 43828.3 44044.3 44067.8 44081.8 3457.1 3535.0 3607.3 4142.9 4355.8 33575.2 34028.8 34134.3 34609.8 35065.3 4257.7 4345.2 4404.3 4412.1 4612.1 385434.1 386131.0 386492.0 388239.0 388360.0 35284.6 36176.0 60598.4 60665.4 61100.0 37339.3 37484.6 37509.2 37564.6 37569.4 15724.6 15830.2 15832.5 15833.1 15862.3 13352.3 13440.9 13442.4 13444.4 13447.4 8381.5 8477.9 8480.2 8526.3 8554.1 3302.2 3315.5 3327.4 3336.6 3342.9 1023.8 1078.7 1100.9 1131.3 1210.4 32391.4 33397.3 33747.0 34000.3 34207.1 1149.2 1154.5 1194.9 1203.5 1203.9 16673.6 17650.2 17688.4 17771.0 17872.3 599894.0 607732.0 607769.0 608727.0 609498.0 61878.0 62359.0 62509.7 62666.7 62770.0 1250.5 1349.8 1388.6 1417.4 1421.9 32528.8 34635.5 34864.7 35019.0 35501.0 52203.0 52563.0 52677.0 52795.5 52922.0 401390.0 401649.0 401727.0 402419.8 403549.0 28412.1 29565.9 29806.4 29866.4 29889.0 49330.5 50531.0 51001.0 51248.2 51475.0 43102.0 43184.5 43228.6 43714.0 45472.3 41438.6 42601.8 43244.6 43951.8 44378.3 42081.0 42959.4 43716.8 43833.6 44620.3 35818.0 36862.4 38582.9 38710.0 39418.6 27797.2 29455.4 29563.7 29628.1 29842.0 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#2] jquery.html Cycles:180 Average:28911.81 Median:11914.14 stddev:77872.90 (653.6%) stddev-sans-first:78061.88 03:29:03 INFO - PROCESS | 25796 | Values: 376.2 398.8 400.6 401.9 419.8 14521.9 18049.3 20171.3 20215.5 20352.9 19551.9 20118.1 20127.1 20313.8 20437.4 5525.8 5641.7 5811.7 5863.6 5863.8 5809.0 5823.0 5840.6 5846.7 5850.2 5737.5 5824.8 6543.7 6637.6 6689.0 5962.5 6662.3 6666.4 6722.8 6725.0 5655.8 5697.0 5697.9 5703.7 5707.4 14565.1 15026.7 23039.7 24112.8 24625.4 2189.1 2203.6 2278.1 2309.1 2375.5 10513.6 10514.2 10612.5 10743.2 10832.1 1857.1 1914.5 1922.9 1939.6 1979.5 86915.0 86955.0 88466.0 88612.6 89509.0 11058.7 11123.7 11290.7 11358.7 11432.3 15727.3 15777.8 15786.1 15818.1 15827.0 8179.7 8404.8 8417.3 8578.8 8654.5 7805.8 7856.8 7882.3 8055.0 8159.0 4643.4 4737.3 4812.5 4857.3 4959.5 1926.0 1986.8 2006.6 2022.1 2037.7 840.5 892.8 963.5 1050.5 1074.0 19270.9 20221.5 20455.5 21574.0 21639.1 1015.4 1015.9 1034.9 1035.9 1060.9 10657.7 11523.4 11583.8 11626.2 11648.0 409052.0 413800.0 415258.0 541395.0 545360.0 78813.2 98552.5 99060.0 103904.5 105836.0 1013.2 1036.5 1040.2 1054.5 1054.7 17596.1 17745.5 18402.4 18411.9 18484.7 33281.0 34410.5 43401.6 43576.6 44827.3 62466.0 63344.0 64303.7 64487.7 67021.0 8275.5 8473.7 8484.7 8651.9 9090.3 12637.2 12637.9 13239.6 14001.9 14304.0 11641.2 11698.6 11796.1 11911.7 12261.6 11895.9 11954.6 12018.2 12089.5 12136.3 11892.4 12146.8 12180.0 12257.0 12514.3 7725.2 8081.7 8915.1 9025.7 9101.0 11414.1 11807.7 11992.2 12035.3 12100.3 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#3] mootools.html Cycles:180 Average:6033.89 Median:465.46 stddev:3444.00 (739.9%) stddev-sans-first:3436.65 03:29:03 INFO - PROCESS | 25796 | Values: 1478.6 1525.6 1653.0 1741.5 1778.4 8777.1 9231.7 9360.6 9367.3 9384.9 7718.4 8608.3 8902.0 8955.7 9021.1 2348.6 2407.2 2411.1 2411.5 2413.7 2357.3 2387.5 2436.4 2440.4 2441.4 2077.4 2134.7 2135.6 2145.2 2347.2 2379.1 2400.7 2418.7 2420.9 2424.7 2382.2 2399.1 2400.3 2403.2 2406.3 8911.8 8922.4 8928.1 8957.3 8998.7 5345.5 5519.7 5568.6 5608.0 5612.6 3397.3 3541.0 3587.9 3605.9 3608.7 1138.2 1177.8 1187.6 1194.7 1219.6 12253.6 12339.4 12348.8 12618.4 12681.6 4896.7 4913.0 4927.3 4965.3 5047.7 10902.8 10979.9 10984.7 11001.5 11006.8 5530.9 5535.6 5542.1 5542.4 5543.5 4955.7 5094.6 5097.1 5118.0 5150.7 3926.0 3959.7 3996.2 4036.1 4040.8 1282.1 1299.0 1308.3 1318.4 1325.4 916.0 981.8 1012.8 1017.1 1033.1 6115.3 6337.5 6343.2 6344.7 6444.3 457.1 457.8 464.8 466.1 466.2 4310.6 4414.5 4419.0 4442.3 4486.4 11265.2 11537.3 11625.1 11647.4 11657.9 10686.5 11054.6 11070.2 11553.9 11577.2 8413.6 8573.0 8573.4 8585.5 8591.8 6283.7 6321.5 6345.3 6390.2 6665.6 10142.9 10517.0 10519.4 10666.9 10672.4 10799.0 10901.9 10905.2 10906.2 10922.6 8238.4 8309.8 8391.1 8391.2 8413.1 8672.7 8715.8 8819.5 8827.2 8833.3 7660.7 7818.7 7959.1 8017.4 8085.0 7629.9 7636.3 7709.5 7764.8 7962.2 7173.7 7183.8 7191.4 7248.8 7289.5 5451.8 5520.8 5593.6 5599.5 5787.2 5385.9 5578.6 5626.0 5673.3 5702.8 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#4] prototype.html Cycles:180 Average:4597.14 Median:5294.80 stddev:1329.38 (25.1%) stddev-sans-first:1293.83 03:29:03 INFO - PROCESS | 25796 | Values: 323.4 333.6 340.1 342.7 349.4 5029.1 5217.8 5306.3 5329.2 5331.4 4993.4 5178.0 5282.9 5288.6 5294.3 4094.6 4107.1 4111.3 4113.5 4121.3 3966.6 4039.4 4078.3 4083.9 4100.7 4058.2 4085.3 4090.8 4092.7 4105.0 4099.0 4114.5 4115.4 4117.9 4127.2 3467.6 3630.3 3647.4 3649.5 3657.9 5106.5 5107.4 5109.6 5120.6 5153.9 4692.7 4696.4 4704.0 4708.9 4722.9 5222.8 5449.6 5506.3 5518.3 5521.7 3953.4 3961.7 3975.5 3976.2 3979.4 5650.5 5674.9 5681.8 5682.9 5713.8 3921.7 4018.7 4021.4 4031.9 4070.8 4040.2 4096.3 4104.9 4110.6 4120.4 4485.1 4545.3 4603.1 4632.5 4644.3 5426.6 5454.2 5458.8 5466.0 5508.5 1401.2 1423.0 1428.9 1430.3 1438.4 943.0 983.9 988.6 992.9 995.8 5291.4 5295.3 5301.6 5315.7 5325.4 5599.2 5638.4 5642.2 5645.8 5664.3 5194.7 5250.0 5269.7 5283.2 5307.6 2929.5 2935.2 2942.9 2953.5 2965.0 5475.8 5670.1 5740.8 5747.0 5759.8 5585.4 5593.8 5595.0 5607.4 5636.9 5646.5 5680.5 5681.1 5708.9 5739.9 5369.4 5457.3 5509.5 5518.2 5553.5 5427.1 5482.2 5488.6 5493.9 5498.6 5465.4 5621.2 5697.6 5728.9 5751.3 3998.8 4018.6 4023.9 4041.9 4058.9 5371.3 5371.4 5535.8 5570.9 5577.6 5392.5 5394.1 5433.2 5451.6 5469.9 5417.8 5429.6 5451.3 5457.3 5486.0 5177.8 5342.3 5377.3 5406.5 5408.4 5431.5 5450.3 5459.6 5477.8 5483.0 5262.6 5287.5 5327.6 5381.3 5382.8 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - PROCESS | 25796 | [#5] yui.html Cycles:180 Average:21179.13 Median:4594.67 stddev:30453.62 (662.8%) stddev-sans-first:30500.34 03:29:03 INFO - PROCESS | 25796 | Values: 730.0 748.6 766.6 772.9 877.9 15484.0 16273.4 16691.5 16729.2 16738.5 14540.8 14667.7 14816.3 14855.5 14892.9 679.6 806.1 826.9 827.7 827.8 801.7 822.3 824.2 826.5 827.3 861.0 862.0 862.1 862.3 864.3 695.1 854.5 855.8 856.7 857.9 610.6 627.0 627.9 628.2 629.1 14291.6 14335.0 14361.0 14366.1 14413.1 13922.4 14173.5 14599.8 14601.2 14815.7 12620.6 12818.9 13222.5 13414.0 13590.1 4463.3 4500.7 4503.5 4580.0 4609.3 79236.0 80674.6 80837.0 81912.0 82961.2 11241.7 11324.3 11426.9 11547.0 11699.9 20742.5 22299.7 22366.8 22388.3 22425.2 8698.3 8917.7 9021.9 9029.1 9041.9 4827.5 4844.9 4928.0 4956.3 5000.2 3404.1 3497.7 3500.4 3503.9 3506.8 671.5 675.4 700.4 705.8 711.4 615.2 636.4 683.3 722.7 723.2 9874.8 10139.7 10429.9 10809.1 10932.3 639.6 682.3 689.5 697.3 755.4 4449.4 4748.2 4753.5 4788.8 4818.9 71643.0 75173.0 122974.6 125685.0 134328.0 66135.0 91864.5 111295.4 111607.0 114011.0 59164.0 59892.4 65638.0 97323.0 102143.5 8936.5 9168.2 9245.9 9246.1 9301.8 57439.7 58664.1 59178.0 59434.0 59847.4 85530.0 86163.6 87440.0 88476.6 89430.0 11681.7 11778.5 11804.2 12042.9 12341.4 13854.4 14179.6 14274.4 14519.0 14521.5 13116.3 13124.4 13443.9 13447.2 13886.4 12816.7 13070.3 13394.7 14314.0 14719.4 14653.0 14744.4 15365.2 16069.0 16135.4 11524.4 12229.2 12313.3 12584.9 12657.7 12576.4 12788.9 12856.2 12877.4 12928.5 03:29:03 INFO - PROCESS | 25796 | -------- Summary: end -------- 03:29:03 INFO - PROCESS | 25796 | 03:29:03 INFO - TEST-INFO | 25796: exit 0 03:29:03 INFO - TEST-OK | dromaeo_css | took 1113442ms 03:29:03 INFO - TEST-START | kraken 03:29:03 INFO - operating with platform_type : linux_ 03:29:03 INFO - Initialising browser for kraken test... 03:29:03 INFO - TEST-INFO | started process 25986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6m_0Nr/profile http://localhost:44085/getInfo.html) 03:29:07 INFO - PROCESS | 25986 | JavaScript error: , line 0: uncaught exception: undefined 03:29:07 INFO - PROCESS | 25986 | __metrics Screen width/height:1600/1200 03:29:07 INFO - PROCESS | 25986 | colorDepth:24 03:29:07 INFO - PROCESS | 25986 | Browser inner width/height: 1024/697 03:29:07 INFO - PROCESS | 25986 | __metrics 03:29:08 INFO - PROCESS | 25986 | 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" 03:29:08 INFO - PROCESS | 25986 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:09 INFO - PROCESS | 25986 | console.error: PushService: 03:29:09 INFO - PROCESS | 25986 | stateChangeProcessEnqueue: Error transitioning state 03:29:09 INFO - PROCESS | 25986 | UnknownError 03:29:09 INFO - TEST-INFO | 25986: exit 0 03:29:09 INFO - Browser initialized. 03:29:09 INFO - Running cycle 1/1 for kraken test... 03:29:09 INFO - TEST-INFO | started process 26070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6m_0Nr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:21 INFO - PROCESS | 26070 | RSS: Main: 157683712 03:29:21 INFO - PROCESS | 26070 | 03:29:23 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44085/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:24 INFO - PROCESS | 26070 | RSS: Main: 214315008 03:29:24 INFO - PROCESS | 26070 | 03:29:27 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44085/tests/kraken/driver.html?testName=audio-dft) 03:29:27 INFO - PROCESS | 26070 | RSS: Main: 192884736 03:29:27 INFO - PROCESS | 26070 | 03:29:30 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44085/tests/kraken/driver.html?testName=audio-fft) 03:29:31 INFO - PROCESS | 26070 | RSS: Main: 270237696 03:29:31 INFO - PROCESS | 26070 | 03:29:33 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44085/tests/kraken/driver.html?testName=audio-oscillator) 03:29:34 INFO - PROCESS | 26070 | RSS: Main: 181592064 03:29:34 INFO - PROCESS | 26070 | 03:29:36 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:36 INFO - PROCESS | 26070 | RSS: Main: 185524224 03:29:36 INFO - PROCESS | 26070 | 03:29:39 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44085/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:40 INFO - PROCESS | 26070 | RSS: Main: 221945856 03:29:40 INFO - PROCESS | 26070 | 03:29:43 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44085/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:44 INFO - PROCESS | 26070 | RSS: Main: 220467200 03:29:44 INFO - PROCESS | 26070 | 03:29:47 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44085/tests/kraken/driver.html?testName=json-parse-financial) 03:29:47 INFO - PROCESS | 26070 | RSS: Main: 220057600 03:29:47 INFO - PROCESS | 26070 | 03:29:49 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:49 INFO - PROCESS | 26070 | RSS: Main: 185135104 03:29:49 INFO - PROCESS | 26070 | 03:29:51 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:52 INFO - PROCESS | 26070 | RSS: Main: 190914560 03:29:52 INFO - PROCESS | 26070 | 03:29:54 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:55 INFO - PROCESS | 26070 | RSS: Main: 194555904 03:29:55 INFO - PROCESS | 26070 | 03:29:57 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:58 INFO - PROCESS | 26070 | RSS: Main: 190541824 03:29:58 INFO - PROCESS | 26070 | 03:30:00 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:01 INFO - PROCESS | 26070 | RSS: Main: 194052096 03:30:01 INFO - PROCESS | 26070 | 03:30:02 INFO - PROCESS | 26070 | Cycle 1(1): loaded http://localhost:44085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44085/tests/kraken/driver.html?testName=ai-astar) 03:30:03 INFO - PROCESS | 26070 | RSS: Main: 245104640 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | __start_tp_report 03:30:03 INFO - PROCESS | 26070 | _x_x_mozilla_page_load 03:30:03 INFO - PROCESS | 26070 | _x_x_mozilla_page_load_details 03:30:03 INFO - PROCESS | 26070 | |i|pagename|runs| 03:30:03 INFO - PROCESS | 26070 | |0;ai-astar;101;111;109;110;111;110;109;110;110;112 03:30:03 INFO - PROCESS | 26070 | |1;audio-beat-detection;146;117;119;185;119;119;143;118;151;121 03:30:03 INFO - PROCESS | 26070 | |2;audio-dft;161;160;160;162;160;163;160;163;161;160 03:30:03 INFO - PROCESS | 26070 | |3;audio-fft;74;74;75;119;77;76;75;74;105;75 03:30:03 INFO - PROCESS | 26070 | |4;audio-oscillator;84;85;112;84;84;83;120;85;85;122 03:30:03 INFO - PROCESS | 26070 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;117 03:30:03 INFO - PROCESS | 26070 | |6;imaging-darkroom;147;147;145;146;145;146;147;146;146;146 03:30:03 INFO - PROCESS | 26070 | |7;imaging-desaturate;95;95;95;95;95;98;96;95;95;96 03:30:03 INFO - PROCESS | 26070 | |8;json-parse-financial;54;50;51;50;51;51;50;51;51;51 03:30:03 INFO - PROCESS | 26070 | |9;json-stringify-tinderbox;62;63;62;62;63;63;63;63;64;64 03:30:03 INFO - PROCESS | 26070 | |10;stanford-crypto-aes;80;74;75;79;77;77;83;76;76;79 03:30:03 INFO - PROCESS | 26070 | |11;stanford-crypto-ccm;121;131;120;119;118;117;119;119;157;123 03:30:03 INFO - PROCESS | 26070 | |12;stanford-crypto-pbkdf2;153;153;154;158;154;159;156;151;153;156 03:30:03 INFO - PROCESS | 26070 | |13;stanford-crypto-sha256-iterative;62;63;63;64;63;63;72;62;63;62 03:30:03 INFO - PROCESS | 26070 | __end_tp_report 03:30:03 INFO - PROCESS | 26070 | __start_cc_report 03:30:03 INFO - PROCESS | 26070 | _x_x_mozilla_cycle_collect,1664 03:30:03 INFO - PROCESS | 26070 | __end_cc_report 03:30:03 INFO - PROCESS | 26070 | __startTimestamp1469529003230__endTimestamp 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | ------- Summary: start ------- 03:30:03 INFO - PROCESS | 26070 | Number of tests: 14 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.97 03:30:03 INFO - PROCESS | 26070 | Values: 101.0 111.0 109.0 110.0 111.0 110.0 109.0 110.0 110.0 112.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:132.00 stddev:22.37 (16.9%) stddev-sans-first:23.29 03:30:03 INFO - PROCESS | 26070 | Values: 146.0 117.0 119.0 185.0 119.0 119.0 143.0 118.0 151.0 121.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 03:30:03 INFO - PROCESS | 26070 | Values: 161.0 160.0 160.0 162.0 160.0 163.0 160.0 163.0 161.0 160.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.97 (21.3%) stddev-sans-first:16.65 03:30:03 INFO - PROCESS | 26070 | Values: 74.0 74.0 75.0 119.0 77.0 76.0 75.0 74.0 105.0 75.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:16.49 (19.6%) stddev-sans-first:17.05 03:30:03 INFO - PROCESS | 26070 | Values: 84.0 85.0 112.0 84.0 84.0 83.0 120.0 85.0 85.0 122.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:30:03 INFO - PROCESS | 26070 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 03:30:03 INFO - PROCESS | 26070 | Values: 147.0 147.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 03:30:03 INFO - PROCESS | 26070 | Values: 95.0 95.0 95.0 95.0 95.0 98.0 96.0 95.0 95.0 96.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.15 (2.3%) stddev-sans-first:0.50 03:30:03 INFO - PROCESS | 26070 | Values: 54.0 50.0 51.0 50.0 51.0 51.0 50.0 51.0 51.0 51.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 03:30:03 INFO - PROCESS | 26070 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 63.0 63.0 64.0 64.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:2.67 (3.4%) stddev-sans-first:2.69 03:30:03 INFO - PROCESS | 26070 | Values: 80.0 74.0 75.0 79.0 77.0 77.0 83.0 76.0 76.0 79.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:120.50 stddev:12.12 (10.1%) stddev-sans-first:12.79 03:30:03 INFO - PROCESS | 26070 | Values: 121.0 131.0 120.0 119.0 118.0 117.0 119.0 119.0 157.0 123.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:2.50 (1.6%) stddev-sans-first:2.57 03:30:03 INFO - PROCESS | 26070 | Values: 153.0 153.0 154.0 158.0 154.0 159.0 156.0 151.0 153.0 156.0 03:30:03 INFO - PROCESS | 26070 | 03:30:03 INFO - PROCESS | 26070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.98 (4.7%) stddev-sans-first:3.10 03:30:03 INFO - PROCESS | 26070 | Values: 62.0 63.0 63.0 64.0 63.0 63.0 72.0 62.0 63.0 62.0 03:30:03 INFO - PROCESS | 26070 | -------- Summary: end -------- 03:30:03 INFO - PROCESS | 26070 | 03:30:04 INFO - TEST-INFO | 26070: exit 0 03:30:04 INFO - TEST-OK | kraken | took 60452ms 03:30:04 INFO - SUITE-END | took 1173s 03:30:04 INFO - Completed test suite (00:19:34) 03:30:04 INFO - javascript benchmark 03:30:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.5401689746536, 3071.0786763970805, 3073.0, 3116.922076948076, 3131.060681795462, 5252.395974462938, 5335.706536140511, 5383.138697808351, 5478.643888147268, 5485.341758988922, 5368.355797304329, 5409.891802163955, 5454.045542030139, 5463.3717122530925, 5502.0371434998915, 4844.5882100021545, 4938.827141050064, 4943.678660887049, 4958.330625365584, 5124.359455068116, 5025.572826309768, 5054.620903432257, 5074.568661663745, 5091.745412729368, 5093.643444958854, 4864.416270047582, 4895.069936712049, 4900.436449808264, 4936.33359496467, 4987.650864439473, 4888.388951381077, 4891.217405215184, 4897.363342765418, 5034.219695947134, 5037.0429618372755, 4906.264060390934, 4968.73415582221, 4971.488954462101, 4992.625553083533, 4998.600111991032, 5297.576193904479, 5404.189371594253, 5488.862778430531, 5492.780288788444, 5541.9168712469345, 5793.855153621151, 5880.882382352372, 5889.057750759901, 5893.823185304448, 5895.322037965646, 5855.677937713424, 5858.062709966385, 5924.496417804492, 5930.347661757203, 5931.614445061057, 5249.921251181236, 5402.108652072443, 5417.106177480671, 5526.972365138189, 5528.889422211573, 5963.582549221513, 5964.7315870785915, 6000.969995149996, 6020.127081573148, 6020.939790602038, 5684.317881854204, 5707.1153971134545, 5707.571932105108, 5752.626079304831, 5754.712264386764, 5621.4659607337235, 5738.426157384228, 5795.0727883539275, 5834.299884013945, 5846.123081537803, 5824.912626310609, 5867.0, 5867.471927526458, 5870.882582348415, 5871.765129394862, 5771.220885180531, 5804.535637149018, 5809.867075920155, 5823.010088285002, 5859.794907178229, 4341.218580655449, 4410.33844923264, 4456.910861782746, 4466.218411777926, 4502.032063106448, 3893.6106389361403, 3939.1924655446137, 3965.385365268388, 3976.701747368959, 3999.3601023836045, 5562.443755624486, 5576.1356989666665, 5593.916091258634, 5596.944030559724, 5643.746031428595, 5684.857878553069, 5896.764129434775, 5913.231279933667, 5927.0, 5979.790707325223, 5505.587080968943, 5555.2500412444615, 5565.220869078333, 5617.988762022876, 5638.943610563924, 5054.49455054499, 5071.87320316995, 5073.594112470993, 5082.415522214993, 5085.0338435697095, 6098.32918378978, 6104.023356263066, 6106.969465152646, 6109.694515274218, 6121.540884433596, 5668.51817595509, 5826.883462330645, 5868.853278668067, 5893.9685555026845, 5994.760209591567, 5971.522278217645, 5988.940110598838, 5993.041113421831, 5994.70026498682, 5997.430244126801, 5631.465010823965, 5700.885982280248, 5703.030484817674, 5706.144078388275, 5707.743151558273, 5670.461306175906, 5801.535877129904, 5809.2738407699035, 5837.591368604157, 5910.1134829774155, 5739.368669446441, 5745.798897038583, 5746.965546201724, 5752.252207213203, 5753.1370294456165, 5721.427857214246, 5729.799457018984, 5733.799317023884, 5734.2258795062135, 5735.197072409783, 5533.474319939599, 5628.0, 5637.098064309691, 5639.3232812062815, 5743.310802703702, 5767.163761254511, 5793.971030144822, 5818.796342128006, 5820.5925585210325, 5825.94174058254, 5659.603827732019, 5665.178549110274, 5667.03660377745, 5667.376588575171, 5675.943240567707], "value": 5384.08756411629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9970700146501, 600.3036477685883, 626.8401557602812, 637.4613451633368, 642.6369101457673, 31597.842010789944, 44592.33111503326, 45420.77289613555, 45626.771866140625, 45645.77177114114, 45986.0, 46148.0, 46250.537494625045, 46305.53694463063, 46405.0, 8938.642454301837, 9070.909290907106, 9074.63701451941, 9078.500682462462, 9078.954605226998, 8949.284057275403, 9015.27877769777, 9032.729018129434, 9042.0, 9049.3665443419, 9004.369694121415, 9072.501012444312, 9086.818263634756, 9123.726288211332, 9125.315601329894, 8892.510911899843, 8937.106289371011, 8942.821143577125, 8956.910430895672, 8964.731058068202, 8794.780130496725, 8937.73186804397, 8959.776005599848, 8966.058563850767, 8967.0, 43637.345439818426, 43828.3425748614, 44044.33933491, 44067.77966110149, 44081.77959110216, 3457.135716070982, 3535.0, 3607.332643460968, 4142.91714165715, 4355.825766969318, 33575.160620984425, 34028.82985585056, 34134.31731365384, 34609.826950865085, 35065.29869402598, 4257.701960862741, 4345.217860785057, 4404.273294906368, 4412.0955204183065, 4612.100640375128, 385434.07282963686, 386131.0, 386492.0, 388239.0, 388360.0, 35284.64715352865, 36176.0, 60598.394016060156, 60665.393346065975, 61100.0, 37339.25321493555, 37484.625153748115, 37509.249815003546, 37564.62435375666, 37569.43645845314, 15724.606884827743, 15830.208489575476, 15832.525024249291, 15833.050016999017, 15862.286197121157, 13352.265625390697, 13440.865591343962, 13442.395092220873, 13444.395002224923, 13447.394867230802, 8381.455205411628, 8477.915220847835, 8480.194381533744, 8526.275266602408, 8554.101819309008, 3302.1579497228054, 3315.4529502632276, 3327.351166522505, 3336.632970373257, 3342.8829990950685, 1023.7594165371132, 1078.703356576932, 1100.862392200975, 1131.3438205840594, 1210.425048102162, 32391.35217295641, 33397.3320533588, 33747.0, 34000.31999359999, 34207.14482137917, 1149.1611123879616, 1154.5381847261162, 1194.892459678633, 1203.48851738011, 1203.8615559210627, 16673.583160420843, 17650.23987775425, 17688.380906668204, 17771.0, 17872.28510859577, 599894.0, 607732.0, 607769.0, 608727.0, 609498.0, 61878.0, 62359.0, 62509.68745156245, 62666.68666656638, 62770.0, 1250.493550112206, 1349.8380194376737, 1388.6181300142541, 1417.4188582681052, 1421.9431222751182, 32528.83735581307, 34635.48046779351, 34864.65135348614, 35019.0078261684, 35501.0, 52203.0, 52563.0, 52677.0, 52795.47204528059, 52922.0, 401390.0, 401649.0, 401727.0, 402419.7822196016, 403549.0, 28412.147635570967, 29565.85217073901, 29806.403871922874, 29866.402671946875, 29889.0, 49330.50669493259, 50531.0, 51001.0, 51248.23127653014, 51475.0, 43102.0, 43184.46563110828, 43228.56771432245, 43714.0, 45472.31791523063, 41438.58561414347, 42601.786991064844, 43244.56755432405, 43951.78024109859, 44378.334324984506, 42081.0, 42959.355609665254, 43716.781416092716, 43833.56166438422, 44620.33069503895, 35818.0, 36862.44706329461, 38582.861003343016, 38710.0, 39418.605813941496, 27797.16608501748, 29455.410891781616, 29563.704362956094, 29628.111156665334, 29842.0], "value": 19579.581732831946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.22122207031424, 398.7786778338023, 400.5573840905799, 401.8633664554051, 419.8341655046257, 14521.854781452183, 18049.278028878845, 20171.29400470984, 20215.49461263469, 20352.898235508837, 19551.902240488813, 20118.09468573914, 20127.094280757363, 20313.796862031377, 20437.386878393634, 5525.806596769114, 5641.68970706611, 5811.651300921958, 5863.560232982522, 5863.824085277449, 5809.0, 5823.0, 5840.561957853157, 5846.678432686201, 5850.210221620091, 5737.512311453532, 5824.796132135376, 6543.705533250992, 6637.601743895381, 6689.0, 5962.493188078975, 6662.267150613428, 6666.400023997815, 6722.764703235388, 6725.0, 5655.773769049233, 5697.03150464422, 5697.943020569783, 5703.7148142592705, 5707.3721890592005, 14565.126092434488, 15026.699466010728, 23039.654405183937, 24112.75887241123, 24625.38436539083, 2189.1462329691435, 2203.6143674856835, 2278.054607337953, 2309.06214869127, 2375.543584085152, 10513.632022879163, 10514.21143414247, 10612.469376531142, 10743.194260430499, 10832.079273261703, 1857.1085878778263, 1914.5309399197147, 1922.865399422041, 1939.6217737541185, 1979.5150188203982, 86915.0, 86955.0, 88466.0, 88612.5569372149, 89509.0, 11058.723531911766, 11123.666290011313, 11290.661280161608, 11358.716032099099, 11432.256903301259, 15727.292271847795, 15777.842221577866, 15786.105667319995, 15818.130002849954, 15827.0, 8179.672813087529, 8404.8319033619, 8417.284530814826, 8578.828423431622, 8654.524001179996, 7805.765827025199, 7856.764297071097, 7882.290593846581, 8054.959725201454, 8158.959205203936, 4643.442786865598, 4737.28940658897, 4812.51874812516, 4857.271409288564, 4959.479254678279, 1925.9614807703767, 1986.7814540400545, 2006.5786184901042, 2022.1304838919407, 2037.7350944377433, 840.4915026408935, 892.7946572288411, 963.450833025183, 1050.5115121468555, 1074.033369967036, 19270.90364548196, 20221.49446263855, 20455.488612784502, 21574.0, 21639.13443462244, 1015.4059874973076, 1015.9136473399695, 1034.906858382749, 1035.8756949165997, 1060.8726952765717, 10657.733556661145, 11523.423828808525, 11583.826242606368, 11626.186166968231, 11648.0, 409052.0, 413800.0, 415258.0, 541395.0, 545360.0, 78813.23508221, 98552.50723746336, 99060.0, 103904.48047759713, 105836.0, 1013.2046343620223, 1036.528379587286, 1040.167865707431, 1054.4991129213715, 1054.6572363981736, 17596.120193989995, 17745.46763597094, 18402.447926562225, 18411.907940460213, 18484.72272915934, 33281.0, 34410.48384274288, 43401.56598433975, 43576.56423435852, 44827.32759008552, 62466.0, 63344.0, 64303.67848160916, 64487.67756161189, 67021.0, 8275.462094963808, 8473.745787626382, 8484.660613575388, 8651.913480865363, 9090.318226132935, 12637.2417654941, 12637.93681031589, 13239.550683123653, 14001.92999035039, 14304.0, 11641.185117041725, 11698.649040528799, 11796.115291353011, 11911.702207444536, 12261.570845020382, 11895.94036115507, 11954.641360759191, 12018.218815776947, 12089.455974480994, 12136.271823690608, 11892.405379731152, 12146.75706485883, 12180.0, 12257.0, 12514.31171285588, 7725.22747725223, 8081.676732930617, 8915.108489151033, 9025.729228123168, 9100.954495227481, 11414.086873050303, 11807.704807379541, 11992.220505667105, 12035.277883327028, 12100.334481603597], "value": 9421.382692991676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.5638236720163, 1525.5804653720227, 1653.0, 1741.4601473543194, 1778.3509019207993, 8777.078406767285, 9231.723048308544, 9360.578773955163, 9367.250619950404, 9384.906150938488, 7718.382529397649, 8608.26829719473, 8901.955490222539, 8955.686550970717, 9021.142991415822, 2348.5772560939026, 2407.157494876788, 2411.0837881604966, 2411.5176964607062, 2413.6741539892155, 2357.2928121563464, 2387.5224955009066, 2436.427439551704, 2440.4264997725522, 2441.389652586853, 2077.366403247009, 2134.6797980303, 2135.6476181430044, 2145.1633862793524, 2347.225415612844, 2379.119725701493, 2400.6519054736964, 2418.6734790803193, 2420.92737217882, 2424.684790977179, 2382.1781485387514, 2399.1003373734848, 2400.255920664582, 2403.2189538399916, 2406.2540612410035, 8911.821763564758, 8922.375433719642, 8928.06255343186, 8957.328200384996, 8998.685046023358, 5345.518903298722, 5519.724013799294, 5568.554515638739, 5608.0, 5612.550995920316, 3397.3035527717007, 3540.964590354089, 3587.9282414351565, 3605.9278814423565, 3608.657177568127, 1138.1805100327751, 1177.8233265010317, 1187.554666999875, 1194.7072967123024, 1219.5609580550995, 12253.632391028283, 12339.444724987397, 12348.753024939451, 12618.432170552256, 12681.556145534862, 4896.657233993657, 4913.0173965207105, 4927.310176575283, 4965.255211718271, 5047.747612619428, 10902.781944361068, 10979.890201097887, 10984.670459886056, 11001.504932278067, 11006.779864402668, 5530.889382212334, 5535.557155427556, 5542.057850165482, 5542.39033706292, 5543.501084902378, 4955.702657840541, 5094.57351941457, 5097.057044446715, 5117.974410127926, 5150.690958542499, 3926.0, 3959.742616729903, 3996.200759848042, 4036.0918793271867, 4040.7575545467366, 1282.0512820512754, 1298.9805152922713, 1308.2935214983993, 1318.4067169773448, 1325.350578216667, 915.9908400915906, 981.8134554434635, 1012.8430093335545, 1017.0897047142913, 1033.1270076785104, 6115.266168059772, 6337.4613157882095, 6343.207099112611, 6344.746210151542, 6444.291127975919, 457.11776271795753, 457.80085662736815, 464.844277167146, 466.08414465575305, 466.16323698960446, 4310.590493903074, 4414.536473670282, 4419.027813880941, 4442.311441726538, 4486.439195100613, 11265.15511336653, 11537.307761534335, 11625.12811539121, 11647.41762911868, 11657.883421165849, 10686.465676716289, 11054.613088541862, 11070.225084244026, 11553.942230288794, 11577.247478913843, 8413.621387037598, 8573.014103378067, 8573.356998225157, 8585.527795971282, 8591.785205369915, 6283.685815709287, 6321.5258855586935, 6345.270293916259, 6390.169277993831, 6665.633390163587, 10142.949285253526, 10517.0, 10519.421431821323, 10666.89333106659, 10672.413017284123, 10799.0, 10901.945490272816, 10905.18211134184, 10906.236563440483, 10922.617708380169, 8238.423310368216, 8309.750707478785, 8391.076981531905, 8391.202835730595, 8413.07456179832, 8672.739817805475, 8715.782105447415, 8819.470831750115, 8827.24968377695, 8833.29333653319, 7660.655270512729, 7818.687252509836, 7959.124496305286, 8017.358611310964, 8084.959575202086, 7629.885551716618, 7636.312731853937, 7709.537427754352, 7764.805879853049, 7962.163972782774, 7173.677184526813, 7183.820404489929, 7191.42468602521, 7248.782536523701, 7289.5261807982315, 5451.809186678447, 5520.806771762969, 5593.580481463988, 5599.496045355938, 5787.160861675117, 5385.892282154413, 5578.63738856973, 5626.0, 5673.290838645169, 5702.800401985911], "value": 4734.886645710743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.39363693075484, 333.6162529988666, 340.08686676274203, 342.7035614193723, 349.43391705437193, 5029.1199040168, 5217.825989152444, 5306.336707911511, 5329.173978033401, 5331.386890507592, 4993.4257560380565, 5177.974110129454, 5282.947170528294, 5288.629795914288, 5294.338207724035, 4094.6219369020528, 4107.13750112476, 4111.342185250361, 4113.506379234481, 4121.340585506319, 3966.5636779954184, 4039.4142849286836, 4078.286299897521, 4083.8570650027104, 4100.712950093494, 4058.168075544521, 4085.3259212229946, 4090.836366545335, 4092.7135100542973, 4104.979475102636, 4099.036726369301, 4114.547399786021, 4115.423840662324, 4117.855875044359, 4127.195196936598, 3467.583889933199, 3630.3283892479976, 3647.434647629622, 3649.543807024122, 3657.9451308230396, 5106.540411362958, 5107.361579802525, 5109.565686916617, 5120.641555091145, 5153.948460515385, 4692.741899195543, 4696.436427628706, 4704.0, 4708.929366059512, 4722.881927951795, 5222.817201397971, 5449.64577302474, 5506.256655351556, 5518.2826232589905, 5521.723913804293, 3953.3872249801325, 3961.6830653547936, 3975.542812576533, 3976.1848820991627, 3979.422983667381, 5650.491455769001, 5674.943250567483, 5681.801136960228, 5682.886342273173, 5713.771449142029, 3921.745086569364, 4018.6985976051915, 4021.3766866135797, 4031.879043628696, 4070.816813243411, 4040.1717647882115, 4096.283150448719, 4104.938425923614, 4110.568390319033, 4120.423140760296, 4485.125400546862, 4545.2954792007295, 4603.148417542765, 4632.513586073481, 4644.349791029259, 5426.620136590401, 5454.191091587835, 5458.836234912879, 5466.0, 5508.531774799107, 1401.2363262022222, 1422.9644258893404, 1428.8856891448659, 1430.3134495442039, 1438.3527412664344, 942.9815798937132, 983.9212862970945, 988.649029594498, 992.8560358748085, 995.7809281957958, 5291.391489978701, 5295.258663787073, 5301.640769857377, 5315.654482458628, 5325.4142044375085, 5599.188117722989, 5638.351589567253, 5642.153676948408, 5645.80239691617, 5664.348599911063, 5194.68831870089, 5249.97625463031, 5269.683818970874, 5283.1546952487415, 5307.62846600742, 2929.487339715541, 2935.207493976657, 2942.911712648624, 2953.5126704094014, 2964.985175074111, 5475.780968761284, 5670.121131224667, 5740.818488974163, 5747.0, 5759.819237056394, 5585.413531579125, 5593.804216852391, 5594.9720251398485, 5607.41122182165, 5636.915446268309, 5646.520045796071, 5680.488756011896, 5681.147827825859, 5708.857278568069, 5739.942600573941, 5369.436209197978, 5457.290552228185, 5509.531689806251, 5518.227448157341, 5553.527950124123, 5427.077396842626, 5482.205080263419, 5488.615796894179, 5493.862653433536, 5498.5876059294915, 5465.371482279589, 5621.156826476062, 5697.601167918372, 5728.914066289092, 5751.281089863767, 3998.7600743955454, 4018.6336645540655, 4023.9195216094927, 4041.91916161681, 4058.857939972087, 5371.274877891435, 5371.382291036424, 5535.778568857361, 5570.860728481658, 5577.637453565505, 5392.487713667196, 5394.136938089887, 5433.174749130509, 5451.563874890078, 5469.863253418537, 5417.8103766367985, 5429.619926605258, 5451.264079349396, 5457.317835270591, 5486.0, 5177.8187763428095, 5342.278792363137, 5377.327834020747, 5406.540444062299, 5408.37748675388, 5431.456854314695, 5450.291462109901, 5459.590530710292, 5477.808276710455, 5483.0, 5262.605304602093, 5287.462018231194, 5327.573794096541, 5381.304888959965, 5382.757775900016], "value": 4179.884950233011, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.9598522081284, 748.6256871564218, 766.6358479722132, 772.9265719756623, 877.8595424732042, 15484.0, 16273.430429934955, 16691.499255022354, 16729.247183876723, 16738.497845064652, 14540.781888271684, 14667.706645867076, 14816.333265003073, 14855.480058197965, 14892.851071489282, 679.619413128647, 806.0810675829545, 826.8553003224441, 827.7475370012144, 827.7847759582522, 801.7193982106274, 822.268181318627, 824.1552408780988, 826.4710585225461, 827.2513375395276, 861.0356400831047, 861.9698310559131, 862.0904945282724, 862.3230763850379, 864.3042350907548, 695.0755495191383, 854.4915775113798, 855.8117214212863, 856.6616186606318, 857.9485230886136, 610.6031079798122, 626.9968650156766, 627.9277883043463, 628.1802248066272, 629.0784001437916, 14291.57125286243, 14335.0, 14361.0, 14366.13803171813, 14413.063150895157, 13922.37349319273, 14173.503927362493, 14599.78100328496, 14601.196934168616, 14815.703685926328, 12620.55828046023, 12818.871811281955, 13222.537211197658, 13414.0, 13590.116642418212, 4463.285874260136, 4500.7299562026055, 4503.459584849807, 4580.0152967112235, 4609.331646911212, 79236.0, 80674.5966270165, 80837.0, 81912.0, 82961.17038829594, 11241.662750117346, 11324.32054076758, 11426.942865285786, 11547.018503427134, 11699.941500292443, 20742.481437964172, 22299.665505017438, 22366.77633223647, 22388.32835014952, 22425.21511747081, 8698.34762392823, 8917.687880924137, 9021.909780902108, 9029.097090290918, 9041.90958090424, 4827.541383568555, 4844.854654360375, 4927.9507204927495, 4956.330895329156, 5000.199968005102, 3404.097914052778, 3497.650234976482, 3500.387432199355, 3503.9474407883904, 3506.807125608116, 671.4963777167125, 675.4191395399952, 700.4221517248291, 705.7847356556197, 711.3846522757881, 615.2063837649472, 636.4367534731796, 683.255251775567, 722.663961258007, 723.2297603052732, 9874.753131171778, 10139.7465063374, 10429.9478502607, 10809.135269178447, 10932.289401188897, 639.5619000984341, 682.3483573187594, 689.5414549324643, 697.2881575731567, 755.3768141283463, 4449.399331090326, 4748.169070412733, 4753.453352864396, 4788.754923719858, 4818.879528011757, 71643.0, 75173.0, 122974.62817147856, 125685.0, 134328.0, 66135.0, 91864.54067729619, 111295.44352278186, 111607.0, 114011.0, 59164.0, 59892.401075989554, 65638.0, 97323.0, 102143.48928255311, 8936.46381217103, 9168.174864262248, 9245.861312080458, 9246.0753924607, 9301.813963720822, 57439.712801437396, 58664.120038198605, 59178.0, 59434.0, 59847.40152598418, 85530.0, 86163.56918215369, 87440.0, 88476.5576172115, 89430.0, 11681.707957300796, 11778.528858845893, 11804.20780594404, 12042.879571204527, 12341.382930853242, 13854.376553054935, 14179.574612761633, 14274.429022838971, 14519.0, 14521.491747788778, 13116.278604676452, 13124.40940157676, 13443.89308785237, 13447.193168409927, 13886.444542218198, 12816.743665126458, 13070.281134537692, 13394.732105358033, 14314.0, 14719.411223551366, 14653.0, 14744.410223590936, 15365.231738413258, 16069.035857848567, 16135.435259765853, 11524.423778811193, 12229.205101668364, 12313.322767247888, 12584.874151258371, 12657.746845063231, 12576.434060467118, 12788.936055319664, 12856.164349317265, 12877.42114549663, 12928.547500837425], "value": 7736.38471858794, "unit": "score"}], "name": "dromaeo_css", "value": 7306.022888304744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 112.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 119.0, 185.0, 119.0, 119.0, 143.0, 118.0, 151.0, 121.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 160.0, 163.0, 160.0, 163.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 119.0, 77.0, 76.0, 75.0, 74.0, 105.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 84.0, 84.0, 83.0, 120.0, 85.0, 85.0, 122.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 96.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 51.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 75.0, 79.0, 77.0, 77.0, 83.0, 76.0, 76.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 131.0, 120.0, 119.0, 118.0, 117.0, 119.0, 119.0, 157.0, 123.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 154.0, 158.0, 154.0, 159.0, 156.0, 151.0, 153.0, 156.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 72.0, 62.0, 63.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1474.0000000000002, "alertThreshold": 2.0}]} 03:30:04 INFO - Return code: 0 03:30:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:04 INFO - # TBPL SUCCESS # 03:30:04 INFO - Running post-action listener: _resource_record_post_action 03:30:04 INFO - [mozharness: 2016-07-26 10:30:04.535058Z] Finished run-tests step (success) 03:30:04 INFO - Running post-run listener: _resource_record_post_run 03:30:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565260288; Read time: 8; Write time: 477300 03:30:04 INFO - TinderboxPrint: CPU usage
13.0% 03:30:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:30:04 INFO - TinderboxPrint: I/O write bytes / time
565,260,288 / 477,300 03:30:04 INFO - TinderboxPrint: CPU idle
8,271.0 (87.0%) 03:30:04 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 03:30:04 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:04 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 272433152; Read time: 0; Write time: 286240 03:30:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292827136; Read time: 0; Write time: 191060 03:30:05 INFO - Running post-run listener: _upload_blobber_files 03:30:05 INFO - Blob upload gear active. 03:30:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:05 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 03:30:05 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'] 03:30:05 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 03:30:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:06 INFO - (blobuploader) - INFO - Done attempting. 03:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:10 INFO - (blobuploader) - INFO - Done attempting. 03:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:10 INFO - (blobuploader) - INFO - Done attempting. 03:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:10 INFO - Return code: 0 03:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fdd19a3ce8ce3ab3228621aa0b2c983170e2734185d1bae0eda7d4167d44c9d846285f1936a63cabb05c079c3c644025ffdcf23f2f94b9ab6e985bf689fe32ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/911379dee9ab16a51d9b61dd3f9ca50db41882f827ddb4b62b37d26a188daed64a834901b279429ff75b7bd4b9be349786be6f8a5c542423197f42514ec38be5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ec99598fef19491585b1af119d36dd91f130bfc8dd31136267c4493bbc895b6f6a29e1f68c41b0aa97bec9ba4a7030ec6fa1ccd47cba0498f02c9e6b1868306d"} 03:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:10 INFO - Contents: 03:30:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fdd19a3ce8ce3ab3228621aa0b2c983170e2734185d1bae0eda7d4167d44c9d846285f1936a63cabb05c079c3c644025ffdcf23f2f94b9ab6e985bf689fe32ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/911379dee9ab16a51d9b61dd3f9ca50db41882f827ddb4b62b37d26a188daed64a834901b279429ff75b7bd4b9be349786be6f8a5c542423197f42514ec38be5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ec99598fef19491585b1af119d36dd91f130bfc8dd31136267c4493bbc895b6f6a29e1f68c41b0aa97bec9ba4a7030ec6fa1ccd47cba0498f02c9e6b1868306d"} 03:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:10 INFO - Copying logs to upload dir... 03:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.633672 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-26 03:30:10.593060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:30:10.597954) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 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/fdd19a3ce8ce3ab3228621aa0b2c983170e2734185d1bae0eda7d4167d44c9d846285f1936a63cabb05c079c3c644025ffdcf23f2f94b9ab6e985bf689fe32ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/911379dee9ab16a51d9b61dd3f9ca50db41882f827ddb4b62b37d26a188daed64a834901b279429ff75b7bd4b9be349786be6f8a5c542423197f42514ec38be5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ec99598fef19491585b1af119d36dd91f130bfc8dd31136267c4493bbc895b6f6a29e1f68c41b0aa97bec9ba4a7030ec6fa1ccd47cba0498f02c9e6b1868306d"} build_url:https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/AWMO5fP6QSKftOzfOmLEbw/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/fdd19a3ce8ce3ab3228621aa0b2c983170e2734185d1bae0eda7d4167d44c9d846285f1936a63cabb05c079c3c644025ffdcf23f2f94b9ab6e985bf689fe32ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/911379dee9ab16a51d9b61dd3f9ca50db41882f827ddb4b62b37d26a188daed64a834901b279429ff75b7bd4b9be349786be6f8a5c542423197f42514ec38be5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ec99598fef19491585b1af119d36dd91f130bfc8dd31136267c4493bbc895b6f6a29e1f68c41b0aa97bec9ba4a7030ec6fa1ccd47cba0498f02c9e6b1868306d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:30:10.624882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:30:10.625352) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469527779.284460-275871326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:30:10.709832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:30:10.710266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:30:10.710686) ========= ========= Total master_lag: 0.17 =========