builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1467641162.83 results: success (0) buildid: 20160704043003 builduid: 5ebf9d29c53c4b4c88d4d4f28cccaecc revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.825845) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.826680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.827194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.846069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.846394) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 07:06:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-04 07:06:03 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.942084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.942814) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017871 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.996821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:02.997125) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 07:06:03,893 truncating revision to first 12 chars 2016-07-04 07:06:03,893 Setting DEBUG logging. 2016-07-04 07:06:03,893 attempt 1/10 2016-07-04 07:06:03,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4191df8e4b8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 07:06:04,224 unpacking tar archive at: mozilla-central-4191df8e4b8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:03.686507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:03.686837) ========= script_repo_revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:03.687353) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:03.687699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 07:06:03.701265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-04 07:06:03.701644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:04 INFO - MultiFileLogger online at 20160704 07:06:04 in /builds/slave/test 07:06:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:06:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:04 INFO - {'append_to_log': False, 07:06:04 INFO - 'base_work_dir': '/builds/slave/test', 07:06:04 INFO - 'blob_upload_branch': 'Firefox', 07:06:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:04 INFO - 'branch': 'Firefox', 07:06:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:04 INFO - 'config_files': ('talos/linux_config.py',), 07:06:04 INFO - 'default_actions': ('clobber', 07:06:04 INFO - 'read-buildbot-config', 07:06:04 INFO - 'download-and-extract', 07:06:04 INFO - 'populate-webroot', 07:06:04 INFO - 'create-virtualenv', 07:06:04 INFO - 'install', 07:06:04 INFO - 'run-tests'), 07:06:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:04 INFO - 'download_minidump_stackwalk': True, 07:06:04 INFO - 'download_symbols': 'ondemand', 07:06:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:04 INFO - 'installer_path': 'installer.exe', 07:06:04 INFO - 'log_level': 'info', 07:06:04 INFO - 'log_name': 'talos', 07:06:04 INFO - 'log_to_console': True, 07:06:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:04 INFO - 'opt_config_files': (), 07:06:04 INFO - 'pip_index': False, 07:06:04 INFO - 'sps_profile': False, 07:06:04 INFO - 'sps_profile_interval': 0, 07:06:04 INFO - 'suite': 'dromaeojs', 07:06:04 INFO - 'system_bits': '32', 07:06:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:04 INFO - 'title': 'talos-linux64-ix-060', 07:06:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:04 INFO - 'use_talos_json': True, 07:06:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:04 INFO - 'work_dir': 'build'} 07:06:04 INFO - ##### 07:06:04 INFO - ##### Running clobber step. 07:06:04 INFO - ##### 07:06:04 INFO - Running pre-action listener: _resource_record_pre_action 07:06:04 INFO - Running main action method: clobber 07:06:04 INFO - rmtree: /builds/slave/test/build 07:06:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:05 INFO - Running post-action listener: _resource_record_post_action 07:06:05 INFO - ##### 07:06:05 INFO - ##### Finished clobber step (success) 07:06:05 INFO - ##### 07:06:05 INFO - ##### 07:06:05 INFO - ##### Running read-buildbot-config step. 07:06:05 INFO - ##### 07:06:05 INFO - Running pre-action listener: _resource_record_pre_action 07:06:05 INFO - Running main action method: read_buildbot_config 07:06:05 INFO - Using buildbot properties: 07:06:05 INFO - { 07:06:05 INFO - "project": "", 07:06:05 INFO - "product": "firefox", 07:06:05 INFO - "script_repo_revision": "production", 07:06:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:06:05 INFO - "repository": "", 07:06:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:06:05 INFO - "buildid": "20160704043003", 07:06:05 INFO - "pgo_build": "True", 07:06:05 INFO - "basedir": "/builds/slave/test", 07:06:05 INFO - "buildnumber": 491, 07:06:05 INFO - "slavename": "talos-linux64-ix-060", 07:06:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:06:05 INFO - "platform": "ubuntu64_hw", 07:06:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:06:05 INFO - "branch": "mozilla-central", 07:06:05 INFO - "repo_path": "mozilla-central", 07:06:05 INFO - "revision": "4191df8e4b8e1e2dd0593132dac25915f987f797", 07:06:05 INFO - "stage_platform": "linux64-pgo", 07:06:05 INFO - "builduid": "5ebf9d29c53c4b4c88d4d4f28cccaecc", 07:06:05 INFO - "slavebuilddir": "test" 07:06:05 INFO - } 07:06:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:06:05 INFO - Running post-action listener: _resource_record_post_action 07:06:05 INFO - ##### 07:06:05 INFO - ##### Finished read-buildbot-config step (success) 07:06:05 INFO - ##### 07:06:05 INFO - ##### 07:06:05 INFO - ##### Running download-and-extract step. 07:06:05 INFO - ##### 07:06:05 INFO - Running pre-action listener: _resource_record_pre_action 07:06:05 INFO - Running main action method: download_and_extract 07:06:05 INFO - mkdir: /builds/slave/test/build/tests 07:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:05 INFO - https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:13 INFO - Downloaded 1361 bytes. 07:06:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:13 INFO - Using the following test package requirements: 07:06:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'jsshell-linux-x86_64.zip'], 07:06:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:13 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')]} 07:06:13 INFO - https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:17 INFO - Downloaded 24276598 bytes. 07:06:17 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'] 07:06:17 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 07:06:18 INFO - Return code: 0 07:06:18 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 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 INFO - https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:20 INFO - Downloaded 24276598 bytes. 07:06:20 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'] 07:06:20 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 07:06:21 INFO - Return code: 0 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:21 INFO - https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:22 INFO - Downloaded 14403333 bytes. 07:06:22 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'] 07:06:22 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 07:06:22 INFO - Return code: 0 07:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:22 INFO - https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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 07:06:24 INFO - Downloaded 60361979 bytes. 07:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:24 INFO - mkdir: /builds/slave/test/properties 07:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:24 INFO - Contents: 07:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:24 INFO - Running post-action listener: _resource_record_post_action 07:06:24 INFO - Running post-action listener: set_extra_try_arguments 07:06:24 INFO - ##### 07:06:24 INFO - ##### Finished download-and-extract step (success) 07:06:24 INFO - ##### 07:06:24 INFO - ##### 07:06:24 INFO - ##### Running populate-webroot step. 07:06:24 INFO - ##### 07:06:24 INFO - Running pre-action listener: _resource_record_pre_action 07:06:24 INFO - Running main action method: populate_webroot 07:06:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:24 INFO - '--tppagecycles', 07:06:24 INFO - '7'], 07:06:24 INFO - 'tests': ['tsvgm']}}, 07:06:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['damp', 'tps']}, 07:06:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'tests': ['damp', 'tps']}, 07:06:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['dromaeo_dom']}, 07:06:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['basic_compositor_video']}, 07:06:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['a11yr', 07:06:24 INFO - 'ts_paint', 07:06:24 INFO - 'tpaint', 07:06:24 INFO - 'sessionrestore', 07:06:24 INFO - 'sessionrestore_no_auto_restore', 07:06:24 INFO - 'tabpaint']}, 07:06:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['tsvgx', 07:06:24 INFO - 'tsvgr_opacity', 07:06:24 INFO - 'tart', 07:06:24 INFO - 'tscrollx', 07:06:24 INFO - 'cart']}, 07:06:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:24 INFO - 'tsvgr_opacity', 07:06:24 INFO - 'tart', 07:06:24 INFO - 'tscrollx', 07:06:24 INFO - 'cart']}, 07:06:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'talos_options': ['--disable-e10s'], 07:06:24 INFO - 'tests': ['tp5o']}, 07:06:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'tests': ['tp5o']}, 07:06:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'talos_options': ['--disable-e10s', 07:06:24 INFO - '--xperf_path', 07:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:24 INFO - 'tests': ['tp5n']}, 07:06:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:24 INFO - 'talos_options': ['--xperf_path', 07:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:24 INFO - 'tests': ['tp5n']}}, 07:06:24 INFO - 'talos.zip': {'path': '', 07:06:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:24 INFO - Running post-action listener: _resource_record_post_action 07:06:24 INFO - ##### 07:06:24 INFO - ##### Finished populate-webroot step (success) 07:06:24 INFO - ##### 07:06:24 INFO - ##### 07:06:24 INFO - ##### Running create-virtualenv step. 07:06:24 INFO - ##### 07:06:24 INFO - Running pre-action listener: _resource_record_pre_action 07:06:24 INFO - Running main action method: create_virtualenv 07:06:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:24 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 07:06:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:25 INFO - Using real prefix '/usr' 07:06:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:27 INFO - Installing pip.................done. 07:06:27 INFO - Return code: 0 07:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:27 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 07:06:27 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 07:06:27 INFO - Using env: {'DISPLAY': ':0', 07:06:27 INFO - 'HOME': '/home/cltbld', 07:06:27 INFO - 'LANG': 'en_US.UTF-8', 07:06:27 INFO - 'LANGUAGE': 'en_US:en', 07:06:27 INFO - 'LOGNAME': 'cltbld', 07:06:27 INFO - 'MAIL': '/var/mail/cltbld', 07:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:27 INFO - 'MOZ_NO_REMOTE': '1', 07:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:27 INFO - 'NO_EM_RESTART': '1', 07:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:27 INFO - 'PWD': '/builds/slave/test', 07:06:27 INFO - 'SHELL': '/bin/bash', 07:06:27 INFO - 'SHLVL': '1', 07:06:27 INFO - 'TERM': 'linux', 07:06:27 INFO - 'TMOUT': '86400', 07:06:27 INFO - 'USER': 'cltbld', 07:06:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:27 INFO - '_': '/tools/buildbot/bin/python'} 07:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:27 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 07:06:27 INFO - Cleaning up... 07:06:27 INFO - Return code: 0 07:06:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:27 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 07:06:27 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 07:06:27 INFO - Using env: {'DISPLAY': ':0', 07:06:27 INFO - 'HOME': '/home/cltbld', 07:06:27 INFO - 'LANG': 'en_US.UTF-8', 07:06:27 INFO - 'LANGUAGE': 'en_US:en', 07:06:27 INFO - 'LOGNAME': 'cltbld', 07:06:27 INFO - 'MAIL': '/var/mail/cltbld', 07:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:27 INFO - 'MOZ_NO_REMOTE': '1', 07:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:27 INFO - 'NO_EM_RESTART': '1', 07:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:27 INFO - 'PWD': '/builds/slave/test', 07:06:27 INFO - 'SHELL': '/bin/bash', 07:06:27 INFO - 'SHLVL': '1', 07:06:27 INFO - 'TERM': 'linux', 07:06:27 INFO - 'TMOUT': '86400', 07:06:27 INFO - 'USER': 'cltbld', 07:06:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:27 INFO - '_': '/tools/buildbot/bin/python'} 07:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:27 INFO - Downloading/unpacking psutil>=3.1.1 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:29 INFO - Installing collected packages: psutil 07:06:29 INFO - Running setup.py install for psutil 07:06:30 INFO - building 'psutil._psutil_linux' extension 07:06:30 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 07:06:30 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 07:06:30 INFO - building 'psutil._psutil_posix' extension 07:06:30 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 07:06:30 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 07:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:30 INFO - Successfully installed psutil 07:06:30 INFO - Cleaning up... 07:06:30 INFO - Return code: 0 07:06:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:30 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:30 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 07:06:30 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 07:06:30 INFO - Using env: {'DISPLAY': ':0', 07:06:30 INFO - 'HOME': '/home/cltbld', 07:06:30 INFO - 'LANG': 'en_US.UTF-8', 07:06:30 INFO - 'LANGUAGE': 'en_US:en', 07:06:30 INFO - 'LOGNAME': 'cltbld', 07:06:30 INFO - 'MAIL': '/var/mail/cltbld', 07:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:30 INFO - 'MOZ_NO_REMOTE': '1', 07:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:30 INFO - 'NO_EM_RESTART': '1', 07:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:30 INFO - 'PWD': '/builds/slave/test', 07:06:30 INFO - 'SHELL': '/bin/bash', 07:06:30 INFO - 'SHLVL': '1', 07:06:30 INFO - 'TERM': 'linux', 07:06:30 INFO - 'TMOUT': '86400', 07:06:30 INFO - 'USER': 'cltbld', 07:06:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:30 INFO - '_': '/tools/buildbot/bin/python'} 07:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:32 INFO - Installing collected packages: mozsystemmonitor 07:06:32 INFO - Running setup.py install for mozsystemmonitor 07:06:32 INFO - Successfully installed mozsystemmonitor 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:32 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 07:06:32 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 07:06:32 INFO - Using env: {'DISPLAY': ':0', 07:06:32 INFO - 'HOME': '/home/cltbld', 07:06:32 INFO - 'LANG': 'en_US.UTF-8', 07:06:32 INFO - 'LANGUAGE': 'en_US:en', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MAIL': '/var/mail/cltbld', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SHLVL': '1', 07:06:32 INFO - 'TERM': 'linux', 07:06:32 INFO - 'TMOUT': '86400', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - '_': '/tools/buildbot/bin/python'} 07:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:33 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:34 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 07:06:34 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 07:06:34 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 07:06:34 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 07:06:34 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 07:06:34 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 07:06:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:35 INFO - warning: no files found matching '*.txt' 07:06:35 INFO - no previously-included directories found matching 'build' 07:06:35 INFO - no previously-included directories found matching 'dist' 07:06:35 INFO - no previously-included directories found matching '.git*' 07:06:35 INFO - Installing collected packages: jsonschema, functools32 07:06:35 INFO - Running setup.py install for functools32 07:06:35 INFO - warning: no files found matching '*.txt' 07:06:35 INFO - no previously-included directories found matching 'build' 07:06:35 INFO - no previously-included directories found matching 'dist' 07:06:35 INFO - no previously-included directories found matching '.git*' 07:06:35 INFO - Successfully installed jsonschema functools32 07:06:35 INFO - Cleaning up... 07:06:35 INFO - Return code: 0 07:06:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:35 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')]} 07:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:35 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')]} 07:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:35 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:35 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 07:06:35 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 07:06:35 INFO - Using env: {'DISPLAY': ':0', 07:06:35 INFO - 'HOME': '/home/cltbld', 07:06:35 INFO - 'LANG': 'en_US.UTF-8', 07:06:35 INFO - 'LANGUAGE': 'en_US:en', 07:06:35 INFO - 'LOGNAME': 'cltbld', 07:06:35 INFO - 'MAIL': '/var/mail/cltbld', 07:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:35 INFO - 'MOZ_NO_REMOTE': '1', 07:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:35 INFO - 'NO_EM_RESTART': '1', 07:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:35 INFO - 'PWD': '/builds/slave/test', 07:06:35 INFO - 'SHELL': '/bin/bash', 07:06:35 INFO - 'SHLVL': '1', 07:06:35 INFO - 'TERM': 'linux', 07:06:35 INFO - 'TMOUT': '86400', 07:06:35 INFO - 'USER': 'cltbld', 07:06:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:35 INFO - '_': '/tools/buildbot/bin/python'} 07:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:35 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 07:06:35 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 07:06:35 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 07:06:35 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 07:06:35 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 07:06:35 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 07:06:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 INFO - Downloading docopt-0.6.1.tar.gz 07:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:38 INFO - Running setup.py install for blobuploader 07:06:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:38 INFO - Running setup.py install for requests 07:06:38 INFO - Running setup.py install for docopt 07:06:38 INFO - Successfully installed blobuploader requests docopt 07:06:38 INFO - Cleaning up... 07:06:38 INFO - Return code: 0 07:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:38 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')]} 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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')]} 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:38 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 07:06:38 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 07:06:38 INFO - Using env: {'DISPLAY': ':0', 07:06:38 INFO - 'HOME': '/home/cltbld', 07:06:38 INFO - 'LANG': 'en_US.UTF-8', 07:06:38 INFO - 'LANGUAGE': 'en_US:en', 07:06:38 INFO - 'LOGNAME': 'cltbld', 07:06:38 INFO - 'MAIL': '/var/mail/cltbld', 07:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:38 INFO - 'MOZ_NO_REMOTE': '1', 07:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:38 INFO - 'NO_EM_RESTART': '1', 07:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:38 INFO - 'PWD': '/builds/slave/test', 07:06:38 INFO - 'SHELL': '/bin/bash', 07:06:38 INFO - 'SHLVL': '1', 07:06:38 INFO - 'TERM': 'linux', 07:06:38 INFO - 'TMOUT': '86400', 07:06:38 INFO - 'USER': 'cltbld', 07:06:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:38 INFO - '_': '/tools/buildbot/bin/python'} 07:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:39 INFO - Running setup.py (path:/tmp/pip-O6KXOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:39 INFO - Running setup.py (path:/tmp/pip-_qRiGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:39 INFO - Running setup.py (path:/tmp/pip-hRLQIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:39 INFO - Running setup.py (path:/tmp/pip-GhI_VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:39 INFO - Running setup.py (path:/tmp/pip-pwKH67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:39 INFO - Running setup.py (path:/tmp/pip-Dz15Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:39 INFO - Running setup.py (path:/tmp/pip-q5Mg7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:39 INFO - Running setup.py (path:/tmp/pip-JvjRm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:39 INFO - Running setup.py (path:/tmp/pip-KnxE6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:39 INFO - Running setup.py (path:/tmp/pip-CcLAee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:39 INFO - Running setup.py (path:/tmp/pip-TzI16S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:39 INFO - Running setup.py (path:/tmp/pip-CPgAsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:39 INFO - Running setup.py (path:/tmp/pip-L5UKTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:40 INFO - Running setup.py (path:/tmp/pip-7sbPts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:40 INFO - Running setup.py (path:/tmp/pip-HthNFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:40 INFO - Running setup.py (path:/tmp/pip-VtIgWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:40 INFO - Running setup.py (path:/tmp/pip-7lFRah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:40 INFO - Running setup.py install for manifestparser 07:06:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:40 INFO - Running setup.py install for mozcrash 07:06:40 INFO - Running setup.py install for mozdebug 07:06:40 INFO - Running setup.py install for mozdevice 07:06:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:40 INFO - Running setup.py install for mozfile 07:06:40 INFO - Running setup.py install for mozhttpd 07:06:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:40 INFO - Running setup.py install for mozinfo 07:06:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for mozInstall 07:06:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for mozleak 07:06:41 INFO - Running setup.py install for mozlog 07:06:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for moznetwork 07:06:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for mozprocess 07:06:41 INFO - Running setup.py install for mozprofile 07:06:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for mozrunner 07:06:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:41 INFO - Running setup.py install for mozscreenshot 07:06:41 INFO - Running setup.py install for moztest 07:06:42 INFO - Running setup.py install for mozversion 07:06:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:42 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 07:06:42 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 07:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:42 INFO - Running setup.py (path:/tmp/pip-rGhBlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:42 INFO - Running setup.py (path:/tmp/pip-LR7MfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:42 INFO - Running setup.py (path:/tmp/pip-6bvg8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:42 INFO - Running setup.py (path:/tmp/pip-s7jQMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:42 INFO - Running setup.py (path:/tmp/pip-3cAa1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:42 INFO - Running setup.py (path:/tmp/pip-yUk3Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:42 INFO - Running setup.py (path:/tmp/pip-4kYZkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:42 INFO - Running setup.py (path:/tmp/pip-B49DWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:42 INFO - Running setup.py (path:/tmp/pip-fB1rwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:42 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)) 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:42 INFO - Running setup.py (path:/tmp/pip-_SB9KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:43 INFO - Running setup.py (path:/tmp/pip-pZTjDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:43 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:43 INFO - Running setup.py (path:/tmp/pip-mzXh_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:43 INFO - Running setup.py (path:/tmp/pip-l0gw3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:43 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:43 INFO - Running setup.py (path:/tmp/pip-QfCLgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:43 INFO - Running setup.py (path:/tmp/pip-s0cHfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:43 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:43 INFO - Running setup.py (path:/tmp/pip-ogW4kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:43 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)) 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:43 INFO - Running setup.py (path:/tmp/pip-0Q1heR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:43 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 07:06:43 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 07:06:43 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 07:06:43 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 07:06:43 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 07:06:43 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 07:06:45 INFO - Downloading blessings-1.6.tar.gz 07:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:45 INFO - Installing collected packages: blessings 07:06:45 INFO - Running setup.py install for blessings 07:06:45 INFO - Successfully installed blessings 07:06:45 INFO - Cleaning up... 07:06:45 INFO - Return code: 0 07:06:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:45 INFO - Reading from file tmpfile_stdout 07:06:45 INFO - Current package versions: 07:06:45 INFO - argparse == 1.2.1 07:06:45 INFO - blessings == 1.6 07:06:45 INFO - blobuploader == 1.2.4 07:06:45 INFO - docopt == 0.6.1 07:06:45 INFO - functools32 == 3.2.3-2 07:06:45 INFO - jsonschema == 2.5.1 07:06:45 INFO - manifestparser == 1.1 07:06:45 INFO - mozInstall == 1.12 07:06:45 INFO - mozcrash == 0.17 07:06:45 INFO - mozdebug == 0.1 07:06:45 INFO - mozdevice == 0.48 07:06:45 INFO - mozfile == 1.2 07:06:45 INFO - mozhttpd == 0.7 07:06:45 INFO - mozinfo == 0.9 07:06:45 INFO - mozleak == 0.1 07:06:45 INFO - mozlog == 3.2 07:06:45 INFO - moznetwork == 0.27 07:06:45 INFO - mozprocess == 0.22 07:06:45 INFO - mozprofile == 0.28 07:06:45 INFO - mozrunner == 6.11 07:06:45 INFO - mozscreenshot == 0.1 07:06:45 INFO - mozsystemmonitor == 0.3 07:06:45 INFO - moztest == 0.7 07:06:45 INFO - mozversion == 1.4 07:06:45 INFO - psutil == 3.1.1 07:06:45 INFO - requests == 1.2.3 07:06:45 INFO - wsgiref == 0.1.2 07:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:45 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')]} 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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')]} 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:45 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 07:06:45 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 07:06:45 INFO - Using env: {'DISPLAY': ':0', 07:06:45 INFO - 'HOME': '/home/cltbld', 07:06:45 INFO - 'LANG': 'en_US.UTF-8', 07:06:45 INFO - 'LANGUAGE': 'en_US:en', 07:06:45 INFO - 'LOGNAME': 'cltbld', 07:06:45 INFO - 'MAIL': '/var/mail/cltbld', 07:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:45 INFO - 'MOZ_NO_REMOTE': '1', 07:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:45 INFO - 'NO_EM_RESTART': '1', 07:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:45 INFO - 'PWD': '/builds/slave/test', 07:06:45 INFO - 'SHELL': '/bin/bash', 07:06:45 INFO - 'SHLVL': '1', 07:06:45 INFO - 'TERM': 'linux', 07:06:45 INFO - 'TMOUT': '86400', 07:06:45 INFO - 'USER': 'cltbld', 07:06:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:45 INFO - '_': '/tools/buildbot/bin/python'} 07:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 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)) 07:06:46 INFO - Cleaning up... 07:06:46 INFO - Return code: 0 07:06:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ece030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', '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 07:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:46 INFO - Using env: {'DISPLAY': ':0', 07:06:46 INFO - 'HOME': '/home/cltbld', 07:06:46 INFO - 'LANG': 'en_US.UTF-8', 07:06:46 INFO - 'LANGUAGE': 'en_US:en', 07:06:46 INFO - 'LOGNAME': 'cltbld', 07:06:46 INFO - 'MAIL': '/var/mail/cltbld', 07:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:46 INFO - 'MOZ_NO_REMOTE': '1', 07:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:46 INFO - 'NO_EM_RESTART': '1', 07:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:46 INFO - 'PWD': '/builds/slave/test', 07:06:46 INFO - 'SHELL': '/bin/bash', 07:06:46 INFO - 'SHLVL': '1', 07:06:46 INFO - 'TERM': 'linux', 07:06:46 INFO - 'TMOUT': '86400', 07:06:46 INFO - 'USER': 'cltbld', 07:06:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:46 INFO - '_': '/tools/buildbot/bin/python'} 07:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:46 INFO - Cleaning up... 07:06:46 INFO - Return code: 0 07:06:46 INFO - Running post-action listener: _resource_record_post_action 07:06:46 INFO - Running post-action listener: _start_resource_monitoring 07:06:46 INFO - Starting resource monitoring. 07:06:46 INFO - ##### 07:06:46 INFO - ##### Finished create-virtualenv step (success) 07:06:46 INFO - ##### 07:06:46 INFO - ##### 07:06:46 INFO - ##### Running install step. 07:06:46 INFO - ##### 07:06:46 INFO - Running pre-action listener: _resource_record_pre_action 07:06:46 INFO - Running main action method: install 07:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:46 INFO - Reading from file tmpfile_stdout 07:06:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:46 INFO - Reading from file tmpfile_stdout 07:06:46 INFO - Output received: 07:06:46 INFO - Usage: mozinstall [options] installer 07:06:46 INFO - Options: 07:06:46 INFO - -h, --help show this help message and exit 07:06:46 INFO - -d DEST, --destination=DEST 07:06:46 INFO - Directory to install application into. [default: 07:06:46 INFO - "/builds/slave/test"] 07:06:46 INFO - --app=APP Application being installed. [default: firefox] 07:06:46 INFO - mkdir: /builds/slave/test/build/application 07:06:46 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'] 07:06:46 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 07:07:03 INFO - Reading from file tmpfile_stdout 07:07:03 INFO - Output received: 07:07:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:03 INFO - Running post-action listener: _resource_record_post_action 07:07:03 INFO - ##### 07:07:03 INFO - ##### Finished install step (success) 07:07:03 INFO - ##### 07:07:03 INFO - ##### 07:07:03 INFO - ##### Running run-tests step. 07:07:03 INFO - ##### 07:07:03 INFO - Running pre-action listener: _resource_record_pre_action 07:07:03 INFO - Running main action method: run_tests 07:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:03 INFO - Python 2.7.3 07:07:03 INFO - Return code: 0 07:07:03 INFO - grabbing minidump binary from tooltool 07:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:03 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 0x218d3b0>, '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 0x218e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:03 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 07:07:03 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 07:07:03 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 07:07:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:03 INFO - Return code: 0 07:07:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 07:07:03 INFO - Using env: {'DISPLAY': ':0', 07:07:03 INFO - 'HOME': '/home/cltbld', 07:07:03 INFO - 'LANG': 'en_US.UTF-8', 07:07:03 INFO - 'LANGUAGE': 'en_US:en', 07:07:03 INFO - 'LOGNAME': 'cltbld', 07:07:03 INFO - 'MAIL': '/var/mail/cltbld', 07:07:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:03 INFO - 'MOZ_NO_REMOTE': '1', 07:07:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:03 INFO - 'NO_EM_RESTART': '1', 07:07:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:03 INFO - 'PWD': '/builds/slave/test', 07:07:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:03 INFO - 'SHELL': '/bin/bash', 07:07:03 INFO - 'SHLVL': '1', 07:07:03 INFO - 'TERM': 'linux', 07:07:03 INFO - 'TMOUT': '86400', 07:07:03 INFO - 'USER': 'cltbld', 07:07:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858', 07:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:03 INFO - '_': '/tools/buildbot/bin/python'} 07:07:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:07:04 INFO - mozversion application_buildid: 20160704043003 07:07:04 INFO - mozversion application_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 07:07:04 INFO - mozversion application_display_name: Nightly 07:07:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:04 INFO - mozversion application_name: Firefox 07:07:04 INFO - mozversion application_remotingname: firefox 07:07:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:04 INFO - mozversion application_vendor: Mozilla 07:07:04 INFO - mozversion application_version: 50.0a1 07:07:04 INFO - mozversion platform_buildid: 20160704043003 07:07:04 INFO - mozversion platform_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 07:07:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:04 INFO - mozversion platform_version: 50.0a1 07:07:04 INFO - using testdate: 1467641224 07:07:04 INFO - actual date: 1467641224 07:07:04 INFO - starting webserver on 'localhost:53157' 07:07:04 INFO - SUITE-START | Running 2 tests 07:07:04 INFO - TEST-START | dromaeo_css 07:07:04 INFO - operating with platform_type : linux_ 07:07:04 INFO - Initialising browser for dromaeo_css test... 07:07:04 INFO - TEST-INFO | started process 22959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_kVIO/profile http://localhost:53157/getInfo.html) 07:07:08 INFO - PROCESS | 22959 | __metrics Screen width/height:1600/1200 07:07:08 INFO - PROCESS | 22959 | colorDepth:24 07:07:08 INFO - PROCESS | 22959 | Browser inner width/height: 1024/697 07:07:08 INFO - PROCESS | 22959 | __metrics 07:07:09 INFO - PROCESS | 22959 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:10 INFO - TEST-INFO | 22959: exit 0 07:07:10 INFO - Browser initialized. 07:07:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:10 INFO - TEST-INFO | started process 23042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_kVIO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:21 INFO - PROCESS | 23042 | RSS: Main: 157786112 07:07:21 INFO - PROCESS | 23042 | 07:08:13 INFO - PROCESS | 23042 | 1467641293756 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] 07:10:21 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53157/tests/dromaeo/cssquery-ext.html) 07:10:22 INFO - PROCESS | 23042 | RSS: Main: 282419200 07:10:22 INFO - PROCESS | 23042 | 07:13:25 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-ext.html (next: http://localhost:53157/tests/dromaeo/cssquery-jquery.html) 07:13:25 INFO - PROCESS | 23042 | RSS: Main: 238841856 07:13:25 INFO - PROCESS | 23042 | 07:16:27 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53157/tests/dromaeo/cssquery-mootools.html) 07:16:28 INFO - PROCESS | 23042 | RSS: Main: 242847744 07:16:28 INFO - PROCESS | 23042 | 07:19:30 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53157/tests/dromaeo/cssquery-prototype.html) 07:19:30 INFO - PROCESS | 23042 | RSS: Main: 237862912 07:19:30 INFO - PROCESS | 23042 | 07:22:33 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53157/tests/dromaeo/cssquery-yui.html) 07:22:34 INFO - PROCESS | 23042 | RSS: Main: 224509952 07:22:34 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-yui.html (next: http://localhost:53157/tests/dromaeo/cssquery-dojo.html) 07:25:37 INFO - PROCESS | 23042 | RSS: Main: 276357120 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | __start_tp_report 07:25:37 INFO - PROCESS | 23042 | _x_x_mozilla_page_load 07:25:37 INFO - PROCESS | 23042 | _x_x_mozilla_page_load_details 07:25:37 INFO - PROCESS | 23042 | |i|pagename|runs| 07:25:37 INFO - PROCESS | 23042 | |0;dojo.html;3095.102420298114;3099.488584383577;3114.7508199344056;3129.953050704238;3145.559621652969;5176.55999240065;5262.789488420463;5295.7881684732565;5351.759170837312;5353.411124776271;5256.8685782855355;5320.893582128355;5349.786008559663;5362.678239305635;5391.973040134803;4827.324174615556;4848.272759086148;4852.514748525155;4852.611791056707;5035.571976381993;4999.375078115236;5001.399832020163;5012.72430016349;5016.724080175589;5019.447860735316;4718.764061796896;4719.362886010379;4753.025629745894;4904.5831104356175;4937.111319962423;4792.041591681643;4802.75986200692;4804.1352556539805;4819.831305904277;4836.951630483685;4837.395325584302;4853.805847766085;4854.708717476963;4856.3201151838775;4959.305697202394;5443.755031023574;5450.863728406782;5465.918011229795;5468;5468.960897429476;5551.444855514456;5640.238567793336;5739.626924249952;5745.6552606843725;5838.678872662002;5796.333421656522;5825;5833.854153646151;5843.649381037151;5850.531957443394;5439.048166570834;5443.646162999393;5444.6188766786345;5447.319085114361;5450.31871016123;5687.9431205687415;5731.799387021518;5812.099124635688;5822.039363505059;5882.970585147133;5609.046462101453;5618.606697531215;5656.943430565724;5661.801836935688;5664.26364572603;5523.585731070186;5667.688277144714;5725;5728.226689396878;5730.140478928194;5562.9443705563235;5636.210930469655;5644.068728659725;5667.688277144796;5674.9501342251815;5678.4605462480995;5681.34664513578;5684.431556844283;5684.54523638108;5685.431456854281;4272.957270427318;4292.484901811803;4348;4348.173846969065;4396.846110386121;3701.722370822199;3892.8442862285756;3896.902577435587;3906.628870257321;3943.9802800986386;5337.466253374631;5377.435369286247;5395.05586522357;5401.432849550741;5438.238646589481;5616.747246373923;5650.0959846424375;5683.403242659461;5720.742566584514;5777.913331300034;5362.597805164628;5373.35519737634;5390.4879036491475;5398.352197736297;5424.810131645373;4889.095517329305;4899.314096026559;4905.583025442877;4927.334809800631;4958.553730164303;5758.539316854642;5843.18195452637;5865.88268234633;5897.056470964625;5914.585978981516;5764.452377024176;5775.768969241183;5782.392848750821;5783.334916484489;5784.045632470596;5932.614380065282;5937.4656280933195;5945.435183657545;5946.226990491208;5949.940500594938;5431.266778984945;5579.386267510489;5618.550515958632;5664.461876121762;5690.658560486384;5717.42825717425;5720.227769251098;5726.484616384545;5730.885382292247;5733.3406658234835;5351.759170837399;5480.945190548044;5566.276384070045;5568.220449137205;5574.052411090043;5485.6982865942755;5509;5529.834104976857;5566.805161819317;5584.720763961867;5466.671999680032;5474.452554744494;5494.2857428534035;5501.724913754377;5507.063799154073;5488.451154884479;5520.033994051106;5578.832635020955;5579.414161512983;5605.859853503695;5278.868028299324;5324.6006549508165;5398.40617532079;5436.374816896107;5544.63959842609 07:25:37 INFO - PROCESS | 23042 | |1;ext.html;591.8697886464976;618.5700937848195;626.6240255846493;636.7834936121718;637.2448648351701;42665.36001959969;43795;43904.780476097614;43924.78037609811;47807.52192478074;44742;45092;45129.77435112828;45130.54869451305;45287.77356113215;9111.498867562264;9233.58448869799;9239.538023098818;9253.35226534143;9253.768655783626;9091.227245684091;9145.039770824067;9159.992400835903;9160.038195989426;9180.173784359406;9193.862092068624;9226.261899048093;9230.769230769218;9231.3076519261;9231.399959002676;9141.085891410872;9163.08369163085;9177.908220917805;9179;9213.585388657526;8995.235404990584;9003.819923601492;9005.459672419676;9035.18683318498;9042.367034307601;42742.358864617054;43153.56846431527;43171;43320.3501947471;43337.34993975093;3477.5826900771817;3512.8594856205723;3692.0769807548113;3973.662238709684;4181.644560212386;33133.3373332532;33385.833070834735;33733;33733.662663373296;35035.474467883;4032.5967403259733;4204.07510347723;4275.251830929575;4369.825206991716;4394.516603173648;348930.2553487242;352108;352476;352977;354613;58460.70769646124;58645.12032319519;58717;58732.41267587355;58893.70553147292;60043.699781500814;60259;60263.69868150719;60292.397076028676;60436.395636043075;16632.50102496927;16796.580085497717;16810.663786724443;16838.410655627238;16843.83156168447;13108.147970381895;13164.275964822027;13181.406836692371;13183.209007459584;13204.405801738945;15831.445899393466;17172.111067782535;17234.396796112076;17239.82760172407;17299.481015569552;6495.6752162391695;6505.251896031922;6639.86720265592;6696.2968888267005;6719.328067193339;962.9085236902483;996.8554559588819;1020.5560581147224;1048.3657387280584;1096.5010920031366;31726.524102138486;31750.092436218936;32249.51625725616;32597.511037334458;32771.67228327734;1147.5581900968186;1151.5681619392728;1164.1152723929706;1173.8884805943421;1201.783678937782;16585.17074146288;17027.574310642085;17031.318747250218;17138;17231.56921076958;550626;551102;555819;556627;558889;58216.41783582194;58390.12414813781;58396.70801645965;58451;58465.70767146222;1219.0065096945962;1328.35574746248;1369.486442584031;1371.6639423341346;1376.938037788282;30692.846535768072;34331.656683433845;34345;34450.31099377948;34526.48210276798;51482;51740.48259517357;51967.724518566676;52091.73954130205;52100;401021;404731;405370;405919;407577;24876.253712388658;27309.180724578295;27936.161915142577;27944;28119.297017573906;48112.27831582599;48192.277115843994;48831.75584122057;48994.755026224644;49666.751666241435;41096.38355424611;41522.37716434195;42199.57800422079;42585.36121958235;43150.35274470948;41079.58920410877;41659.583404166784;41747.16505669809;42420.36369454522;42556.78721606372;40157;41107.383389248585;41363.379549306184;41427.37858932058;41494.1701165981;34781.826090870396;37051.444228336055;37090;37207.441888371155;37803.432948505244;27589.31026724348;28074.019480906765;28213.717862821108;28302.272988232817;28363.858180708965 07:25:37 INFO - PROCESS | 23042 | |2;jquery.html;398.5615822595144;398.59542564297243;400.90177906412936;403.45734986443233;416.7582801974855;18238.726419103707;18673.346432874852;19761.40715778527;19769.703454448176;20072;15235.847641523582;16337.509874703748;16358.591035224126;18717.157727902242;18946.905265473688;5228.79084836607;5368.141097424394;5371.086915224401;5714.57140714446;5933.970330148343;5873.207117039209;5875.294964604253;5876.0598304271325;5889.617174883619;5912.970435147839;5193.065248255312;5312.893742125155;5337.919931201016;5716.314042314928;5795.333536643277;5250.6587071840395;5286.629935904488;5295.311609490742;5309.442508536606;5311.336082989626;5137.229415587654;5173.948260517422;5218.530332270076;5225.268462415265;5252.343457067866;13836.377363018688;14059.507917222849;14177;20411.489712757153;24528.509429811304;2595.23440585026;2672.906448274301;2731.7814574834165;3010.8795648174046;3018.4868572342534;10136.239782016304;10365.689029329133;10569.524371403306;13808.447662093504;14528.273586320747;1907.437305994735;1973.703944408336;1991.0542492316179;2027.108072448118;2031.5327474680905;69737.95393069107;72723.63638181829;82451.5877420609;82968;88253;11091.223614346918;11149.498272577754;11294.7176320591;11306.208565400508;11469.426528673534;15454.459093931659;15502.224888755743;15558.455454059054;15585.142817144939;15589.76615350748;8296.419250652396;8342.958285208535;8428.157184281523;8644.95677521621;8656.437331573428;8112.3104536113915;8168.509889406655;8210.548419836847;8383.706570270011;8395.790105247417;4702.600278976325;4827.42070951488;4838.104950584153;4868.659193856467;4913.336699545587;1884.8303652671325;1957.1388589020785;1989.691597802343;1995.600879824041;1996.6805311150438;904.8733177355175;969.2439896880445;984.5028260728286;1069.9625513107003;1106.8063088959561;19675.917824519503;19916.60166796656;20015.699764503544;20282.188712451632;20565.69151462729;963.1572374172599;989.3124278626285;996.2179688944144;1023.6110278094277;1044.3525014491065;10596.364218146937;10919.252130495102;11062.723431914266;11124.833127503094;11126.554937802559;477757;480014;487345;498235;507950;95334;95622;96600.51699741457;98144.50927745315;98784.50607746915;1020.2042406922463;1025.9281850270409;1033.34382667007;1057.4659796802566;1065.9626913058005;17423.215955282296;17438.30246790165;17645.117744112486;17925.910370448586;18129.184186711365;42906.78546607247;43233.56766432295;43522.12955740804;43603.781981089895;44381.668549943555;59131;59302;59593.404065960516;60951.39048609457;61822;8801.559922004002;8831;8835.867461987948;8841.911580884365;8934.86597701022;9784.461854598065;13604.25176615256;13710.725785484434;13726.245056521988;14302.928485357923;12179.208351457128;12235.143539952474;12365.567205147776;12492.563355214266;12782.36088195568;11721.355325456841;12081.154319197572;12121.69695757613;12188.878111219128;12437.315947622968;12166.939165304117;12186.2078964867;12236.327002014974;12400.131990760921;12499.625011249676;8586.742397728078;8679;8751.956240218758;8760.868586971073;8807.983571425;8877.9346478423;11574.305541667527;12187.207831490925;12259.448324825582;12313.630591082281 07:25:37 INFO - PROCESS | 23042 | |3;mootools.html;1341.9396127174275;1455.185096346046;1489.5382431446253;1591.538453848384;1739.6868563658536;7863.606819659016;8204.58977051148;8222.876656850152;8223.095459499451;8389.91610083899;8210.466319689216;8472.872906906387;8664.480131192133;8673.132686731324;8680.652773889036;1979.8119178678003;2149.312220089572;2165.71845660064;2212.734471863371;2225.6550234713645;2219.034719896842;2244.1920908472935;2248.15694114707;2251.1653002802746;2252.234240358278;2200.3728937252886;2220.7890250426185;2234.039363073886;2235.6646503024513;2236.1279101150562;1916.2335065973582;2119.3853782403085;2195.3084778294865;2198.560287942402;2208.6466165413617;2083.666613341873;2098.4229336932312;2109.9050542725613;2115.4922818523596;2118.110393634677;8595.226429621363;8634.093420190915;8644.394892357537;8658.523781192032;8678.956605216934;4966.528179822911;4980.302757613937;4995.275685025687;4997.350344455198;5102.056119617882;3119.8128112313334;3181.316017056344;3182.7294679952233;3215.1479857837694;3235.7087862092526;1098.1050443888205;1130.4178348150708;1132.9037031852301;1138.8633363996373;1149.2127892393737;11918.821217681741;12196.329201893892;12198.39008049594;12206.328651924141;12220.755584888342;4437.134758722083;4438.423005009328;4569.109023740405;4616.60758835496;4697.389339385858;10377.221708371751;10392.688219353431;10400.47997600117;10407.739806504898;10422.895771042193;5308.442613525602;5326.92009619856;5327.440618734977;5329.786808527693;5331.333583302087;4125.463689720377;4594.310853371954;4709.95290047102;4713.622910167179;4784.40194975628;3945.4870866787132;3968.265870813909;4026.355783074694;4050.3721923101966;4096.160287141129;1133.1784456269138;1207.5833837326109;1222.1628184693514;1241.273854794955;1256.824044633752;957.1768279279814;972.5234635028785;973.6056896956744;984.9655262065936;989.2432289298692;5564.944350556442;5641.26663533738;5699.974004679198;5837.67892765902;5910.083936989773;953.5422996961497;974.9951250243703;982.4792859784326;1002.3985608634761;1003.6487229469627;3974.20515896816;4017.2367250222364;4029.8992525187105;4053.331200351909;4090.734102283342;10117.29178957466;10353.378797272188;10502.159827213805;10513.211509136845;10519.631812886511;10385.84421233682;10406.5837366506;10410;10414.375137491776;10418.635347762793;7866.606669666494;7945.761627151194;7955.4828936118965;7957.602119893866;7969.442139050327;5729.627574207663;5778.104393818965;5907.113932909926;5948.2862056553495;6159.692015399301;9617.951910240405;9642.758931026781;9709.805803884024;9794.265430092913;9809.705708828747;10106.39361638304;10135.341202821794;10204.285700001226;10206.336588121749;10217.846732298873;7822.295993360625;7834.177411371724;8000.479968802009;8002.9599852000365;8032.236937490929;8440.915590844013;8537.74386768398;8558.52928088961;8567.27178189861;8575.742727718178;7635.88546171819;7859.567723775247;7937.087234968052;7995.440319177835;8039.075506316848;7644.885326720215;7765.5728934906865;7794.88307675374;7819.765407037798;7974;6847.417969472651;6885.965570172117;6894.276101009322;6900.309969003059;6904.516683832084;4940.975295123645;5145.176771716508;5219.582433405394;5271.604629652715;5275.182346736108;5128.717920514258;5146.871328216825;5153.7165455900285;5194.922076168936;5317.361916570037 07:25:37 INFO - PROCESS | 23042 | |4;prototype.html;333.48328671739006;336.6061707801872;340.2497493027874;340.8329918340014;345.44728434504793;5269.235960785683;5276.944611077785;5287.92068118978;5289.973550132248;5291.973540132294;5182.637215394924;5199.4800519947985;5205.453427390126;5232.529072383485;5252.317198764155;4186.3092589722655;4190.53904070552;4191.853285135021;4193.6645068394455;4243.172581346638;3855.633714797104;3992.860249891254;4113.56807535209;4130.628243458088;4166.458360413142;4083;4126.216018956388;4130.8141133648905;4131.173765246947;4135.1316223593085;3969.6900022992345;4144.626983571478;4153.7300075494995;4170.582941705836;4171.791410429481;3615.620359862203;3662.8755321913227;3668.761530500509;3669.5229620149476;3677.3932301170275;5126.92309615356;5146.150885103991;5152.587792976553;5154.845354639367;5172.327597412313;4627.583517483443;4701.318308845232;4718.740469274188;4721.268203428474;4722.669413141081;5464.207689884945;5484.080571799878;5484.314460692413;5488.231647569343;5492.171531661198;4003.899902502432;4016.4176194451934;4021.617946295097;4023.7786921719294;4048.1701251243426;5206.765695543671;5537.418571050022;5729.427057294237;5734.741936612862;5737.885242295172;4045.474088368552;4066.2274167908004;4068.4304197412384;4073.2260870434525;4086.2429155463437;4119.7940102994735;4134.193832202692;4138.882501724578;4144.70987030911;4150.252954468165;4710.29345598163;4716.504766999416;4721.433427988594;4723.716577005391;4728.645351598644;5293.258943747878;5520.834374968757;5524.364698059694;5534.501894829485;5574.804881829197;1406.9718605628034;1415.794709767078;1417.9432822686977;1427.450431583827;1431.3415828718905;884.4118661090431;919.8620206969008;923.4966943016072;929.0662883801871;937.1378331934636;4693.976530117396;4708.104515722805;4761.285807128958;4769.308450274691;4784.976075119602;4907.067657145131;4970.502949705001;4972.950270497321;4998.600111991032;5040.697558146523;4781.2350023996;4787.712737235777;4793.448753393404;4807.18277892759;4984.476629953802;2999.2351950252546;3016.668166501683;3060.73983711387;3060.7857449978733;3077.6768439313996;5852.91721031602;5869.090291004901;5889.234399528034;5892.734826932799;5906.379830117861;5489.27087967297;5601.403599973988;5829.183914252008;5835.883282334329;5899.7050147492455;5654.6324488908085;5745.6552606843725;5755.827325180251;5762;5805.274340707411;5626.212330273683;5642.163328936363;5646.040173170489;5677.034904066236;5683.7779877326575;5450.610094425896;5562.3047119110115;5567.749451274622;5592.580556458201;5617.6910269933915;5682.801101961411;5736.512396446349;5772.855678608068;5788.623739456922;5818.94181058201;3981.7411868228473;3997.92004159921;3999.400089986409;4022.21566794484;4024.879253622396;5547.7780888764;5566;5568.9443105568425;5598.216249725123;5607.523360514238;5440.374356949002;5455.727213639223;5467.6719396836315;5475.151351540518;5482.479164479528;5222.660527065728;5454.390954668303;5500.559955203494;5517.751701173376;5518.420565840529;5472.233887255867;5481.095619222783;5488.62784303924;5513.862153446196;5522.282103326542;5558.471945165203;5562.249096371938;5579.609427340048;5615.045442274904;5628.142712904813;5215.348081489814;5435.891282174413;5439.347278326626;5478.397376288684;5483.506484416422 07:25:37 INFO - PROCESS | 23042 | |5;yui.html;716.663168310894;719.3777382564084;725.9709611615535;728.8688036153491;803.1767438375664;15549.222538873053;16499.422520211796;16513.66972660546;16514.339426422943;16538.42115525955;14731.189784561844;14892.776608350883;14906.925465372686;15020.699586008273;15565.53303400897;772.5712229712507;788.6687591211676;789.9249571290718;791.0704921716988;793.8729803231485;645.8127143128511;760.6615056299948;789.4868335581889;793.6190628498324;801.418971245845;842.3261390887296;844.1389782421926;844.4764246167354;845.1084106267884;847.2290215903529;671.664167916042;840.4915026408995;841.9789505262356;842.4439869686008;842.473454091193;582.3855832097136;596.9701514924236;601.714185761764;604.3865476541314;604.7792555717175;15384.846151538566;15386.615334616612;15409.614759630987;15440.845591544054;15459.845401545954;13345.33273336339;13774.104683195661;13809.861901381058;14073.437062517487;14080.436782528686;11847.881521184763;12119.697007574792;12241.510339586406;12652.240865548096;12970.156939798882;4510.21071312519;4517.909641807179;4587.587117159472;4731;4739.715617062987;74250.62874685592;75338;77327.6133619334;77984;78929;11461.369624670557;11527.365994870363;11683.649490515128;11718.765624687458;12045.819312710317;20846.895765521378;20940;20956;20979.16083356679;21050.157993680386;8015.559144247122;8137.674493020331;8162.102168761431;8320.70877519284;8475.957620211859;4714.929276060861;4741.359916411309;4743.7153770773175;4769.403824521934;4830;3321.5183798349103;3474.6872781449283;3476.3916314645344;3480.4953281774;3487.3199726053685;611.541343992006;620.711369213318;623.6008954269271;637.0539748473514;640.2796853539768;630.7792272704609;735.3492159438935;764.2014095270456;772.2702046566053;776.0997243197863;9173.312001599907;9690.95154524223;9812.90187098134;9844.212463002943;9857.852132218022;717.921616919027;745.4520927118564;755.4183278875236;764.896738940247;769.5613500304885;4298.78506074695;4470.575295346936;4587.4036375271;4660.580547750718;4671.976640116845;94642;96507;98196;112805;114846.42576787062;107555.46222268838;109103;111638.44180779044;111860;112650.43674781574;90245.54877225572;93307;98103;98375;99162.50418748004;9260.907390926273;9741.415515069119;9757.658481953098;9791.951040244754;9869.963653816532;54217.72891135519;54437.72781136069;55434.44565554293;55482.72258638681;55992.16011759908;79486;82068.58965705133;84542.57728711318;84641;85480.57259713662;12669.493220271086;12759.553415630407;13364.732705345645;13556.25440600737;13725.656858578615;15948.441804536786;16022.839771602135;16230.594235144215;16332.755008674641;17133.22900469457;14121.788173177616;14278.19175360159;14442.711145777235;14591.270436478346;15301.617459563155;14968;15007.474738384104;15445.150516721687;15516.84483155154;15752.212389380256;13879.722405552035;14515.201663908165;14640.194789286692;14728;14807.92596037056;11855.703607409883;12047.277163370225;12081.51673933068;12081.57714479989;12286.38568071575;12504.599107027378;12522.93738531338;12723;12974.481020759064;13002.139529303538 07:25:37 INFO - PROCESS | 23042 | __end_tp_report 07:25:37 INFO - PROCESS | 23042 | __start_cc_report 07:25:37 INFO - PROCESS | 23042 | _x_x_mozilla_cycle_collect,1036 07:25:37 INFO - PROCESS | 23042 | __end_cc_report 07:25:37 INFO - PROCESS | 23042 | __startTimestamp1467642337504__endTimestamp 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | ------- Summary: start ------- 07:25:37 INFO - PROCESS | 23042 | Number of tests: 6 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#0] dojo.html Cycles:165 Average:5301.65 Median:5474.45 stddev:598.73 (10.9%) stddev-sans-first:575.00 07:25:37 INFO - PROCESS | 23042 | Values: 3095.1 3099.5 3114.8 3130.0 3145.6 5176.6 5262.8 5295.8 5351.8 5353.4 5256.9 5320.9 5349.8 5362.7 5392.0 4827.3 4848.3 4852.5 4852.6 5035.6 4999.4 5001.4 5012.7 5016.7 5019.4 4718.8 4719.4 4753.0 4904.6 4937.1 4792.0 4802.8 4804.1 4819.8 4837.0 4837.4 4853.8 4854.7 4856.3 4959.3 5443.8 5450.9 5465.9 5468.0 5469.0 5551.4 5640.2 5739.6 5745.7 5838.7 5796.3 5825.0 5833.9 5843.6 5850.5 5439.0 5443.6 5444.6 5447.3 5450.3 5687.9 5731.8 5812.1 5822.0 5883.0 5609.0 5618.6 5656.9 5661.8 5664.3 5523.6 5667.7 5725.0 5728.2 5730.1 5562.9 5636.2 5644.1 5667.7 5675.0 5678.5 5681.3 5684.4 5684.5 5685.4 4273.0 4292.5 4348.0 4348.2 4396.8 3701.7 3892.8 3896.9 3906.6 3944.0 5337.5 5377.4 5395.1 5401.4 5438.2 5616.7 5650.1 5683.4 5720.7 5777.9 5362.6 5373.4 5390.5 5398.4 5424.8 4889.1 4899.3 4905.6 4927.3 4958.6 5758.5 5843.2 5865.9 5897.1 5914.6 5764.5 5775.8 5782.4 5783.3 5784.0 5932.6 5937.5 5945.4 5946.2 5949.9 5431.3 5579.4 5618.6 5664.5 5690.7 5717.4 5720.2 5726.5 5730.9 5733.3 5351.8 5480.9 5566.3 5568.2 5574.1 5485.7 5509.0 5529.8 5566.8 5584.7 5466.7 5474.5 5494.3 5501.7 5507.1 5488.5 5520.0 5578.8 5579.4 5605.9 5278.9 5324.6 5398.4 5436.4 5544.6 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#1] ext.html Cycles:180 Average:60216.05 Median:42309.97 stddev:118118.49 (279.2%) stddev-sans-first:118365.01 07:25:37 INFO - PROCESS | 23042 | Values: 591.9 618.6 626.6 636.8 637.2 42665.4 43795.0 43904.8 43924.8 47807.5 44742.0 45092.0 45129.8 45130.5 45287.8 9111.5 9233.6 9239.5 9253.4 9253.8 9091.2 9145.0 9160.0 9160.0 9180.2 9193.9 9226.3 9230.8 9231.3 9231.4 9141.1 9163.1 9177.9 9179.0 9213.6 8995.2 9003.8 9005.5 9035.2 9042.4 42742.4 43153.6 43171.0 43320.4 43337.3 3477.6 3512.9 3692.1 3973.7 4181.6 33133.3 33385.8 33733.0 33733.7 35035.5 4032.6 4204.1 4275.3 4369.8 4394.5 348930.3 352108.0 352476.0 352977.0 354613.0 58460.7 58645.1 58717.0 58732.4 58893.7 60043.7 60259.0 60263.7 60292.4 60436.4 16632.5 16796.6 16810.7 16838.4 16843.8 13108.1 13164.3 13181.4 13183.2 13204.4 15831.4 17172.1 17234.4 17239.8 17299.5 6495.7 6505.3 6639.9 6696.3 6719.3 962.9 996.9 1020.6 1048.4 1096.5 31726.5 31750.1 32249.5 32597.5 32771.7 1147.6 1151.6 1164.1 1173.9 1201.8 16585.2 17027.6 17031.3 17138.0 17231.6 550626.0 551102.0 555819.0 556627.0 558889.0 58216.4 58390.1 58396.7 58451.0 58465.7 1219.0 1328.4 1369.5 1371.7 1376.9 30692.8 34331.7 34345.0 34450.3 34526.5 51482.0 51740.5 51967.7 52091.7 52100.0 401021.0 404731.0 405370.0 405919.0 407577.0 24876.3 27309.2 27936.2 27944.0 28119.3 48112.3 48192.3 48831.8 48994.8 49666.8 41096.4 41522.4 42199.6 42585.4 43150.4 41079.6 41659.6 41747.2 42420.4 42556.8 40157.0 41107.4 41363.4 41427.4 41494.2 34781.8 37051.4 37090.0 37207.4 37803.4 27589.3 28074.0 28213.7 28302.3 28363.9 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#2] jquery.html Cycles:180 Average:29148.47 Median:3014.68 stddev:80970.56 (2685.9%) stddev-sans-first:81168.93 07:25:37 INFO - PROCESS | 23042 | Values: 398.6 398.6 400.9 403.5 416.8 18238.7 18673.3 19761.4 19769.7 20072.0 15235.8 16337.5 16358.6 18717.2 18946.9 5228.8 5368.1 5371.1 5714.6 5934.0 5873.2 5875.3 5876.1 5889.6 5913.0 5193.1 5312.9 5337.9 5716.3 5795.3 5250.7 5286.6 5295.3 5309.4 5311.3 5137.2 5173.9 5218.5 5225.3 5252.3 13836.4 14059.5 14177.0 20411.5 24528.5 2595.2 2672.9 2731.8 3010.9 3018.5 10136.2 10365.7 10569.5 13808.4 14528.3 1907.4 1973.7 1991.1 2027.1 2031.5 69738.0 72723.6 82451.6 82968.0 88253.0 11091.2 11149.5 11294.7 11306.2 11469.4 15454.5 15502.2 15558.5 15585.1 15589.8 8296.4 8343.0 8428.2 8645.0 8656.4 8112.3 8168.5 8210.5 8383.7 8395.8 4702.6 4827.4 4838.1 4868.7 4913.3 1884.8 1957.1 1989.7 1995.6 1996.7 904.9 969.2 984.5 1070.0 1106.8 19675.9 19916.6 20015.7 20282.2 20565.7 963.2 989.3 996.2 1023.6 1044.4 10596.4 10919.3 11062.7 11124.8 11126.6 477757.0 480014.0 487345.0 498235.0 507950.0 95334.0 95622.0 96600.5 98144.5 98784.5 1020.2 1025.9 1033.3 1057.5 1066.0 17423.2 17438.3 17645.1 17925.9 18129.2 42906.8 43233.6 43522.1 43603.8 44381.7 59131.0 59302.0 59593.4 60951.4 61822.0 8801.6 8831.0 8835.9 8841.9 8934.9 9784.5 13604.3 13710.7 13726.2 14302.9 12179.2 12235.1 12365.6 12492.6 12782.4 11721.4 12081.2 12121.7 12188.9 12437.3 12166.9 12186.2 12236.3 12400.1 12499.6 8586.7 8679.0 8752.0 8760.9 8808.0 8877.9 11574.3 12187.2 12259.4 12313.6 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#3] mootools.html Cycles:180 Average:5693.79 Median:4749.01 stddev:3245.22 (68.3%) stddev-sans-first:3237.84 07:25:37 INFO - PROCESS | 23042 | Values: 1341.9 1455.2 1489.5 1591.5 1739.7 7863.6 8204.6 8222.9 8223.1 8389.9 8210.5 8472.9 8664.5 8673.1 8680.7 1979.8 2149.3 2165.7 2212.7 2225.7 2219.0 2244.2 2248.2 2251.2 2252.2 2200.4 2220.8 2234.0 2235.7 2236.1 1916.2 2119.4 2195.3 2198.6 2208.6 2083.7 2098.4 2109.9 2115.5 2118.1 8595.2 8634.1 8644.4 8658.5 8679.0 4966.5 4980.3 4995.3 4997.4 5102.1 3119.8 3181.3 3182.7 3215.1 3235.7 1098.1 1130.4 1132.9 1138.9 1149.2 11918.8 12196.3 12198.4 12206.3 12220.8 4437.1 4438.4 4569.1 4616.6 4697.4 10377.2 10392.7 10400.5 10407.7 10422.9 5308.4 5326.9 5327.4 5329.8 5331.3 4125.5 4594.3 4710.0 4713.6 4784.4 3945.5 3968.3 4026.4 4050.4 4096.2 1133.2 1207.6 1222.2 1241.3 1256.8 957.2 972.5 973.6 985.0 989.2 5564.9 5641.3 5700.0 5837.7 5910.1 953.5 975.0 982.5 1002.4 1003.6 3974.2 4017.2 4029.9 4053.3 4090.7 10117.3 10353.4 10502.2 10513.2 10519.6 10385.8 10406.6 10410.0 10414.4 10418.6 7866.6 7945.8 7955.5 7957.6 7969.4 5729.6 5778.1 5907.1 5948.3 6159.7 9618.0 9642.8 9709.8 9794.3 9809.7 10106.4 10135.3 10204.3 10206.3 10217.8 7822.3 7834.2 8000.5 8003.0 8032.2 8440.9 8537.7 8558.5 8567.3 8575.7 7635.9 7859.6 7937.1 7995.4 8039.1 7644.9 7765.6 7794.9 7819.8 7974.0 6847.4 6886.0 6894.3 6900.3 6904.5 4941.0 5145.2 5219.6 5271.6 5275.2 5128.7 5146.9 5153.7 5194.9 5317.4 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#4] prototype.html Cycles:180 Average:4600.02 Median:5191.06 stddev:1334.65 (25.7%) stddev-sans-first:1299.40 07:25:37 INFO - PROCESS | 23042 | Values: 333.5 336.6 340.2 340.8 345.4 5269.2 5276.9 5287.9 5290.0 5292.0 5182.6 5199.5 5205.5 5232.5 5252.3 4186.3 4190.5 4191.9 4193.7 4243.2 3855.6 3992.9 4113.6 4130.6 4166.5 4083.0 4126.2 4130.8 4131.2 4135.1 3969.7 4144.6 4153.7 4170.6 4171.8 3615.6 3662.9 3668.8 3669.5 3677.4 5126.9 5146.2 5152.6 5154.8 5172.3 4627.6 4701.3 4718.7 4721.3 4722.7 5464.2 5484.1 5484.3 5488.2 5492.2 4003.9 4016.4 4021.6 4023.8 4048.2 5206.8 5537.4 5729.4 5734.7 5737.9 4045.5 4066.2 4068.4 4073.2 4086.2 4119.8 4134.2 4138.9 4144.7 4150.3 4710.3 4716.5 4721.4 4723.7 4728.6 5293.3 5520.8 5524.4 5534.5 5574.8 1407.0 1415.8 1417.9 1427.5 1431.3 884.4 919.9 923.5 929.1 937.1 4694.0 4708.1 4761.3 4769.3 4785.0 4907.1 4970.5 4973.0 4998.6 5040.7 4781.2 4787.7 4793.4 4807.2 4984.5 2999.2 3016.7 3060.7 3060.8 3077.7 5852.9 5869.1 5889.2 5892.7 5906.4 5489.3 5601.4 5829.2 5835.9 5899.7 5654.6 5745.7 5755.8 5762.0 5805.3 5626.2 5642.2 5646.0 5677.0 5683.8 5450.6 5562.3 5567.7 5592.6 5617.7 5682.8 5736.5 5772.9 5788.6 5818.9 3981.7 3997.9 3999.4 4022.2 4024.9 5547.8 5566.0 5568.9 5598.2 5607.5 5440.4 5455.7 5467.7 5475.2 5482.5 5222.7 5454.4 5500.6 5517.8 5518.4 5472.2 5481.1 5488.6 5513.9 5522.3 5558.5 5562.2 5579.6 5615.0 5628.1 5215.3 5435.9 5439.3 5478.4 5483.5 07:25:37 INFO - PROCESS | 23042 | 07:25:37 INFO - PROCESS | 23042 | [#5] yui.html Cycles:180 Average:21690.75 Median:4722.96 stddev:31050.12 (657.4%) stddev-sans-first:31097.29 07:25:37 INFO - PROCESS | 23042 | Values: 716.7 719.4 726.0 728.9 803.2 15549.2 16499.4 16513.7 16514.3 16538.4 14731.2 14892.8 14906.9 15020.7 15565.5 772.6 788.7 789.9 791.1 793.9 645.8 760.7 789.5 793.6 801.4 842.3 844.1 844.5 845.1 847.2 671.7 840.5 842.0 842.4 842.5 582.4 597.0 601.7 604.4 604.8 15384.8 15386.6 15409.6 15440.8 15459.8 13345.3 13774.1 13809.9 14073.4 14080.4 11847.9 12119.7 12241.5 12652.2 12970.2 4510.2 4517.9 4587.6 4731.0 4739.7 74250.6 75338.0 77327.6 77984.0 78929.0 11461.4 11527.4 11683.6 11718.8 12045.8 20846.9 20940.0 20956.0 20979.2 21050.2 8015.6 8137.7 8162.1 8320.7 8476.0 4714.9 4741.4 4743.7 4769.4 4830.0 3321.5 3474.7 3476.4 3480.5 3487.3 611.5 620.7 623.6 637.1 640.3 630.8 735.3 764.2 772.3 776.1 9173.3 9691.0 9812.9 9844.2 9857.9 717.9 745.5 755.4 764.9 769.6 4298.8 4470.6 4587.4 4660.6 4672.0 94642.0 96507.0 98196.0 112805.0 114846.4 107555.5 109103.0 111638.4 111860.0 112650.4 90245.5 93307.0 98103.0 98375.0 99162.5 9260.9 9741.4 9757.7 9792.0 9870.0 54217.7 54437.7 55434.4 55482.7 55992.2 79486.0 82068.6 84542.6 84641.0 85480.6 12669.5 12759.6 13364.7 13556.3 13725.7 15948.4 16022.8 16230.6 16332.8 17133.2 14121.8 14278.2 14442.7 14591.3 15301.6 14968.0 15007.5 15445.2 15516.8 15752.2 13879.7 14515.2 14640.2 14728.0 14807.9 11855.7 12047.3 12081.5 12081.6 12286.4 12504.6 12522.9 12723.0 12974.5 13002.1 07:25:37 INFO - PROCESS | 23042 | -------- Summary: end -------- 07:25:37 INFO - PROCESS | 23042 | 07:25:38 INFO - TEST-INFO | 23042: exit 0 07:25:38 INFO - TEST-OK | dromaeo_css | took 1114179ms 07:25:38 INFO - TEST-START | kraken 07:25:38 INFO - operating with platform_type : linux_ 07:25:38 INFO - Initialising browser for kraken test... 07:25:38 INFO - TEST-INFO | started process 23242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTa2Pz/profile http://localhost:53157/getInfo.html) 07:25:42 INFO - PROCESS | 23242 | __metrics Screen width/height:1600/1200 07:25:42 INFO - PROCESS | 23242 | colorDepth:24 07:25:42 INFO - PROCESS | 23242 | Browser inner width/height: 1024/697 07:25:42 INFO - PROCESS | 23242 | __metrics 07:25:43 INFO - PROCESS | 23242 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:44 INFO - TEST-INFO | 23242: exit 0 07:25:44 INFO - Browser initialized. 07:25:44 INFO - Running cycle 1/1 for kraken test... 07:25:44 INFO - TEST-INFO | started process 23325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTa2Pz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:55 INFO - PROCESS | 23325 | RSS: Main: 157798400 07:25:55 INFO - PROCESS | 23325 | 07:25:58 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:59 INFO - PROCESS | 23325 | RSS: Main: 216055808 07:25:59 INFO - PROCESS | 23325 | 07:26:01 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-dft) 07:26:02 INFO - PROCESS | 23325 | RSS: Main: 203739136 07:26:02 INFO - PROCESS | 23325 | 07:26:05 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-fft) 07:26:06 INFO - PROCESS | 23325 | RSS: Main: 269783040 07:26:06 INFO - PROCESS | 23325 | 07:26:08 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-oscillator) 07:26:09 INFO - PROCESS | 23325 | RSS: Main: 180998144 07:26:09 INFO - PROCESS | 23325 | 07:26:11 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:11 INFO - PROCESS | 23325 | RSS: Main: 184717312 07:26:11 INFO - PROCESS | 23325 | 07:26:14 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:15 INFO - PROCESS | 23325 | RSS: Main: 220803072 07:26:15 INFO - PROCESS | 23325 | 07:26:18 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:19 INFO - PROCESS | 23325 | RSS: Main: 221888512 07:26:19 INFO - PROCESS | 23325 | 07:26:22 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53157/tests/kraken/driver.html?testName=json-parse-financial) 07:26:22 INFO - PROCESS | 23325 | RSS: Main: 221892608 07:26:22 INFO - PROCESS | 23325 | 07:26:24 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:24 INFO - PROCESS | 23325 | RSS: Main: 209432576 07:26:24 INFO - PROCESS | 23325 | 07:26:26 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:27 INFO - PROCESS | 23325 | RSS: Main: 212054016 07:26:27 INFO - PROCESS | 23325 | 07:26:29 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:30 INFO - PROCESS | 23325 | RSS: Main: 210526208 07:26:30 INFO - PROCESS | 23325 | 07:26:32 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:33 INFO - PROCESS | 23325 | RSS: Main: 224538624 07:26:33 INFO - PROCESS | 23325 | 07:26:35 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:36 INFO - PROCESS | 23325 | RSS: Main: 226295808 07:26:36 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53157/tests/kraken/driver.html?testName=ai-astar) 07:26:38 INFO - PROCESS | 23325 | RSS: Main: 267972608 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | __start_tp_report 07:26:38 INFO - PROCESS | 23325 | _x_x_mozilla_page_load 07:26:38 INFO - PROCESS | 23325 | _x_x_mozilla_page_load_details 07:26:38 INFO - PROCESS | 23325 | |i|pagename|runs| 07:26:38 INFO - PROCESS | 23325 | |0;ai-astar;102;111;113;112;112;111;110;110;112;109 07:26:38 INFO - PROCESS | 23325 | |1;audio-beat-detection;150;116;118;177;125;118;151;116;169;117 07:26:38 INFO - PROCESS | 23325 | |2;audio-dft;160;161;161;159;160;159;159;160;162;162 07:26:38 INFO - PROCESS | 23325 | |3;audio-fft;74;76;75;132;76;86;75;73;107;76 07:26:38 INFO - PROCESS | 23325 | |4;audio-oscillator;83;83;117;83;84;84;119;83;83;120 07:26:38 INFO - PROCESS | 23325 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:26:38 INFO - PROCESS | 23325 | |6;imaging-darkroom;145;146;145;146;146;146;146;146;146;146 07:26:38 INFO - PROCESS | 23325 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:26:38 INFO - PROCESS | 23325 | |8;json-parse-financial;53;56;53;53;52;55;52;52;53;53 07:26:38 INFO - PROCESS | 23325 | |9;json-stringify-tinderbox;61;61;61;60;60;61;61;60;60;61 07:26:38 INFO - PROCESS | 23325 | |10;stanford-crypto-aes;75;75;76;75;75;77;81;77;74;78 07:26:38 INFO - PROCESS | 23325 | |11;stanford-crypto-ccm;123;127;118;119;119;119;126;119;174;119 07:26:38 INFO - PROCESS | 23325 | |12;stanford-crypto-pbkdf2;160;157;158;158;158;155;167;158;157;154 07:26:38 INFO - PROCESS | 23325 | |13;stanford-crypto-sha256-iterative;63;61;62;63;63;62;64;64;62;62 07:26:38 INFO - PROCESS | 23325 | __end_tp_report 07:26:38 INFO - PROCESS | 23325 | __start_cc_report 07:26:38 INFO - PROCESS | 23325 | _x_x_mozilla_cycle_collect,1684 07:26:38 INFO - PROCESS | 23325 | __end_cc_report 07:26:38 INFO - PROCESS | 23325 | __startTimestamp1467642398301__endTimestamp 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | ------- Summary: start ------- 07:26:38 INFO - PROCESS | 23325 | Number of tests: 14 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.12 (2.8%) stddev-sans-first:1.27 07:26:38 INFO - PROCESS | 23325 | Values: 102.0 111.0 113.0 112.0 112.0 111.0 110.0 110.0 112.0 109.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:137.50 stddev:23.85 (17.3%) stddev-sans-first:24.73 07:26:38 INFO - PROCESS | 23325 | Values: 150.0 116.0 118.0 177.0 125.0 118.0 151.0 116.0 169.0 117.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 07:26:38 INFO - PROCESS | 23325 | Values: 160.0 161.0 161.0 159.0 160.0 159.0 159.0 160.0 162.0 162.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.50 stddev:19.44 (25.8%) stddev-sans-first:20.21 07:26:38 INFO - PROCESS | 23325 | Values: 74.0 76.0 75.0 132.0 76.0 86.0 75.0 73.0 107.0 76.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.00 stddev:17.11 (20.6%) stddev-sans-first:17.69 07:26:38 INFO - PROCESS | 23325 | Values: 83.0 83.0 117.0 83.0 84.0 84.0 119.0 83.0 83.0 120.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:26:38 INFO - PROCESS | 23325 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 07:26:38 INFO - PROCESS | 23325 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:26:38 INFO - PROCESS | 23325 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.32 (2.5%) stddev-sans-first:1.39 07:26:38 INFO - PROCESS | 23325 | Values: 53.0 56.0 53.0 53.0 52.0 55.0 52.0 52.0 53.0 53.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:26:38 INFO - PROCESS | 23325 | Values: 61.0 61.0 61.0 60.0 60.0 61.0 61.0 60.0 60.0 61.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.50 stddev:2.06 (2.7%) stddev-sans-first:2.13 07:26:38 INFO - PROCESS | 23325 | Values: 75.0 75.0 76.0 75.0 75.0 77.0 81.0 77.0 74.0 78.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:121.00 stddev:17.07 (14.1%) stddev-sans-first:18.06 07:26:38 INFO - PROCESS | 23325 | Values: 123.0 127.0 118.0 119.0 119.0 119.0 126.0 119.0 174.0 119.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:3.52 (2.2%) stddev-sans-first:3.67 07:26:38 INFO - PROCESS | 23325 | Values: 160.0 157.0 158.0 158.0 158.0 155.0 167.0 158.0 157.0 154.0 07:26:38 INFO - PROCESS | 23325 | 07:26:38 INFO - PROCESS | 23325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 07:26:38 INFO - PROCESS | 23325 | Values: 63.0 61.0 62.0 63.0 63.0 62.0 64.0 64.0 62.0 62.0 07:26:38 INFO - PROCESS | 23325 | -------- Summary: end -------- 07:26:38 INFO - PROCESS | 23325 | 07:26:39 INFO - TEST-INFO | 23325: exit 0 07:26:39 INFO - TEST-OK | kraken | took 61019ms 07:26:39 INFO - SUITE-END | took 1175s 07:26:39 INFO - Completed test suite (00:19:35) 07:26:39 INFO - javascript benchmark 07:26:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.102420298114, 3099.488584383577, 3114.7508199344056, 3129.953050704238, 3145.559621652969, 5176.55999240065, 5262.789488420463, 5295.7881684732565, 5351.759170837312, 5353.411124776271, 5256.8685782855355, 5320.893582128355, 5349.786008559663, 5362.678239305635, 5391.973040134803, 4827.324174615556, 4848.272759086148, 4852.514748525155, 4852.611791056707, 5035.571976381993, 4999.375078115236, 5001.399832020163, 5012.72430016349, 5016.724080175589, 5019.447860735316, 4718.764061796896, 4719.362886010379, 4753.025629745894, 4904.5831104356175, 4937.111319962423, 4792.041591681643, 4802.75986200692, 4804.1352556539805, 4819.831305904277, 4836.951630483685, 4837.395325584302, 4853.805847766085, 4854.708717476963, 4856.3201151838775, 4959.305697202394, 5443.755031023574, 5450.863728406782, 5465.918011229795, 5468.0, 5468.960897429476, 5551.444855514456, 5640.238567793336, 5739.626924249952, 5745.6552606843725, 5838.678872662002, 5796.333421656522, 5825.0, 5833.854153646151, 5843.649381037151, 5850.531957443394, 5439.048166570834, 5443.646162999393, 5444.6188766786345, 5447.319085114361, 5450.31871016123, 5687.9431205687415, 5731.799387021518, 5812.099124635688, 5822.039363505059, 5882.970585147133, 5609.046462101453, 5618.606697531215, 5656.943430565724, 5661.801836935688, 5664.26364572603, 5523.585731070186, 5667.688277144714, 5725.0, 5728.226689396878, 5730.140478928194, 5562.9443705563235, 5636.210930469655, 5644.068728659725, 5667.688277144796, 5674.9501342251815, 5678.4605462480995, 5681.34664513578, 5684.431556844283, 5684.54523638108, 5685.431456854281, 4272.957270427318, 4292.484901811803, 4348.0, 4348.173846969065, 4396.846110386121, 3701.722370822199, 3892.8442862285756, 3896.902577435587, 3906.628870257321, 3943.9802800986386, 5337.466253374631, 5377.435369286247, 5395.05586522357, 5401.432849550741, 5438.238646589481, 5616.747246373923, 5650.0959846424375, 5683.403242659461, 5720.742566584514, 5777.913331300034, 5362.597805164628, 5373.35519737634, 5390.4879036491475, 5398.352197736297, 5424.810131645373, 4889.095517329305, 4899.314096026559, 4905.583025442877, 4927.334809800631, 4958.553730164303, 5758.539316854642, 5843.18195452637, 5865.88268234633, 5897.056470964625, 5914.585978981516, 5764.452377024176, 5775.768969241183, 5782.392848750821, 5783.334916484489, 5784.045632470596, 5932.614380065282, 5937.4656280933195, 5945.435183657545, 5946.226990491208, 5949.940500594938, 5431.266778984945, 5579.386267510489, 5618.550515958632, 5664.461876121762, 5690.658560486384, 5717.42825717425, 5720.227769251098, 5726.484616384545, 5730.885382292247, 5733.3406658234835, 5351.759170837399, 5480.945190548044, 5566.276384070045, 5568.220449137205, 5574.052411090043, 5485.6982865942755, 5509.0, 5529.834104976857, 5566.805161819317, 5584.720763961867, 5466.671999680032, 5474.452554744494, 5494.2857428534035, 5501.724913754377, 5507.063799154073, 5488.451154884479, 5520.033994051106, 5578.832635020955, 5579.414161512983, 5605.859853503695, 5278.868028299324, 5324.6006549508165, 5398.40617532079, 5436.374816896107, 5544.63959842609], "value": 5261.512926072116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8697886464976, 618.5700937848195, 626.6240255846493, 636.7834936121718, 637.2448648351701, 42665.36001959969, 43795.0, 43904.780476097614, 43924.78037609811, 47807.52192478074, 44742.0, 45092.0, 45129.77435112828, 45130.54869451305, 45287.77356113215, 9111.498867562264, 9233.58448869799, 9239.538023098818, 9253.35226534143, 9253.768655783626, 9091.227245684091, 9145.039770824067, 9159.992400835903, 9160.038195989426, 9180.173784359406, 9193.862092068624, 9226.261899048093, 9230.769230769218, 9231.3076519261, 9231.399959002676, 9141.085891410872, 9163.08369163085, 9177.908220917805, 9179.0, 9213.585388657526, 8995.235404990584, 9003.819923601492, 9005.459672419676, 9035.18683318498, 9042.367034307601, 42742.358864617054, 43153.56846431527, 43171.0, 43320.3501947471, 43337.34993975093, 3477.5826900771817, 3512.8594856205723, 3692.0769807548113, 3973.662238709684, 4181.644560212386, 33133.3373332532, 33385.833070834735, 33733.0, 33733.662663373296, 35035.474467883, 4032.5967403259733, 4204.07510347723, 4275.251830929575, 4369.825206991716, 4394.516603173648, 348930.2553487242, 352108.0, 352476.0, 352977.0, 354613.0, 58460.70769646124, 58645.12032319519, 58717.0, 58732.41267587355, 58893.70553147292, 60043.699781500814, 60259.0, 60263.69868150719, 60292.397076028676, 60436.395636043075, 16632.50102496927, 16796.580085497717, 16810.663786724443, 16838.410655627238, 16843.83156168447, 13108.147970381895, 13164.275964822027, 13181.406836692371, 13183.209007459584, 13204.405801738945, 15831.445899393466, 17172.111067782535, 17234.396796112076, 17239.82760172407, 17299.481015569552, 6495.6752162391695, 6505.251896031922, 6639.86720265592, 6696.2968888267005, 6719.328067193339, 962.9085236902483, 996.8554559588819, 1020.5560581147224, 1048.3657387280584, 1096.5010920031366, 31726.524102138486, 31750.092436218936, 32249.51625725616, 32597.511037334458, 32771.67228327734, 1147.5581900968186, 1151.5681619392728, 1164.1152723929706, 1173.8884805943421, 1201.783678937782, 16585.17074146288, 17027.574310642085, 17031.318747250218, 17138.0, 17231.56921076958, 550626.0, 551102.0, 555819.0, 556627.0, 558889.0, 58216.41783582194, 58390.12414813781, 58396.70801645965, 58451.0, 58465.70767146222, 1219.0065096945962, 1328.35574746248, 1369.486442584031, 1371.6639423341346, 1376.938037788282, 30692.846535768072, 34331.656683433845, 34345.0, 34450.31099377948, 34526.48210276798, 51482.0, 51740.48259517357, 51967.724518566676, 52091.73954130205, 52100.0, 401021.0, 404731.0, 405370.0, 405919.0, 407577.0, 24876.253712388658, 27309.180724578295, 27936.161915142577, 27944.0, 28119.297017573906, 48112.27831582599, 48192.277115843994, 48831.75584122057, 48994.755026224644, 49666.751666241435, 41096.38355424611, 41522.37716434195, 42199.57800422079, 42585.36121958235, 43150.35274470948, 41079.58920410877, 41659.583404166784, 41747.16505669809, 42420.36369454522, 42556.78721606372, 40157.0, 41107.383389248585, 41363.379549306184, 41427.37858932058, 41494.1701165981, 34781.826090870396, 37051.444228336055, 37090.0, 37207.441888371155, 37803.432948505244, 27589.31026724348, 28074.019480906765, 28213.717862821108, 28302.272988232817, 28363.858180708965], "value": 20292.097508476672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.5615822595144, 398.59542564297243, 400.90177906412936, 403.45734986443233, 416.7582801974855, 18238.726419103707, 18673.346432874852, 19761.40715778527, 19769.703454448176, 20072.0, 15235.847641523582, 16337.509874703748, 16358.591035224126, 18717.157727902242, 18946.905265473688, 5228.79084836607, 5368.141097424394, 5371.086915224401, 5714.57140714446, 5933.970330148343, 5873.207117039209, 5875.294964604253, 5876.0598304271325, 5889.617174883619, 5912.970435147839, 5193.065248255312, 5312.893742125155, 5337.919931201016, 5716.314042314928, 5795.333536643277, 5250.6587071840395, 5286.629935904488, 5295.311609490742, 5309.442508536606, 5311.336082989626, 5137.229415587654, 5173.948260517422, 5218.530332270076, 5225.268462415265, 5252.343457067866, 13836.377363018688, 14059.507917222849, 14177.0, 20411.489712757153, 24528.509429811304, 2595.23440585026, 2672.906448274301, 2731.7814574834165, 3010.8795648174046, 3018.4868572342534, 10136.239782016304, 10365.689029329133, 10569.524371403306, 13808.447662093504, 14528.273586320747, 1907.437305994735, 1973.703944408336, 1991.0542492316179, 2027.108072448118, 2031.5327474680905, 69737.95393069107, 72723.63638181829, 82451.5877420609, 82968.0, 88253.0, 11091.223614346918, 11149.498272577754, 11294.7176320591, 11306.208565400508, 11469.426528673534, 15454.459093931659, 15502.224888755743, 15558.455454059054, 15585.142817144939, 15589.76615350748, 8296.419250652396, 8342.958285208535, 8428.157184281523, 8644.95677521621, 8656.437331573428, 8112.3104536113915, 8168.509889406655, 8210.548419836847, 8383.706570270011, 8395.790105247417, 4702.600278976325, 4827.42070951488, 4838.104950584153, 4868.659193856467, 4913.336699545587, 1884.8303652671325, 1957.1388589020785, 1989.691597802343, 1995.600879824041, 1996.6805311150438, 904.8733177355175, 969.2439896880445, 984.5028260728286, 1069.9625513107003, 1106.8063088959561, 19675.917824519503, 19916.60166796656, 20015.699764503544, 20282.188712451632, 20565.69151462729, 963.1572374172599, 989.3124278626285, 996.2179688944144, 1023.6110278094277, 1044.3525014491065, 10596.364218146937, 10919.252130495102, 11062.723431914266, 11124.833127503094, 11126.554937802559, 477757.0, 480014.0, 487345.0, 498235.0, 507950.0, 95334.0, 95622.0, 96600.51699741457, 98144.50927745315, 98784.50607746915, 1020.2042406922463, 1025.9281850270409, 1033.34382667007, 1057.4659796802566, 1065.9626913058005, 17423.215955282296, 17438.30246790165, 17645.117744112486, 17925.910370448586, 18129.184186711365, 42906.78546607247, 43233.56766432295, 43522.12955740804, 43603.781981089895, 44381.668549943555, 59131.0, 59302.0, 59593.404065960516, 60951.39048609457, 61822.0, 8801.559922004002, 8831.0, 8835.867461987948, 8841.911580884365, 8934.86597701022, 9784.461854598065, 13604.25176615256, 13710.725785484434, 13726.245056521988, 14302.928485357923, 12179.208351457128, 12235.143539952474, 12365.567205147776, 12492.563355214266, 12782.36088195568, 11721.355325456841, 12081.154319197572, 12121.69695757613, 12188.878111219128, 12437.315947622968, 12166.939165304117, 12186.2078964867, 12236.327002014974, 12400.131990760921, 12499.625011249676, 8586.742397728078, 8679.0, 8751.956240218758, 8760.868586971073, 8807.983571425, 8877.9346478423, 11574.305541667527, 12187.207831490925, 12259.448324825582, 12313.630591082281], "value": 9307.529559918634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9396127174275, 1455.185096346046, 1489.5382431446253, 1591.538453848384, 1739.6868563658536, 7863.606819659016, 8204.58977051148, 8222.876656850152, 8223.095459499451, 8389.91610083899, 8210.466319689216, 8472.872906906387, 8664.480131192133, 8673.132686731324, 8680.652773889036, 1979.8119178678003, 2149.312220089572, 2165.71845660064, 2212.734471863371, 2225.6550234713645, 2219.034719896842, 2244.1920908472935, 2248.15694114707, 2251.1653002802746, 2252.234240358278, 2200.3728937252886, 2220.7890250426185, 2234.039363073886, 2235.6646503024513, 2236.1279101150562, 1916.2335065973582, 2119.3853782403085, 2195.3084778294865, 2198.560287942402, 2208.6466165413617, 2083.666613341873, 2098.4229336932312, 2109.9050542725613, 2115.4922818523596, 2118.110393634677, 8595.226429621363, 8634.093420190915, 8644.394892357537, 8658.523781192032, 8678.956605216934, 4966.528179822911, 4980.302757613937, 4995.275685025687, 4997.350344455198, 5102.056119617882, 3119.8128112313334, 3181.316017056344, 3182.7294679952233, 3215.1479857837694, 3235.7087862092526, 1098.1050443888205, 1130.4178348150708, 1132.9037031852301, 1138.8633363996373, 1149.2127892393737, 11918.821217681741, 12196.329201893892, 12198.39008049594, 12206.328651924141, 12220.755584888342, 4437.134758722083, 4438.423005009328, 4569.109023740405, 4616.60758835496, 4697.389339385858, 10377.221708371751, 10392.688219353431, 10400.47997600117, 10407.739806504898, 10422.895771042193, 5308.442613525602, 5326.92009619856, 5327.440618734977, 5329.786808527693, 5331.333583302087, 4125.463689720377, 4594.310853371954, 4709.95290047102, 4713.622910167179, 4784.40194975628, 3945.4870866787132, 3968.265870813909, 4026.355783074694, 4050.3721923101966, 4096.160287141129, 1133.1784456269138, 1207.5833837326109, 1222.1628184693514, 1241.273854794955, 1256.824044633752, 957.1768279279814, 972.5234635028785, 973.6056896956744, 984.9655262065936, 989.2432289298692, 5564.944350556442, 5641.26663533738, 5699.974004679198, 5837.67892765902, 5910.083936989773, 953.5422996961497, 974.9951250243703, 982.4792859784326, 1002.3985608634761, 1003.6487229469627, 3974.20515896816, 4017.2367250222364, 4029.8992525187105, 4053.331200351909, 4090.734102283342, 10117.29178957466, 10353.378797272188, 10502.159827213805, 10513.211509136845, 10519.631812886511, 10385.84421233682, 10406.5837366506, 10410.0, 10414.375137491776, 10418.635347762793, 7866.606669666494, 7945.761627151194, 7955.4828936118965, 7957.602119893866, 7969.442139050327, 5729.627574207663, 5778.104393818965, 5907.113932909926, 5948.2862056553495, 6159.692015399301, 9617.951910240405, 9642.758931026781, 9709.805803884024, 9794.265430092913, 9809.705708828747, 10106.39361638304, 10135.341202821794, 10204.285700001226, 10206.336588121749, 10217.846732298873, 7822.295993360625, 7834.177411371724, 8000.479968802009, 8002.9599852000365, 8032.236937490929, 8440.915590844013, 8537.74386768398, 8558.52928088961, 8567.27178189861, 8575.742727718178, 7635.88546171819, 7859.567723775247, 7937.087234968052, 7995.440319177835, 8039.075506316848, 7644.885326720215, 7765.5728934906865, 7794.88307675374, 7819.765407037798, 7974.0, 6847.417969472651, 6885.965570172117, 6894.276101009322, 6900.309969003059, 6904.516683832084, 4940.975295123645, 5145.176771716508, 5219.582433405394, 5271.604629652715, 5275.182346736108, 5128.717920514258, 5146.871328216825, 5153.7165455900285, 5194.922076168936, 5317.361916570037], "value": 4544.706539358857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.48328671739006, 336.6061707801872, 340.2497493027874, 340.8329918340014, 345.44728434504793, 5269.235960785683, 5276.944611077785, 5287.92068118978, 5289.973550132248, 5291.973540132294, 5182.637215394924, 5199.4800519947985, 5205.453427390126, 5232.529072383485, 5252.317198764155, 4186.3092589722655, 4190.53904070552, 4191.853285135021, 4193.6645068394455, 4243.172581346638, 3855.633714797104, 3992.860249891254, 4113.56807535209, 4130.628243458088, 4166.458360413142, 4083.0, 4126.216018956388, 4130.8141133648905, 4131.173765246947, 4135.1316223593085, 3969.6900022992345, 4144.626983571478, 4153.7300075494995, 4170.582941705836, 4171.791410429481, 3615.620359862203, 3662.8755321913227, 3668.761530500509, 3669.5229620149476, 3677.3932301170275, 5126.92309615356, 5146.150885103991, 5152.587792976553, 5154.845354639367, 5172.327597412313, 4627.583517483443, 4701.318308845232, 4718.740469274188, 4721.268203428474, 4722.669413141081, 5464.207689884945, 5484.080571799878, 5484.314460692413, 5488.231647569343, 5492.171531661198, 4003.899902502432, 4016.4176194451934, 4021.617946295097, 4023.7786921719294, 4048.1701251243426, 5206.765695543671, 5537.418571050022, 5729.427057294237, 5734.741936612862, 5737.885242295172, 4045.474088368552, 4066.2274167908004, 4068.4304197412384, 4073.2260870434525, 4086.2429155463437, 4119.7940102994735, 4134.193832202692, 4138.882501724578, 4144.70987030911, 4150.252954468165, 4710.29345598163, 4716.504766999416, 4721.433427988594, 4723.716577005391, 4728.645351598644, 5293.258943747878, 5520.834374968757, 5524.364698059694, 5534.501894829485, 5574.804881829197, 1406.9718605628034, 1415.794709767078, 1417.9432822686977, 1427.450431583827, 1431.3415828718905, 884.4118661090431, 919.8620206969008, 923.4966943016072, 929.0662883801871, 937.1378331934636, 4693.976530117396, 4708.104515722805, 4761.285807128958, 4769.308450274691, 4784.976075119602, 4907.067657145131, 4970.502949705001, 4972.950270497321, 4998.600111991032, 5040.697558146523, 4781.2350023996, 4787.712737235777, 4793.448753393404, 4807.18277892759, 4984.476629953802, 2999.2351950252546, 3016.668166501683, 3060.73983711387, 3060.7857449978733, 3077.6768439313996, 5852.91721031602, 5869.090291004901, 5889.234399528034, 5892.734826932799, 5906.379830117861, 5489.27087967297, 5601.403599973988, 5829.183914252008, 5835.883282334329, 5899.7050147492455, 5654.6324488908085, 5745.6552606843725, 5755.827325180251, 5762.0, 5805.274340707411, 5626.212330273683, 5642.163328936363, 5646.040173170489, 5677.034904066236, 5683.7779877326575, 5450.610094425896, 5562.3047119110115, 5567.749451274622, 5592.580556458201, 5617.6910269933915, 5682.801101961411, 5736.512396446349, 5772.855678608068, 5788.623739456922, 5818.94181058201, 3981.7411868228473, 3997.92004159921, 3999.400089986409, 4022.21566794484, 4024.879253622396, 5547.7780888764, 5566.0, 5568.9443105568425, 5598.216249725123, 5607.523360514238, 5440.374356949002, 5455.727213639223, 5467.6719396836315, 5475.151351540518, 5482.479164479528, 5222.660527065728, 5454.390954668303, 5500.559955203494, 5517.751701173376, 5518.420565840529, 5472.233887255867, 5481.095619222783, 5488.62784303924, 5513.862153446196, 5522.282103326542, 5558.471945165203, 5562.249096371938, 5579.609427340048, 5615.045442274904, 5628.142712904813, 5215.348081489814, 5435.891282174413, 5439.347278326626, 5478.397376288684, 5483.506484416422], "value": 4177.921016994671, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.663168310894, 719.3777382564084, 725.9709611615535, 728.8688036153491, 803.1767438375664, 15549.222538873053, 16499.422520211796, 16513.66972660546, 16514.339426422943, 16538.42115525955, 14731.189784561844, 14892.776608350883, 14906.925465372686, 15020.699586008273, 15565.53303400897, 772.5712229712507, 788.6687591211676, 789.9249571290718, 791.0704921716988, 793.8729803231485, 645.8127143128511, 760.6615056299948, 789.4868335581889, 793.6190628498324, 801.418971245845, 842.3261390887296, 844.1389782421926, 844.4764246167354, 845.1084106267884, 847.2290215903529, 671.664167916042, 840.4915026408995, 841.9789505262356, 842.4439869686008, 842.473454091193, 582.3855832097136, 596.9701514924236, 601.714185761764, 604.3865476541314, 604.7792555717175, 15384.846151538566, 15386.615334616612, 15409.614759630987, 15440.845591544054, 15459.845401545954, 13345.33273336339, 13774.104683195661, 13809.861901381058, 14073.437062517487, 14080.436782528686, 11847.881521184763, 12119.697007574792, 12241.510339586406, 12652.240865548096, 12970.156939798882, 4510.21071312519, 4517.909641807179, 4587.587117159472, 4731.0, 4739.715617062987, 74250.62874685592, 75338.0, 77327.6133619334, 77984.0, 78929.0, 11461.369624670557, 11527.365994870363, 11683.649490515128, 11718.765624687458, 12045.819312710317, 20846.895765521378, 20940.0, 20956.0, 20979.16083356679, 21050.157993680386, 8015.559144247122, 8137.674493020331, 8162.102168761431, 8320.70877519284, 8475.957620211859, 4714.929276060861, 4741.359916411309, 4743.7153770773175, 4769.403824521934, 4830.0, 3321.5183798349103, 3474.6872781449283, 3476.3916314645344, 3480.4953281774, 3487.3199726053685, 611.541343992006, 620.711369213318, 623.6008954269271, 637.0539748473514, 640.2796853539768, 630.7792272704609, 735.3492159438935, 764.2014095270456, 772.2702046566053, 776.0997243197863, 9173.312001599907, 9690.95154524223, 9812.90187098134, 9844.212463002943, 9857.852132218022, 717.921616919027, 745.4520927118564, 755.4183278875236, 764.896738940247, 769.5613500304885, 4298.78506074695, 4470.575295346936, 4587.4036375271, 4660.580547750718, 4671.976640116845, 94642.0, 96507.0, 98196.0, 112805.0, 114846.42576787062, 107555.46222268838, 109103.0, 111638.44180779044, 111860.0, 112650.43674781574, 90245.54877225572, 93307.0, 98103.0, 98375.0, 99162.50418748004, 9260.907390926273, 9741.415515069119, 9757.658481953098, 9791.951040244754, 9869.963653816532, 54217.72891135519, 54437.72781136069, 55434.44565554293, 55482.72258638681, 55992.16011759908, 79486.0, 82068.58965705133, 84542.57728711318, 84641.0, 85480.57259713662, 12669.493220271086, 12759.553415630407, 13364.732705345645, 13556.25440600737, 13725.656858578615, 15948.441804536786, 16022.839771602135, 16230.594235144215, 16332.755008674641, 17133.22900469457, 14121.788173177616, 14278.19175360159, 14442.711145777235, 14591.270436478346, 15301.617459563155, 14968.0, 15007.474738384104, 15445.150516721687, 15516.84483155154, 15752.212389380256, 13879.722405552035, 14515.201663908165, 14640.194789286692, 14728.0, 14807.92596037056, 11855.703607409883, 12047.277163370225, 12081.51673933068, 12081.57714479989, 12286.38568071575, 12504.599107027378, 12522.93738531338, 12723.0, 12974.481020759064, 13002.139529303538], "value": 7761.985112088823, "unit": "score"}], "name": "dromaeo_css", "value": 7260.385359215238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 112.0, 112.0, 111.0, 110.0, 110.0, 112.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 118.0, 177.0, 125.0, 118.0, 151.0, 116.0, 169.0, 117.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 159.0, 159.0, 160.0, 162.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 132.0, 76.0, 86.0, 75.0, 73.0, 107.0, 76.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 84.0, 84.0, 119.0, 83.0, 83.0, 120.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 53.0, 52.0, 55.0, 52.0, 52.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 75.0, 77.0, 81.0, 77.0, 74.0, 78.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 118.0, 119.0, 119.0, 119.0, 126.0, 119.0, 174.0, 119.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 158.0, 158.0, 158.0, 155.0, 167.0, 158.0, 157.0, 154.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 63.0, 63.0, 62.0, 64.0, 64.0, 62.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 07:26:39 INFO - Return code: 0 07:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:39 INFO - # TBPL SUCCESS # 07:26:39 INFO - Running post-action listener: _resource_record_post_action 07:26:39 INFO - ##### 07:26:39 INFO - ##### Finished run-tests step (success) 07:26:39 INFO - ##### 07:26:39 INFO - Running post-run listener: _resource_record_post_run 07:26:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 551886848; Read time: 0; Write time: 460848 07:26:39 INFO - TinderboxPrint: CPU usage
13.0% 07:26:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:26:39 INFO - TinderboxPrint: I/O write bytes / time
551,886,848 / 460,848 07:26:39 INFO - TinderboxPrint: CPU idle
8,282.1 (87.0%) 07:26:39 INFO - TinderboxPrint: CPU user
1,196.7 (12.6%) 07:26:39 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255799296; Read time: 0; Write time: 272304 07:26:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295895040; Read time: 0; Write time: 188528 07:26:40 INFO - Running post-run listener: _upload_blobber_files 07:26:40 INFO - Blob upload gear active. 07:26:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:40 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 07:26:40 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:26:40 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:26:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:41 INFO - (blobuploader) - INFO - Done attempting. 07:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:42 INFO - (blobuploader) - INFO - Done attempting. 07:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:45 INFO - (blobuploader) - INFO - Done attempting. 07:26:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:45 INFO - Return code: 0 07:26:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23dce51f197afb835f9a47c209ec3a4eae025a6fb2a1bbafb5c528f71a26aa655874b5626f7273a23cc28d8ae854155d8efdaa627731329406ba56e0a54df942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d420cd824ced6e21720646d7aa3fd85c6162fe4865d7d6ad13d5b8c604dfb1db0df5ee56e227f38d95301a06b839f44772225ad99d693570303b33bbbafb77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408c20b6a0b3efe31e0ad9f7437a116fcd578ec716fac7098058efc816e708b873a6b84d937c2f157657dbda58645a742eacdae6636b59bb56f2586ce28e4a1d"} 07:26:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:45 INFO - Contents: 07:26:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23dce51f197afb835f9a47c209ec3a4eae025a6fb2a1bbafb5c528f71a26aa655874b5626f7273a23cc28d8ae854155d8efdaa627731329406ba56e0a54df942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d420cd824ced6e21720646d7aa3fd85c6162fe4865d7d6ad13d5b8c604dfb1db0df5ee56e227f38d95301a06b839f44772225ad99d693570303b33bbbafb77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408c20b6a0b3efe31e0ad9f7437a116fcd578ec716fac7098058efc816e708b873a6b84d937c2f157657dbda58645a742eacdae6636b59bb56f2586ce28e4a1d"} 07:26:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:45 INFO - Copying logs to upload dir... 07:26:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.818281 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-04 07:26:44.537170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 07:26:44.540693) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23dce51f197afb835f9a47c209ec3a4eae025a6fb2a1bbafb5c528f71a26aa655874b5626f7273a23cc28d8ae854155d8efdaa627731329406ba56e0a54df942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d420cd824ced6e21720646d7aa3fd85c6162fe4865d7d6ad13d5b8c604dfb1db0df5ee56e227f38d95301a06b839f44772225ad99d693570303b33bbbafb77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408c20b6a0b3efe31e0ad9f7437a116fcd578ec716fac7098058efc816e708b873a6b84d937c2f157657dbda58645a742eacdae6636b59bb56f2586ce28e4a1d"} build_url:https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/YtcZu1x4QYWfQ0E4Dg7pdw/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/Firefox/sha512/23dce51f197afb835f9a47c209ec3a4eae025a6fb2a1bbafb5c528f71a26aa655874b5626f7273a23cc28d8ae854155d8efdaa627731329406ba56e0a54df942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d420cd824ced6e21720646d7aa3fd85c6162fe4865d7d6ad13d5b8c604dfb1db0df5ee56e227f38d95301a06b839f44772225ad99d693570303b33bbbafb77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408c20b6a0b3efe31e0ad9f7437a116fcd578ec716fac7098058efc816e708b873a6b84d937c2f157657dbda58645a742eacdae6636b59bb56f2586ce28e4a1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 07:26:44.568796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:26:44.569153) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467641054.365947-802513858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 07:26:44.652916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 07:26:44.653462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 07:26:44.653769) ========= ========= Total master_lag: 0.19 =========