builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1483557716.99 results: success (0) buildid: 20170104094639 builduid: 9343ee82ee7647bca7e55bf4f6e6e44f revision: a51cdeb88cbfee1e51234a575ccb8aa75130a07d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:56.992256) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:56.992733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:56.993041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.008125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.008434) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 11:21:57-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-01-04 11:21:57 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.097194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.097476) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017715 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.152331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.152645) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a51cdeb88cbfee1e51234a575ccb8aa75130a07d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a51cdeb88cbfee1e51234a575ccb8aa75130a07d --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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 11:21:58,030 truncating revision to first 12 chars 2017-01-04 11:21:58,030 Setting DEBUG logging. 2017-01-04 11:21:58,030 attempt 1/10 2017-01-04 11:21:58,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a51cdeb88cbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 11:21:58,333 unpacking tar archive at: mozilla-aurora-a51cdeb88cbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.768408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.768724) ========= script_repo_revision: a51cdeb88cbfee1e51234a575ccb8aa75130a07d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.769151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.769437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 11:21:57.777583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-04 11:21:57.777868) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:58 INFO - MultiFileLogger online at 20170104 11:21:58 in /builds/slave/test 11:21:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:21:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:58 INFO - {'append_to_log': False, 11:21:58 INFO - 'base_work_dir': '/builds/slave/test', 11:21:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:21:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:58 INFO - 'branch': 'Mozilla-Aurora', 11:21:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:58 INFO - 'config_files': ('talos/linux_config.py',), 11:21:58 INFO - 'default_actions': ('clobber', 11:21:58 INFO - 'read-buildbot-config', 11:21:58 INFO - 'download-and-extract', 11:21:58 INFO - 'populate-webroot', 11:21:58 INFO - 'create-virtualenv', 11:21:58 INFO - 'install', 11:21:58 INFO - 'run-tests'), 11:21:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:58 INFO - 'download_minidump_stackwalk': True, 11:21:58 INFO - 'download_symbols': 'ondemand', 11:21:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:58 INFO - 'installer_path': 'installer.exe', 11:21:58 INFO - 'log_level': 'info', 11:21:58 INFO - 'log_name': 'talos', 11:21:58 INFO - 'log_to_console': True, 11:21:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:58 INFO - 'opt_config_files': (), 11:21:58 INFO - 'pip_index': False, 11:21:58 INFO - 'sps_profile': False, 11:21:58 INFO - 'sps_profile_interval': 0, 11:21:58 INFO - 'suite': 'dromaeojs', 11:21:58 INFO - 'system_bits': '32', 11:21:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:58 INFO - 'title': 'talos-linux64-ix-034', 11:21:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:58 INFO - 'use_talos_json': True, 11:21:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:58 INFO - 'work_dir': 'build'} 11:21:58 INFO - [mozharness: 2017-01-04 19:21:58.753620Z] Running clobber step. 11:21:58 INFO - Running pre-action listener: _resource_record_pre_action 11:21:58 INFO - Running main action method: clobber 11:21:58 INFO - rmtree: /builds/slave/test/build 11:21:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:59 INFO - Running post-action listener: _resource_record_post_action 11:21:59 INFO - [mozharness: 2017-01-04 19:21:59.220790Z] Finished clobber step (success) 11:21:59 INFO - [mozharness: 2017-01-04 19:21:59.220891Z] Running read-buildbot-config step. 11:21:59 INFO - Running pre-action listener: _resource_record_pre_action 11:21:59 INFO - Running main action method: read_buildbot_config 11:21:59 INFO - Using buildbot properties: 11:21:59 INFO - { 11:21:59 INFO - "project": "", 11:21:59 INFO - "product": "firefox", 11:21:59 INFO - "script_repo_revision": "production", 11:21:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:21:59 INFO - "repository": "", 11:21:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:21:59 INFO - "buildid": "20170104094639", 11:21:59 INFO - "pgo_build": "True", 11:21:59 INFO - "basedir": "/builds/slave/test", 11:21:59 INFO - "buildnumber": 679, 11:21:59 INFO - "slavename": "talos-linux64-ix-034", 11:21:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:21:59 INFO - "platform": "ubuntu64_hw", 11:21:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:21:59 INFO - "branch": "mozilla-aurora", 11:21:59 INFO - "repo_path": "releases/mozilla-aurora", 11:21:59 INFO - "revision": "a51cdeb88cbfee1e51234a575ccb8aa75130a07d", 11:21:59 INFO - "stage_platform": "linux64-pgo", 11:21:59 INFO - "builduid": "9343ee82ee7647bca7e55bf4f6e6e44f", 11:21:59 INFO - "slavebuilddir": "test" 11:21:59 INFO - } 11:21:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:21:59 INFO - Running post-action listener: _resource_record_post_action 11:21:59 INFO - [mozharness: 2017-01-04 19:21:59.223352Z] Finished read-buildbot-config step (success) 11:21:59 INFO - [mozharness: 2017-01-04 19:21:59.223441Z] Running download-and-extract step. 11:21:59 INFO - Running pre-action listener: _resource_record_pre_action 11:21:59 INFO - Running main action method: download_and_extract 11:21:59 INFO - mkdir: /builds/slave/test/build/tests 11:21:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:59 INFO - trying https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:21:59 INFO - Downloading https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:21:59 INFO - Downloaded 1361 bytes. 11:21:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:21:59 INFO - Using the following test package requirements: 11:21:59 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:21:59 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:21:59 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:21:59 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'jsshell-linux-x86_64.zip'], 11:21:59 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:21:59 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:21:59 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:21:59 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:21:59 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:21:59 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:59 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:21:59 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:21:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:21:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:21:59 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:22:00 INFO - Http code: 200 11:22:00 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 11:22:00 INFO - x-amz-cf-id: zXLOwa5OgJgvi2cmeI4K63imcdq5Gq_ER7Ecol59lKZbkWp_2lqxSg== 11:22:00 INFO - x-amz-version-id: Q5V5mWoIAK37qkCBdPsKs6XSHd1G2h67 11:22:00 INFO - Expected file size: 21942320 11:22:00 INFO - Obtained file size: 21942320 11:22:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:22:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:22:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:04 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:22:05 INFO - Http code: 200 11:22:05 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 11:22:05 INFO - x-amz-cf-id: iJVmNoKFZpteUe9jcN9uLLPN-s0C64IdkP5_V1edt1_6VAsPnx2loA== 11:22:05 INFO - x-amz-version-id: Q5V5mWoIAK37qkCBdPsKs6XSHd1G2h67 11:22:05 INFO - Expected file size: 21942320 11:22:05 INFO - Obtained file size: 21942320 11:22:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:10 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:22:10 INFO - Http code: 200 11:22:10 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 11:22:10 INFO - x-amz-cf-id: vqoQSV3UMctYAxd1nFuMsbajOAv7i5c1h2ahD_vzt66MkFNSl0e0Lg== 11:22:10 INFO - x-amz-version-id: LSR04SWboSQyJ3xpXuEkS.KNdYvqFMbm 11:22:10 INFO - Expected file size: 14409038 11:22:10 INFO - Obtained file size: 14409038 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:11 INFO - trying https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:11 INFO - Downloading https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:22:12 INFO - Downloaded 64010003 bytes. 11:22:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:12 INFO - mkdir: /builds/slave/test/properties 11:22:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:12 INFO - Contents: 11:22:12 INFO - build_url:https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:12 INFO - Running post-action listener: _resource_record_post_action 11:22:12 INFO - Running post-action listener: set_extra_try_arguments 11:22:12 INFO - [mozharness: 2017-01-04 19:22:12.838487Z] Finished download-and-extract step (success) 11:22:12 INFO - [mozharness: 2017-01-04 19:22:12.838785Z] Running populate-webroot step. 11:22:12 INFO - Running pre-action listener: _resource_record_pre_action 11:22:12 INFO - Running main action method: populate_webroot 11:22:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:12 INFO - '--tppagecycles', 11:22:12 INFO - '7'], 11:22:12 INFO - 'tests': ['tsvgm']}}, 11:22:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['damp', 'tps']}, 11:22:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'tests': ['damp', 'tps']}, 11:22:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['dromaeo_dom']}, 11:22:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['basic_compositor_video']}, 11:22:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['a11yr', 11:22:12 INFO - 'ts_paint', 11:22:12 INFO - 'tpaint', 11:22:12 INFO - 'sessionrestore', 11:22:12 INFO - 'sessionrestore_no_auto_restore', 11:22:12 INFO - 'tabpaint']}, 11:22:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['tsvgx', 11:22:12 INFO - 'tsvgr_opacity', 11:22:12 INFO - 'tart', 11:22:12 INFO - 'tscrollx', 11:22:12 INFO - 'cart']}, 11:22:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:12 INFO - 'tsvgr_opacity', 11:22:12 INFO - 'tart', 11:22:12 INFO - 'tscrollx', 11:22:12 INFO - 'cart']}, 11:22:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'talos_options': ['--disable-e10s'], 11:22:12 INFO - 'tests': ['tp5o']}, 11:22:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'tests': ['tp5o']}, 11:22:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'talos_options': ['--disable-e10s', 11:22:12 INFO - '--xperf_path', 11:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:12 INFO - 'tests': ['tp5n']}, 11:22:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:12 INFO - 'talos_options': ['--xperf_path', 11:22:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:12 INFO - 'tests': ['tp5n']}}, 11:22:12 INFO - 'talos.zip': {'path': '', 11:22:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:12 INFO - Running post-action listener: _resource_record_post_action 11:22:12 INFO - [mozharness: 2017-01-04 19:22:12.860265Z] Finished populate-webroot step (success) 11:22:12 INFO - [mozharness: 2017-01-04 19:22:12.860356Z] Running create-virtualenv step. 11:22:12 INFO - Running pre-action listener: _resource_record_pre_action 11:22:12 INFO - Running main action method: create_virtualenv 11:22:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:22:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:12 INFO - Using real prefix '/usr' 11:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:15 INFO - Installing pip.................done. 11:22:15 INFO - Return code: 0 11:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:22:15 INFO - Reading from file tmpfile_stdout 11:22:15 INFO - Output received: 11:22:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:22:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:15 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:15 INFO - Using env: {'DISPLAY': ':0', 11:22:15 INFO - 'HOME': '/home/cltbld', 11:22:15 INFO - 'LANG': 'en_US.UTF-8', 11:22:15 INFO - 'LANGUAGE': 'en_US:en', 11:22:15 INFO - 'LOGNAME': 'cltbld', 11:22:15 INFO - 'MAIL': '/var/mail/cltbld', 11:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:15 INFO - 'MOZ_NO_REMOTE': '1', 11:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:15 INFO - 'NO_EM_RESTART': '1', 11:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:15 INFO - 'PWD': '/builds/slave/test', 11:22:15 INFO - 'SHELL': '/bin/bash', 11:22:15 INFO - 'SHLVL': '1', 11:22:15 INFO - 'TERM': 'linux', 11:22:15 INFO - 'TMOUT': '86400', 11:22:15 INFO - 'USER': 'cltbld', 11:22:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:15 INFO - '_': '/tools/buildbot/bin/python'} 11:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:22:15 INFO - Cleaning up... 11:22:15 INFO - Return code: 0 11:22:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:15 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:22:15 INFO - Using env: {'DISPLAY': ':0', 11:22:15 INFO - 'HOME': '/home/cltbld', 11:22:15 INFO - 'LANG': 'en_US.UTF-8', 11:22:15 INFO - 'LANGUAGE': 'en_US:en', 11:22:15 INFO - 'LOGNAME': 'cltbld', 11:22:15 INFO - 'MAIL': '/var/mail/cltbld', 11:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:15 INFO - 'MOZ_NO_REMOTE': '1', 11:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:15 INFO - 'NO_EM_RESTART': '1', 11:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:15 INFO - 'PWD': '/builds/slave/test', 11:22:15 INFO - 'SHELL': '/bin/bash', 11:22:15 INFO - 'SHLVL': '1', 11:22:15 INFO - 'TERM': 'linux', 11:22:15 INFO - 'TMOUT': '86400', 11:22:15 INFO - 'USER': 'cltbld', 11:22:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:15 INFO - '_': '/tools/buildbot/bin/python'} 11:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:16 INFO - Downloading/unpacking psutil>=3.1.1 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:18 INFO - Installing collected packages: psutil 11:22:18 INFO - Running setup.py install for psutil 11:22:18 INFO - building 'psutil._psutil_linux' extension 11:22:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:22:18 INFO - building 'psutil._psutil_posix' extension 11:22:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:18 INFO - Successfully installed psutil 11:22:18 INFO - Cleaning up... 11:22:18 INFO - Return code: 0 11:22:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:18 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:18 INFO - Using env: {'DISPLAY': ':0', 11:22:18 INFO - 'HOME': '/home/cltbld', 11:22:18 INFO - 'LANG': 'en_US.UTF-8', 11:22:18 INFO - 'LANGUAGE': 'en_US:en', 11:22:18 INFO - 'LOGNAME': 'cltbld', 11:22:18 INFO - 'MAIL': '/var/mail/cltbld', 11:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:18 INFO - 'MOZ_NO_REMOTE': '1', 11:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:18 INFO - 'NO_EM_RESTART': '1', 11:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:18 INFO - 'PWD': '/builds/slave/test', 11:22:18 INFO - 'SHELL': '/bin/bash', 11:22:18 INFO - 'SHLVL': '1', 11:22:18 INFO - 'TERM': 'linux', 11:22:18 INFO - 'TMOUT': '86400', 11:22:18 INFO - 'USER': 'cltbld', 11:22:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:18 INFO - '_': '/tools/buildbot/bin/python'} 11:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:21 INFO - Installing collected packages: mozsystemmonitor 11:22:21 INFO - Running setup.py install for mozsystemmonitor 11:22:21 INFO - Successfully installed mozsystemmonitor 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:21 INFO - Using env: {'DISPLAY': ':0', 11:22:21 INFO - 'HOME': '/home/cltbld', 11:22:21 INFO - 'LANG': 'en_US.UTF-8', 11:22:21 INFO - 'LANGUAGE': 'en_US:en', 11:22:21 INFO - 'LOGNAME': 'cltbld', 11:22:21 INFO - 'MAIL': '/var/mail/cltbld', 11:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:21 INFO - 'MOZ_NO_REMOTE': '1', 11:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:21 INFO - 'NO_EM_RESTART': '1', 11:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:21 INFO - 'PWD': '/builds/slave/test', 11:22:21 INFO - 'SHELL': '/bin/bash', 11:22:21 INFO - 'SHLVL': '1', 11:22:21 INFO - 'TERM': 'linux', 11:22:21 INFO - 'TMOUT': '86400', 11:22:21 INFO - 'USER': 'cltbld', 11:22:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:21 INFO - '_': '/tools/buildbot/bin/python'} 11:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:21 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:23 INFO - warning: no files found matching '*.txt' 11:22:23 INFO - no previously-included directories found matching 'build' 11:22:23 INFO - no previously-included directories found matching 'dist' 11:22:23 INFO - no previously-included directories found matching '.git*' 11:22:23 INFO - Installing collected packages: jsonschema, functools32 11:22:23 INFO - Running setup.py install for functools32 11:22:23 INFO - warning: no files found matching '*.txt' 11:22:23 INFO - no previously-included directories found matching 'build' 11:22:23 INFO - no previously-included directories found matching 'dist' 11:22:23 INFO - no previously-included directories found matching '.git*' 11:22:23 INFO - Successfully installed jsonschema functools32 11:22:23 INFO - Cleaning up... 11:22:23 INFO - Return code: 0 11:22:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:23 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:23 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22:23 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 functools32==3.2.3-2 11:22:23 INFO - Using env: {'DISPLAY': ':0', 11:22:23 INFO - 'HOME': '/home/cltbld', 11:22:23 INFO - 'LANG': 'en_US.UTF-8', 11:22:23 INFO - 'LANGUAGE': 'en_US:en', 11:22:23 INFO - 'LOGNAME': 'cltbld', 11:22:23 INFO - 'MAIL': '/var/mail/cltbld', 11:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:23 INFO - 'MOZ_NO_REMOTE': '1', 11:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:23 INFO - 'NO_EM_RESTART': '1', 11:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:23 INFO - 'PWD': '/builds/slave/test', 11:22:23 INFO - 'SHELL': '/bin/bash', 11:22:23 INFO - 'SHLVL': '1', 11:22:23 INFO - 'TERM': 'linux', 11:22:23 INFO - 'TMOUT': '86400', 11:22:23 INFO - 'USER': 'cltbld', 11:22:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:23 INFO - '_': '/tools/buildbot/bin/python'} 11:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:24 INFO - Cleaning up... 11:22:24 INFO - Return code: 0 11:22:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:24 INFO - Using env: {'DISPLAY': ':0', 11:22:24 INFO - 'HOME': '/home/cltbld', 11:22:24 INFO - 'LANG': 'en_US.UTF-8', 11:22:24 INFO - 'LANGUAGE': 'en_US:en', 11:22:24 INFO - 'LOGNAME': 'cltbld', 11:22:24 INFO - 'MAIL': '/var/mail/cltbld', 11:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:24 INFO - 'MOZ_NO_REMOTE': '1', 11:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:24 INFO - 'NO_EM_RESTART': '1', 11:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:24 INFO - 'PWD': '/builds/slave/test', 11:22:24 INFO - 'SHELL': '/bin/bash', 11:22:24 INFO - 'SHLVL': '1', 11:22:24 INFO - 'TERM': 'linux', 11:22:24 INFO - 'TMOUT': '86400', 11:22:24 INFO - 'USER': 'cltbld', 11:22:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:24 INFO - '_': '/tools/buildbot/bin/python'} 11:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:27 INFO - Downloading docopt-0.6.1.tar.gz 11:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:27 INFO - Running setup.py install for blobuploader 11:22:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:27 INFO - Running setup.py install for requests 11:22:27 INFO - Running setup.py install for docopt 11:22:27 INFO - Successfully installed blobuploader requests docopt 11:22:27 INFO - Cleaning up... 11:22:27 INFO - Return code: 0 11:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:27 INFO - Using env: {'DISPLAY': ':0', 11:22:27 INFO - 'HOME': '/home/cltbld', 11:22:27 INFO - 'LANG': 'en_US.UTF-8', 11:22:27 INFO - 'LANGUAGE': 'en_US:en', 11:22:27 INFO - 'LOGNAME': 'cltbld', 11:22:27 INFO - 'MAIL': '/var/mail/cltbld', 11:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:27 INFO - 'MOZ_NO_REMOTE': '1', 11:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:27 INFO - 'NO_EM_RESTART': '1', 11:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:27 INFO - 'PWD': '/builds/slave/test', 11:22:27 INFO - 'SHELL': '/bin/bash', 11:22:27 INFO - 'SHLVL': '1', 11:22:27 INFO - 'TERM': 'linux', 11:22:27 INFO - 'TMOUT': '86400', 11:22:27 INFO - 'USER': 'cltbld', 11:22:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:27 INFO - '_': '/tools/buildbot/bin/python'} 11:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:27 INFO - Running setup.py (path:/tmp/pip-n_gU9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:27 INFO - Running setup.py (path:/tmp/pip-oWDJwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:28 INFO - Running setup.py (path:/tmp/pip-zWkhwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:28 INFO - Running setup.py (path:/tmp/pip-rxc9fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:28 INFO - Running setup.py (path:/tmp/pip-jhJaQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:28 INFO - Running setup.py (path:/tmp/pip-VwAxjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:28 INFO - Running setup.py (path:/tmp/pip-1T_RTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:28 INFO - Running setup.py (path:/tmp/pip-yTKyeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:28 INFO - Running setup.py (path:/tmp/pip-s2z6VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:28 INFO - Running setup.py (path:/tmp/pip-7C4b5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:28 INFO - Running setup.py (path:/tmp/pip-0f2dvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:28 INFO - Running setup.py (path:/tmp/pip-wf8A_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:28 INFO - Running setup.py (path:/tmp/pip-vVOlIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:28 INFO - Running setup.py (path:/tmp/pip-JgezFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:28 INFO - Running setup.py (path:/tmp/pip-XxSt1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:28 INFO - Running setup.py (path:/tmp/pip-MfD9sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:29 INFO - Running setup.py (path:/tmp/pip-CdCOrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:29 INFO - Running setup.py install for manifestparser 11:22:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Running setup.py install for mozcrash 11:22:29 INFO - Running setup.py install for mozdebug 11:22:29 INFO - Running setup.py install for mozdevice 11:22:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Running setup.py install for mozfile 11:22:29 INFO - Running setup.py install for mozhttpd 11:22:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Running setup.py install for mozinfo 11:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Running setup.py install for mozInstall 11:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:29 INFO - Running setup.py install for mozleak 11:22:30 INFO - Running setup.py install for mozlog 11:22:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Running setup.py install for moznetwork 11:22:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Running setup.py install for mozprocess 11:22:30 INFO - Running setup.py install for mozprofile 11:22:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Running setup.py install for mozrunner 11:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Running setup.py install for mozscreenshot 11:22:30 INFO - Running setup.py install for moztest 11:22:30 INFO - Running setup.py install for mozversion 11:22:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:30 INFO - Cleaning up... 11:22:30 INFO - Return code: 0 11:22:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:30 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:30 INFO - Using env: {'DISPLAY': ':0', 11:22:30 INFO - 'HOME': '/home/cltbld', 11:22:30 INFO - 'LANG': 'en_US.UTF-8', 11:22:30 INFO - 'LANGUAGE': 'en_US:en', 11:22:30 INFO - 'LOGNAME': 'cltbld', 11:22:30 INFO - 'MAIL': '/var/mail/cltbld', 11:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:30 INFO - 'MOZ_NO_REMOTE': '1', 11:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:30 INFO - 'NO_EM_RESTART': '1', 11:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:30 INFO - 'PWD': '/builds/slave/test', 11:22:30 INFO - 'SHELL': '/bin/bash', 11:22:30 INFO - 'SHLVL': '1', 11:22:30 INFO - 'TERM': 'linux', 11:22:30 INFO - 'TMOUT': '86400', 11:22:30 INFO - 'USER': 'cltbld', 11:22:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:30 INFO - '_': '/tools/buildbot/bin/python'} 11:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:31 INFO - Running setup.py (path:/tmp/pip-h7RDV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:31 INFO - Running setup.py (path:/tmp/pip-9Wmh96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:31 INFO - Running setup.py (path:/tmp/pip-ZELKcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:31 INFO - Running setup.py (path:/tmp/pip-fw1U2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:31 INFO - Running setup.py (path:/tmp/pip-f9f6Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:31 INFO - Running setup.py (path:/tmp/pip-S9KEm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:31 INFO - Running setup.py (path:/tmp/pip-EgxAKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:31 INFO - Running setup.py (path:/tmp/pip-OGeKbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:31 INFO - Running setup.py (path:/tmp/pip-osI5_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:31 INFO - Running setup.py (path:/tmp/pip-ZhLn9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:31 INFO - Running setup.py (path:/tmp/pip-CPK3Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:31 INFO - Running setup.py (path:/tmp/pip-4d6ySd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:32 INFO - Running setup.py (path:/tmp/pip-_NXVHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:32 INFO - Running setup.py (path:/tmp/pip-8Qr2w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:32 INFO - Running setup.py (path:/tmp/pip-1WbcwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:32 INFO - Running setup.py (path:/tmp/pip-MRc9e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:32 INFO - Running setup.py (path:/tmp/pip-pPFoJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:34 INFO - Downloading blessings-1.6.tar.gz 11:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:34 INFO - Installing collected packages: blessings 11:22:34 INFO - Running setup.py install for blessings 11:22:34 INFO - Successfully installed blessings 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:34 INFO - Reading from file tmpfile_stdout 11:22:34 INFO - Current package versions: 11:22:34 INFO - argparse == 1.2.1 11:22:34 INFO - blessings == 1.6 11:22:34 INFO - blobuploader == 1.2.4 11:22:34 INFO - docopt == 0.6.1 11:22:34 INFO - functools32 == 3.2.3-2 11:22:34 INFO - jsonschema == 2.5.1 11:22:34 INFO - manifestparser == 1.1 11:22:34 INFO - mozInstall == 1.12 11:22:34 INFO - mozcrash == 1.0 11:22:34 INFO - mozdebug == 0.1 11:22:34 INFO - mozdevice == 0.48 11:22:34 INFO - mozfile == 1.2 11:22:34 INFO - mozhttpd == 0.7 11:22:34 INFO - mozinfo == 0.9 11:22:34 INFO - mozleak == 0.1 11:22:34 INFO - mozlog == 3.4 11:22:34 INFO - moznetwork == 0.27 11:22:34 INFO - mozprocess == 0.23 11:22:34 INFO - mozprofile == 0.28 11:22:34 INFO - mozrunner == 6.13 11:22:34 INFO - mozscreenshot == 0.1 11:22:34 INFO - mozsystemmonitor == 0.3 11:22:34 INFO - moztest == 0.8 11:22:34 INFO - mozversion == 1.4 11:22:34 INFO - psutil == 3.1.1 11:22:34 INFO - requests == 1.2.3 11:22:34 INFO - wsgiref == 0.1.2 11:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:35 INFO - Cleaning up... 11:22:35 INFO - Return code: 0 11:22:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9cd273f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22: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', 'jsonschema'] in /builds/slave/test/build 11:22: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 jsonschema 11:22:35 INFO - Using env: {'DISPLAY': ':0', 11:22:35 INFO - 'HOME': '/home/cltbld', 11:22:35 INFO - 'LANG': 'en_US.UTF-8', 11:22:35 INFO - 'LANGUAGE': 'en_US:en', 11:22:35 INFO - 'LOGNAME': 'cltbld', 11:22:35 INFO - 'MAIL': '/var/mail/cltbld', 11:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:35 INFO - 'MOZ_NO_REMOTE': '1', 11:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:35 INFO - 'NO_EM_RESTART': '1', 11:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:35 INFO - 'PWD': '/builds/slave/test', 11:22:35 INFO - 'SHELL': '/bin/bash', 11:22:35 INFO - 'SHLVL': '1', 11:22:35 INFO - 'TERM': 'linux', 11:22:35 INFO - 'TMOUT': '86400', 11:22:35 INFO - 'USER': 'cltbld', 11:22:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:35 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:35 INFO - Cleaning up... 11:22:35 INFO - Return code: 0 11:22:35 INFO - Running post-action listener: _resource_record_post_action 11:22:35 INFO - Running post-action listener: _start_resource_monitoring 11:22:35 INFO - Starting resource monitoring. 11:22:35 INFO - [mozharness: 2017-01-04 19:22:35.366763Z] Finished create-virtualenv step (success) 11:22:35 INFO - [mozharness: 2017-01-04 19:22:35.367270Z] Running install step. 11:22:35 INFO - Running pre-action listener: _resource_record_pre_action 11:22:35 INFO - Running main action method: install 11:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:35 INFO - Reading from file tmpfile_stdout 11:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:35 INFO - Reading from file tmpfile_stdout 11:22:35 INFO - Output received: 11:22:35 INFO - Usage: mozinstall [options] installer 11:22:35 INFO - Options: 11:22:35 INFO - -h, --help show this help message and exit 11:22:35 INFO - -d DEST, --destination=DEST 11:22:35 INFO - Directory to install application into. [default: 11:22:35 INFO - "/builds/slave/test"] 11:22:35 INFO - --app=APP Application being installed. [default: firefox] 11:22:35 INFO - mkdir: /builds/slave/test/build/application 11:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:22:51 INFO - Reading from file tmpfile_stdout 11:22:51 INFO - Output received: 11:22:51 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:51 INFO - Running post-action listener: _resource_record_post_action 11:22:51 INFO - [mozharness: 2017-01-04 19:22:51.604718Z] Finished install step (success) 11:22:51 INFO - [mozharness: 2017-01-04 19:22:51.604963Z] Running run-tests step. 11:22:51 INFO - Running pre-action listener: _resource_record_pre_action 11:22:51 INFO - Running main action method: run_tests 11:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:51 INFO - Python 2.7.3 11:22:51 INFO - Return code: 0 11:22:51 INFO - grabbing minidump binary from tooltool 11:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:51 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 0x14a8f60>, '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 0x14a9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:22:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:22:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:22:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:51 INFO - Return code: 0 11:22:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:22:51 INFO - Using env: {'DISPLAY': ':0', 11:22:51 INFO - 'HOME': '/home/cltbld', 11:22:51 INFO - 'LANG': 'en_US.UTF-8', 11:22:51 INFO - 'LANGUAGE': 'en_US:en', 11:22:51 INFO - 'LOGNAME': 'cltbld', 11:22:51 INFO - 'MAIL': '/var/mail/cltbld', 11:22:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:51 INFO - 'MOZ_NO_REMOTE': '1', 11:22:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:51 INFO - 'NO_EM_RESTART': '1', 11:22:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:51 INFO - 'PWD': '/builds/slave/test', 11:22:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:51 INFO - 'SHELL': '/bin/bash', 11:22:51 INFO - 'SHLVL': '1', 11:22:51 INFO - 'TERM': 'linux', 11:22:51 INFO - 'TMOUT': '86400', 11:22:51 INFO - 'USER': 'cltbld', 11:22:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308', 11:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:51 INFO - '_': '/tools/buildbot/bin/python'} 11:22:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:22:51 INFO - mozversion application_buildid: 20170104094639 11:22:51 INFO - mozversion application_changeset: a51cdeb88cbfee1e51234a575ccb8aa75130a07d 11:22:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:22:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:51 INFO - mozversion application_name: Firefox 11:22:51 INFO - mozversion application_remotingname: firefox-dev 11:22:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:51 INFO - mozversion application_vendor: Mozilla 11:22:51 INFO - mozversion application_version: 52.0a2 11:22:51 INFO - mozversion platform_buildid: 20170104094639 11:22:51 INFO - mozversion platform_changeset: a51cdeb88cbfee1e51234a575ccb8aa75130a07d 11:22:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:51 INFO - mozversion platform_version: 52.0a2 11:22:51 INFO - using testdate: 1483557771 11:22:51 INFO - actual date: 1483557771 11:22:51 INFO - starting webserver on 'localhost:45302' 11:22:51 INFO - SUITE-START | Running 2 tests 11:22:51 INFO - TEST-START | dromaeo_css 11:22:51 INFO - operating with platform_type : linux_ 11:22:51 INFO - Initialising browser for dromaeo_css test... 11:22:51 INFO - TEST-INFO | started process 25043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdK29y/profile http://localhost:45302/getInfo.html) 11:22:55 INFO - PROCESS | 25043 | __metrics Screen width/height:1600/1200 11:22:55 INFO - PROCESS | 25043 | colorDepth:24 11:22:55 INFO - PROCESS | 25043 | Browser inner width/height: 1024/697 11:22:55 INFO - PROCESS | 25043 | __metrics 11:22:56 INFO - PROCESS | 25043 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:22:56 INFO - PROCESS | 25043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:22:56 INFO - PROCESS | 25043 | console.error: PushService: 11:22:56 INFO - PROCESS | 25043 | stateChangeProcessEnqueue: Error transitioning state 11:22:56 INFO - PROCESS | 25043 | UnknownError 11:22:57 INFO - TEST-INFO | 25043: exit 0 11:22:57 INFO - Browser initialized. 11:22:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:57 INFO - TEST-INFO | started process 25135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdK29y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:09 INFO - PROCESS | 25135 | RSS: Main: 144867328 11:23:09 INFO - PROCESS | 25135 | 11:26:10 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45302/tests/dromaeo/cssquery-ext.html) 11:26:12 INFO - PROCESS | 25135 | RSS: Main: 274358272 11:26:12 INFO - PROCESS | 25135 | 11:29:14 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-ext.html (next: http://localhost:45302/tests/dromaeo/cssquery-jquery.html) 11:29:15 INFO - PROCESS | 25135 | RSS: Main: 229998592 11:29:15 INFO - PROCESS | 25135 | 11:32:17 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45302/tests/dromaeo/cssquery-mootools.html) 11:32:17 INFO - PROCESS | 25135 | RSS: Main: 177836032 11:32:17 INFO - PROCESS | 25135 | 11:35:19 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45302/tests/dromaeo/cssquery-prototype.html) 11:35:20 INFO - PROCESS | 25135 | RSS: Main: 230141952 11:35:20 INFO - PROCESS | 25135 | 11:38:23 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45302/tests/dromaeo/cssquery-yui.html) 11:38:23 INFO - PROCESS | 25135 | RSS: Main: 173416448 11:38:23 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-yui.html (next: http://localhost:45302/tests/dromaeo/cssquery-dojo.html) 11:41:26 INFO - PROCESS | 25135 | RSS: Main: 255991808 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | __start_tp_report 11:41:26 INFO - PROCESS | 25135 | _x_x_mozilla_page_load 11:41:26 INFO - PROCESS | 25135 | _x_x_mozilla_page_load_details 11:41:26 INFO - PROCESS | 25135 | |i|pagename|runs| 11:41:26 INFO - PROCESS | 25135 | |0;dojo.html;3200.5679233303504;3238.125706059365;3247.3342964692242;3268.2483028903366;3293.9505907411394;5460.78156873725;5576.944230557693;5577.498025177733;5593.636413633111;5595.49640532352;5496.4503549645015;5525.309336332958;5526.889462210754;5530.419305972875;5556.416576259495;4980.950190498094;4995.100881841267;5024.371953505812;5067.518585734368;5072.898542029157;4997.075541024904;5002.799888004475;5046.848594542152;5094.388673359202;5102.413222479426;5037.848864534069;5083.949160508403;5095.0319439306595;5097.7960881564695;5104.310918026056;5028.723420211887;5034.0686972910125;5071.797128114889;5081.364829396325;5092.872678183038;5019.52314530119;5042.445331013586;5048.015636950796;5083.974580127113;5139.126348520723;5548;5570.359408667974;5640.915386269209;5643.5767317451355;5656.462636049569;5771.220885180531;5818.2436283282905;5822.330432000332;5860.355360910296;5898.705064746746;5951.345352011275;5953.493953013999;5962.403759624046;6083.665398403086;6088.056351265561;5662.09406494963;5669.518090962232;5672.943270567324;5674.290713660793;5678.744456499468;5840.2991641003355;5872;5922.407759224043;5924.822255332347;5981.521478281814;5763.942360576424;5791.276090488689;5794.82615521535;5795.82612521625;5799.88400231993;5839.124131380242;5845.064789633639;5849.239598852122;5858.033424484997;5864.706764661835;5740.196372507852;5740.454656807597;5786.1610066540115;5796.217510636095;5801.796937107181;5918.408159184047;5921.73352199152;5922.466977972003;5930.970345148333;5947.881042379128;4593.035462552902;4597.885052873705;4602.424696912886;4609.723416594948;4609.861704148881;4014.8594799182474;4047.514298284225;4055.1889622075705;4101.651359634465;4144.958550414518;5583.944160558342;5648;5677.233573467529;5683.54531637468;5737.053386191315;5997.7001149942325;6007.399260074045;6010.789622363196;6013.458788709037;6015.849603759941;5401.675899446046;5452.727363631802;5637.802676906289;5648.858778530487;5661.7735290588735;5004.674696144739;5062.265971434195;5072.6195535335;5092.490750924952;5149.407818100966;6131.509479241561;6168.722407491674;6169.2288463942;6173.99999999991;6182.752689892354;5829.912551311819;5925.05199168131;5927.881442371042;5939.67331796738;5946.554008449297;5968.940310596839;6021.969890150521;6101.725422356093;6130.417610327012;6155.199824022849;5908.7045647718305;5913.497352724895;5914.172015917861;5932.762689492544;5947.524198064058;5971.492423143907;5975.521958243417;5979.910301345396;5981.0729336952845;5991;5654.491095801233;5690.687012214368;5766.711664416846;5861.706914654165;5907.852303692442;5724.0555308375315;5832.24180856486;5848.298204215351;5850.23946886902;5853;5776.971115144397;5793.188953546591;5815.2149459822385;5815.447532484407;5816.9127463088935;5696.515796157373;5707.286589176353;5840.415958404125;5882.94117058841;5894.823155305347;5633.239512665901;5658.717064146694;5663.490285874291;5741;5760.452756988079 11:41:26 INFO - PROCESS | 25135 | |1;ext.html;561.6658088437379;595.2648479128277;620.348633934369;653.5523166630858;661.4278648968643;33967.66032339679;37040.259194816084;37088.62911370882;37090.814545927264;37101.62898371016;37342.813285933604;46506;47313.76343118288;47483.050338993286;51537.226941595814;8833.999999999984;8950.14973577509;8955.865662015074;8956.820863582725;8957.865632015493;8477.703280385187;8698.304135669132;8854.247388971913;8957.328200384965;8961.462312261285;10647.57409703611;10901.182411319143;10910.072643825284;11262.324260544352;11265.718357041098;10737.51681174349;10800.405977671226;10806.35161890289;10812;10812.135029197685;10552.683419497427;10596.682099536949;10643.521041553071;10651.094656954168;10665.9466702666;44377.77811110956;44961;45008.54991450109;45090;45170.09659806785;3768.623137686237;3815.351390263662;3843.3082045231845;3871.361225397806;3959.4060890866313;34109.48835767466;34140;34227;34271;34485;4204.432401625802;4249.978750106261;4260.211860805761;4260.659147268211;4376.759278239696;357443;357586;357981;359030;359598.2020089909;64525.354746452875;65259.67370163119;65287;65311.67344163249;65343.67328163424;40398.39402408966;41181.58818411837;41320;44129;44179.337309940376;19632.3128690498;19797.208111675372;19798.50503737418;19825.603487930162;19833;15093.39626414953;15178.848211517743;15193;15198.46805361807;15198.468053618291;18551;18959.052047397574;20829.1668333268;21012.369628911158;21738;7522.887156692654;7657.1959944205055;7692.615369231516;7697.576633285223;7873.803154921058;1013.7009582173276;1042.5829668132808;1113.1929351220463;1130.5308297056795;1134.28540019787;32470;33975.66024339725;34265;34432.48351274733;34709.13227169341;1106.7454485468227;1113.8050841102774;1167.8948894599528;1239.305988646361;1244.4089057697522;17944;18176.818231817513;18199.63600727978;18351.908240458713;18368.63262734738;495368;546021;550357;553057;800493;65283;65903.67048164824;65913.34086659168;65983.34016659867;66036.33963660398;1345.2399394342165;1390.4924702483722;1414.5968399006233;1439.5321520505877;1453.4694836384856;34593.48109778405;36162.19280535571;36249.27501450009;36477.63522364743;36573.26853462969;54298.72850635721;54933.450665492834;55061.449385505635;55067.44932550623;55067.72466137644;307075;310673;311763;311981;312707;30560.694393056674;31065.223369415944;31442.528362075045;32447.702091917003;32882.671173288916;50678;50842.491575083775;50851.23723144082;51681.7415912918;51896.74051629869;43238;44406.3339049908;44934.77532612316;45014.324785127596;46158.30762538497;44286.778566106965;45440;45668.10376904481;46198.53801462077;46424.30363544482;45000.54999450094;45469.31796023128;45660.315095272934;46454.53545464637;46477;37789.244215114995;39654.405183921685;39685;40659;40722.389164163156;29656.851715741283;29860.253493662833;30090.398192036475;30629.540556891217;30717.69282307238 11:41:26 INFO - PROCESS | 25135 | |2;jquery.html;388.95527014393355;425.8523040623817;429.55970130616106;435.71896126998087;441.31816343748886;15283.923580382096;19039.855252562418;20771.896140519275;20839.791602083973;20934.16263349464;17412.912935435306;18034.368797092106;18220.81779182208;18249.270029198848;19667.5083122922;5734.853029394117;6003.879922401549;6006.969965150168;6010.1585777990895;6012.278526576795;4371.73769573825;4581.9337841056595;4623.606993405565;6750.426213771835;6779.62712050837;6704.966475167617;6709.396154346108;6715.227748808877;6718.05947167397;6724.058631791553;6441.516886233528;6601.966990165042;6613.834654133685;6626.337366263335;6640.1035860158745;5725.799597014126;5891.823245302605;5899.997000509924;5908.97045514774;5958.940410595882;23841;23913;24041.39896502584;24056.87971560131;24108.517829643308;2609.086819613139;2680.6917204521533;2682.785377169822;2715.579085241791;2756.3109222694325;14098;14825.70348593022;15057.096574205583;15272.31274592646;15437.614059648598;1966.5771859050374;1986.8311193548566;1996.610660921121;2037.7962203779653;2065.2461851424273;83265.16734832696;84335.57832210862;84734.57632711859;85896.57051714702;86637.56681216617;9852.901470985198;11014.669559913216;11152.386618736047;11202.719932001764;11391.430428478543;14295.213763243122;14386.784198237036;15071.698566028617;15088.321025553876;15121;8418.452800567944;8876.423032502867;9022.278217742565;9090.500022498825;9203.309751768644;8330.333573314121;8439.662413503514;8470.661173553111;8543.273821725099;8664.956675216583;6635.4359879410795;6789.728410863609;6883.139607549057;6964.512484126062;7064.116985376828;1976.1107501624326;2008.7728043066668;2029.5737895041912;2029.857909946319;2029.9797002030086;1009.5557954499997;1042.1298215989734;1053.3890343600692;1100.959593184433;1128.3906690387264;20611.484712881997;20826.583468330547;20971.37085887426;21002.894985524974;21242.78757212408;1083.1334932054326;1083.983740243897;1089.1178145702006;1097.5006372100675;1107.0460636975745;11107;11939.88060119405;11965;12226.083043771574;12239.632811015685;462991;469961;471746;473134;481495;80535;80778.59610701908;82320;83690;84540;1049.92125590581;1070.9946450267698;1082.734729991157;1097.0510508410327;1097.4074000040048;17458.30166793314;17870.5532361692;18020.36928707489;18329.98370179306;18408.26366945361;27637.447251054466;30019.399612008074;35088.94733158009;39523.40714889221;40233.597664022986;49702.25446618231;49724.25413618871;49894.25158622551;50181;51343.74328128336;8785.780355490908;8912.153345432174;9076.820013398215;9200.861987070066;9206.355555111346;13605.251711155586;13969.720605587629;14006.789898151332;14130.576082717535;14343.354549045527;11630.476628551567;11661.24201926872;11770.823437648613;11817.172797904064;12019.75960480768;9753.561089750836;11811.468483918072;12094.879051209375;12102.939485302517;12446.813297800722;10440.373577585066;10883.183761218099;11149.442527873736;11378.487968041292;11754.11844111678;8931.330150238628;8997.775055623662;9021.858005363501;9102.817943641223;9369.765755856159;11570.305781653127;11608.30350178992;11650.88349116532;11676.88323116792;11734.119941004288 11:41:26 INFO - PROCESS | 25135 | |3;mootools.html;1346.5017943360958;1489.1363009454517;1496.4537943650564;1676.1870492810986;1821.6538857617052;7355.3380195782365;8295.253427191552;8552.999999999984;8617.612207450657;8813;8591.527465989368;8667.69663061793;8668.089850565695;8670.43642163259;8681.175288347613;2483.962740558893;2503.0113105323385;2505.711843138035;2506.0351764570682;2510.924672259835;2465.506898620274;2528.1404322530334;2529.8482091074593;2531.0761572026263;2535.6069809179608;2442.535918175541;2445.7798798108165;2466.3094333586623;2490.0786708917726;2490.414752533153;2391.796697280733;2419.516096780651;2447.229122826313;2459.5203935232457;2467.0501856785086;2443.315871555967;2463.3718401807605;2484.6831179474907;2489.5892177790643;2489.73857744936;8349.123342049119;8532.744017679417;8587.742367728915;8595.398322117455;8721.912780872173;5267.604929630254;5509.807156749534;5523.7238138092935;5530.668159910419;5538.889222215533;3535.1338921964284;3558.395072837624;3642.1805093853936;3673.963260367389;3720.441933709938;1235.1600911380258;1237.22055105284;1279.2899940533;1294.7928331467015;1311.63929919272;12006.759864802742;12091.879081209252;12162.209456385306;12164.148509604243;12172.208806427643;4698.562014649349;4719.079779442975;4762.071396077801;4801.279808028824;4897;9374.203192728559;9404.38871473352;9407.153356197838;9410.623575057058;9511.048895110434;5417.322834645669;5508.394076651565;5516.972415137899;5518.034343989866;5518.806841760519;4238.258304796648;4453.3320001999955;4543.204939135704;5040.36995375578;5171.922421163686;3957.3074711925296;3989.301872172416;4079.184163167319;4093.6520395766097;4096.40602112692;1273.452415461342;1306.6210798868221;1306.777847765863;1310.2269660900115;1323.5499930023839;1027.5581499954942;1028.1106842581114;1054.2409465185056;1063.5107850388754;1064.4039337970762;5971.5222782177325;6059.303180134253;6085.6348619083;6086.9391306087255;6398.8720225595225;476.8783960090155;483.2750873689466;493.86171871875933;495.88594623236133;499.3159371660848;4209.137126888981;4237.660987121023;4262;4326.048269380732;4350.216960946997;10691.572337106429;10841.620543280947;10941.070009049161;10957.671269861918;10973.670789876316;10289.691309260734;10687.251892367614;10691.358518488916;10880.510377033053;11032.558697652164;8285.42002059862;8472.745817625604;8517.829643407098;8519.275861551838;8519.829603407898;6022;6036.709993053709;6111.083337499411;6167.1366008759705;6308.71610777507;10002.999700029939;10063.798724025331;10166.8474972874;10191.796164076528;10199.133073688523;8339.54132522717;8575.528345941033;10070.647527336509;10097.89902100999;10258.846117308098;7069.434445244471;7243.891341629775;7244.239354867663;7553.471257011956;7733.458657893893;8474.66101355939;8541.829163416573;8621.784455388415;8636.006859211271;8652.913470865211;7447.478676492594;7488.326050655467;7547.886781698169;7555.73554925575;7660.310572048543;7406.296401842032;7470.962645186957;7590.506617069873;7599.088109426904;7611.809704757426;7126.786196414116;7168.85298352282;7170.103737032871;7170.211276759656;7204.71181152769;5216.66091704038;5297.8145764898045;5303.36359636846;5443.129099344086;5546.805861794818;5129.846104616868;5168.095583272988;5275.788968441219;5319.4414586467865;5328.200769884548 11:41:26 INFO - PROCESS | 25135 | |4;prototype.html;348.7802684308885;348.92846966371894;352.73368606701933;362.195925046397;364.6499360613811;5269.683818970864;5343.519083282504;5343.866403339918;5390.218418329345;5396.865078373043;5256.2917051958075;5261.210818377236;5263.763015691309;5267.815626453065;5278.419373868871;3969.7816620085882;4242.693665929084;4261.4460120184485;4300.39794428781;4327.221100201962;3752.418375151856;4128.8348466061325;4196.412502249687;4215.409842622035;4223.472065991751;4172.395002724603;4180.47744031996;4187.225363307783;4205.684573656973;4206.432131662233;4181.560936101696;4203.789810509493;4237.618614324726;4238.109996900655;4241.0881660443;3613.8012409317475;3652.1600031992525;3717.442383642448;3782.6217378261954;3793.3930571108767;5140;5151.124308867464;5153.9742301288625;5164.786275225319;5172.715500647463;4797.40032495938;4808.639352048575;4813.181759100926;4860;4883.4628190898975;5324.334458192726;5475.479829416239;5503.559715222773;5506.109292621366;5525.972370138164;4156.896077598054;4160.292750232467;4202.684798640114;4203.327467605169;4209.2423363794505;5525.419830917736;5560.694161821058;5684.289463817023;5802.506786923117;5806.361300256968;4236.5128010278595;4245.150969806051;4246.532881383046;4258.446401967786;4296.119295544406;4328.523862375137;4336.3278691802825;4337.284348082594;4343.066240758252;4352.1513304905875;4722.150012997693;4778.12657826721;4812.278158276286;4849.442314133919;4871.585915197248;5527.281453411031;5532.612717109763;5555.111182210827;5556.749946252347;5604.719764011783;1445.5302026841318;1459.5694270190106;1463.8609332113433;1474.1376294867407;1478.3643033495484;987.7382493639192;1023.357511194537;1028.711960651019;1042.5569133118395;1057.7620035491952;5247.347085668002;5256.789728410898;5266.447023062523;5270.49930256625;5278.5513231375;5459.2902922619805;5496.972515137399;5514.172874068921;5531.502164805187;5555.749991250404;4942.728149951788;5173.198154286091;5229.581633469314;5231.8168864089575;5277.7805538621415;2924.400497897926;2925.063979526531;2932.3695405487924;2936.7063293670462;2941.8970336038137;5761.481466667936;5774.913376299359;5782.797602083907;5790.88418231633;5799.926039199231;5381.354237491526;5558.805441809517;5589.972050139723;5610.915836262459;5617.38208797032;5696.3449203341315;5712.428757124254;5725;5751.827445176567;5840.445157710011;5257.947420525746;5489.560835133259;5522.22688823573;5542.674395362911;5570.582206334622;5335.519803217729;5371.62398632092;5395.676259424447;5409.404965453876;5430.972845135749;5627.0434026214825;5778.682172480554;5792.9710351447975;5869.06095024794;5926.348101708722;4158.521769996489;4162.4796900387455;4183.707140500136;4210.473690788652;4213.557576454428;5599.356074051536;5688.601797874109;5753.238445546245;5770.451807078321;5784.363719990882;5540.667559946416;5549.139883318092;5549.556035517229;5601.719914004202;5603.663780173202;5517.475839795213;5544.140658197985;5545.1682247663175;5570.832875013756;5574.386817449996;5256.39551451588;5518.19986102021;5525.668459892419;5538.446155384429;5561.416051314553;5625.184348269559;5625.8593535161945;5629.577781666473;5644.915326270027;5645.633033852787;5465.316835395575;5508.641938274;5516.227728117987;5516.779328826802;5518.42056584069 11:41:26 INFO - PROCESS | 25135 | |5;yui.html;797.3780451248025;840.3403328387217;852.8379607874504;873.5894129759012;916.5371487398864;15200.467983620576;16279.674406511862;16306.429274975364;16308.83691163088;16325.102119383444;13888.930555347235;13955.092918960261;13974.720505589881;13976.790348144761;13983;709.1596458197052;729.2780147653838;829.8796674482227;838.7861095420675;856.7815207122175;857.8584533551956;859.6346552715103;860.0797147052656;860.2515811244226;860.6084231674604;754.9886751698729;911.6672414568701;911.8313112074254;912.2473958983832;912.9543522823866;773.9071311442607;859.5272600069968;877.7937184761576;890.5636238243214;892.7366426904014;652.9902051469231;653.947684185264;654.6268626882679;654.7413771560255;655.0240142188153;12669.619911402673;12750.362481875869;12808.679783005406;12819.16675416095;12981.610551683465;13336.133151345131;13463.259520726357;13607.183568985893;13932.860671393257;14123.364448599736;13234.669133271746;13322.200667959953;13379.130356526892;13430.127041742353;13530.120542164728;4185.393117997904;4245.320748680197;4253.447051883266;4278.593533614302;4308.849190278356;62395.688021560054;64735.67632161809;65382.34617653858;66174;67300;11508.884911150948;11605.419729013516;11616.651500455;11649.12631552637;11701.414929253504;19359.4192174235;19799.10904009323;19843.801561984194;19921.900390497955;20579;8090.676372945134;8340.457870238415;8429.367797415218;8453.661853525913;8470.703525376583;4248.299030659907;4305.784710764449;4333.544977777288;4391.604755572014;4400.075984043323;3583.8028908409765;3706.6664000240107;3711.183539621279;3711.257748450321;3712.3688972874675;622.1662971618053;623.1307326279814;629.515273239612;659.4592434203906;664.9434798042221;678.772611175252;749.5577609210483;758.5069704691995;789.423720683904;791.4183075439547;9644.662436814679;9746.976567460457;9807.166390856715;9975.25185611082;10139.543720532594;717.6474681059462;733.7285204474379;742.224375527575;751.372603875759;757.4130049211794;4651.646962599436;4900.387451568554;4944.9258261126115;4948.331975183376;4958.9504104959215;80201.19798802055;88894.55552722195;92369;92992.53503732439;96487;80827.59586202032;82055;82876.58561707153;83575;86009;72319.29924554887;74087.25912740911;74646.62676686581;75882.86175707368;77439.61280193563;9444.386114902509;9481.146696797321;9556.331056825955;9577.23382129442;9620.855687164558;48332.886119475166;49796.751016244685;50669.746651266505;51394.229086562984;51698.22452663288;65186.348136519926;66671.66664166648;67042;67783.3221667777;69615.95576066464;10782.299150555189;10919.890801091888;11058.889411106107;11229.55081796719;11330.036946859609;12707.809382859079;12931.224126552437;13359.26524041187;13377.264250466318;13485.258310793;11934.701632459259;12326.568570100004;13424.664383390103;13474.730505389642;13640.249786261851;13610;13644.317784110954;13692.589222322948;13866;14158.929205353907;13297.202167869958;13348.866511334762;13388.330583470593;13506.864931350561;13684.589462316146;10561.260711750103;10715.839262410915;10862.837057443987;11004.174686898676;11609.941950290195;11262.605808796652;11271.549138034714;11583.131265155316;11844;11925 11:41:26 INFO - PROCESS | 25135 | __end_tp_report 11:41:26 INFO - PROCESS | 25135 | __start_cc_report 11:41:26 INFO - PROCESS | 25135 | _x_x_mozilla_cycle_collect,1279 11:41:26 INFO - PROCESS | 25135 | __end_cc_report 11:41:26 INFO - PROCESS | 25135 | __startTimestamp1483558886510__endTimestamp 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | ------- Summary: start ------- 11:41:26 INFO - PROCESS | 25135 | Number of tests: 6 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#0] dojo.html Cycles:165 Average:5513.46 Median:5737.05 stddev:610.44 (10.6%) stddev-sans-first:584.72 11:41:26 INFO - PROCESS | 25135 | Values: 3200.6 3238.1 3247.3 3268.2 3294.0 5460.8 5576.9 5577.5 5593.6 5595.5 5496.5 5525.3 5526.9 5530.4 5556.4 4981.0 4995.1 5024.4 5067.5 5072.9 4997.1 5002.8 5046.8 5094.4 5102.4 5037.8 5083.9 5095.0 5097.8 5104.3 5028.7 5034.1 5071.8 5081.4 5092.9 5019.5 5042.4 5048.0 5084.0 5139.1 5548.0 5570.4 5640.9 5643.6 5656.5 5771.2 5818.2 5822.3 5860.4 5898.7 5951.3 5953.5 5962.4 6083.7 6088.1 5662.1 5669.5 5672.9 5674.3 5678.7 5840.3 5872.0 5922.4 5924.8 5981.5 5763.9 5791.3 5794.8 5795.8 5799.9 5839.1 5845.1 5849.2 5858.0 5864.7 5740.2 5740.5 5786.2 5796.2 5801.8 5918.4 5921.7 5922.5 5931.0 5947.9 4593.0 4597.9 4602.4 4609.7 4609.9 4014.9 4047.5 4055.2 4101.7 4145.0 5583.9 5648.0 5677.2 5683.5 5737.1 5997.7 6007.4 6010.8 6013.5 6015.8 5401.7 5452.7 5637.8 5648.9 5661.8 5004.7 5062.3 5072.6 5092.5 5149.4 6131.5 6168.7 6169.2 6174.0 6182.8 5829.9 5925.1 5927.9 5939.7 5946.6 5968.9 6022.0 6101.7 6130.4 6155.2 5908.7 5913.5 5914.2 5932.8 5947.5 5971.5 5975.5 5979.9 5981.1 5991.0 5654.5 5690.7 5766.7 5861.7 5907.9 5724.1 5832.2 5848.3 5850.2 5853.0 5777.0 5793.2 5815.2 5815.4 5816.9 5696.5 5707.3 5840.4 5882.9 5894.8 5633.2 5658.7 5663.5 5741.0 5760.5 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#1] ext.html Cycles:180 Average:59736.26 Median:20555.72 stddev:117222.74 (570.3%) stddev-sans-first:117467.38 11:41:26 INFO - PROCESS | 25135 | Values: 561.7 595.3 620.3 653.6 661.4 33967.7 37040.3 37088.6 37090.8 37101.6 37342.8 46506.0 47313.8 47483.1 51537.2 8834.0 8950.1 8955.9 8956.8 8957.9 8477.7 8698.3 8854.2 8957.3 8961.5 10647.6 10901.2 10910.1 11262.3 11265.7 10737.5 10800.4 10806.4 10812.0 10812.1 10552.7 10596.7 10643.5 10651.1 10665.9 44377.8 44961.0 45008.5 45090.0 45170.1 3768.6 3815.4 3843.3 3871.4 3959.4 34109.5 34140.0 34227.0 34271.0 34485.0 4204.4 4250.0 4260.2 4260.7 4376.8 357443.0 357586.0 357981.0 359030.0 359598.2 64525.4 65259.7 65287.0 65311.7 65343.7 40398.4 41181.6 41320.0 44129.0 44179.3 19632.3 19797.2 19798.5 19825.6 19833.0 15093.4 15178.8 15193.0 15198.5 15198.5 18551.0 18959.1 20829.2 21012.4 21738.0 7522.9 7657.2 7692.6 7697.6 7873.8 1013.7 1042.6 1113.2 1130.5 1134.3 32470.0 33975.7 34265.0 34432.5 34709.1 1106.7 1113.8 1167.9 1239.3 1244.4 17944.0 18176.8 18199.6 18351.9 18368.6 495368.0 546021.0 550357.0 553057.0 800493.0 65283.0 65903.7 65913.3 65983.3 66036.3 1345.2 1390.5 1414.6 1439.5 1453.5 34593.5 36162.2 36249.3 36477.6 36573.3 54298.7 54933.5 55061.4 55067.4 55067.7 307075.0 310673.0 311763.0 311981.0 312707.0 30560.7 31065.2 31442.5 32447.7 32882.7 50678.0 50842.5 50851.2 51681.7 51896.7 43238.0 44406.3 44934.8 45014.3 46158.3 44286.8 45440.0 45668.1 46198.5 46424.3 45000.5 45469.3 45660.3 46454.5 46477.0 37789.2 39654.4 39685.0 40659.0 40722.4 29656.9 29860.3 30090.4 30629.5 30717.7 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#2] jquery.html Cycles:180 Average:28349.82 Median:24049.14 stddev:77596.89 (322.7%) stddev-sans-first:77786.17 11:41:26 INFO - PROCESS | 25135 | Values: 389.0 425.9 429.6 435.7 441.3 15283.9 19039.9 20771.9 20839.8 20934.2 17412.9 18034.4 18220.8 18249.3 19667.5 5734.9 6003.9 6007.0 6010.2 6012.3 4371.7 4581.9 4623.6 6750.4 6779.6 6705.0 6709.4 6715.2 6718.1 6724.1 6441.5 6602.0 6613.8 6626.3 6640.1 5725.8 5891.8 5900.0 5909.0 5958.9 23841.0 23913.0 24041.4 24056.9 24108.5 2609.1 2680.7 2682.8 2715.6 2756.3 14098.0 14825.7 15057.1 15272.3 15437.6 1966.6 1986.8 1996.6 2037.8 2065.2 83265.2 84335.6 84734.6 85896.6 86637.6 9852.9 11014.7 11152.4 11202.7 11391.4 14295.2 14386.8 15071.7 15088.3 15121.0 8418.5 8876.4 9022.3 9090.5 9203.3 8330.3 8439.7 8470.7 8543.3 8665.0 6635.4 6789.7 6883.1 6964.5 7064.1 1976.1 2008.8 2029.6 2029.9 2030.0 1009.6 1042.1 1053.4 1101.0 1128.4 20611.5 20826.6 20971.4 21002.9 21242.8 1083.1 1084.0 1089.1 1097.5 1107.0 11107.0 11939.9 11965.0 12226.1 12239.6 462991.0 469961.0 471746.0 473134.0 481495.0 80535.0 80778.6 82320.0 83690.0 84540.0 1049.9 1071.0 1082.7 1097.1 1097.4 17458.3 17870.6 18020.4 18330.0 18408.3 27637.4 30019.4 35088.9 39523.4 40233.6 49702.3 49724.3 49894.3 50181.0 51343.7 8785.8 8912.2 9076.8 9200.9 9206.4 13605.3 13969.7 14006.8 14130.6 14343.4 11630.5 11661.2 11770.8 11817.2 12019.8 9753.6 11811.5 12094.9 12102.9 12446.8 10440.4 10883.2 11149.4 11378.5 11754.1 8931.3 8997.8 9021.9 9102.8 9369.8 11570.3 11608.3 11650.9 11676.9 11734.1 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#3] mootools.html Cycles:180 Average:5784.64 Median:2642.28 stddev:3179.11 (120.3%) stddev-sans-first:3170.52 11:41:26 INFO - PROCESS | 25135 | Values: 1346.5 1489.1 1496.5 1676.2 1821.7 7355.3 8295.3 8553.0 8617.6 8813.0 8591.5 8667.7 8668.1 8670.4 8681.2 2484.0 2503.0 2505.7 2506.0 2510.9 2465.5 2528.1 2529.8 2531.1 2535.6 2442.5 2445.8 2466.3 2490.1 2490.4 2391.8 2419.5 2447.2 2459.5 2467.1 2443.3 2463.4 2484.7 2489.6 2489.7 8349.1 8532.7 8587.7 8595.4 8721.9 5267.6 5509.8 5523.7 5530.7 5538.9 3535.1 3558.4 3642.2 3674.0 3720.4 1235.2 1237.2 1279.3 1294.8 1311.6 12006.8 12091.9 12162.2 12164.1 12172.2 4698.6 4719.1 4762.1 4801.3 4897.0 9374.2 9404.4 9407.2 9410.6 9511.0 5417.3 5508.4 5517.0 5518.0 5518.8 4238.3 4453.3 4543.2 5040.4 5171.9 3957.3 3989.3 4079.2 4093.7 4096.4 1273.5 1306.6 1306.8 1310.2 1323.5 1027.6 1028.1 1054.2 1063.5 1064.4 5971.5 6059.3 6085.6 6086.9 6398.9 476.9 483.3 493.9 495.9 499.3 4209.1 4237.7 4262.0 4326.0 4350.2 10691.6 10841.6 10941.1 10957.7 10973.7 10289.7 10687.3 10691.4 10880.5 11032.6 8285.4 8472.7 8517.8 8519.3 8519.8 6022.0 6036.7 6111.1 6167.1 6308.7 10003.0 10063.8 10166.8 10191.8 10199.1 8339.5 8575.5 10070.6 10097.9 10258.8 7069.4 7243.9 7244.2 7553.5 7733.5 8474.7 8541.8 8621.8 8636.0 8652.9 7447.5 7488.3 7547.9 7555.7 7660.3 7406.3 7471.0 7590.5 7599.1 7611.8 7126.8 7168.9 7170.1 7170.2 7204.7 5216.7 5297.8 5303.4 5443.1 5546.8 5129.8 5168.1 5275.8 5319.4 5328.2 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#4] prototype.html Cycles:180 Average:4679.17 Median:5267.13 stddev:1330.40 (25.3%) stddev-sans-first:1293.82 11:41:26 INFO - PROCESS | 25135 | Values: 348.8 348.9 352.7 362.2 364.6 5269.7 5343.5 5343.9 5390.2 5396.9 5256.3 5261.2 5263.8 5267.8 5278.4 3969.8 4242.7 4261.4 4300.4 4327.2 3752.4 4128.8 4196.4 4215.4 4223.5 4172.4 4180.5 4187.2 4205.7 4206.4 4181.6 4203.8 4237.6 4238.1 4241.1 3613.8 3652.2 3717.4 3782.6 3793.4 5140.0 5151.1 5154.0 5164.8 5172.7 4797.4 4808.6 4813.2 4860.0 4883.5 5324.3 5475.5 5503.6 5506.1 5526.0 4156.9 4160.3 4202.7 4203.3 4209.2 5525.4 5560.7 5684.3 5802.5 5806.4 4236.5 4245.2 4246.5 4258.4 4296.1 4328.5 4336.3 4337.3 4343.1 4352.2 4722.2 4778.1 4812.3 4849.4 4871.6 5527.3 5532.6 5555.1 5556.7 5604.7 1445.5 1459.6 1463.9 1474.1 1478.4 987.7 1023.4 1028.7 1042.6 1057.8 5247.3 5256.8 5266.4 5270.5 5278.6 5459.3 5497.0 5514.2 5531.5 5555.7 4942.7 5173.2 5229.6 5231.8 5277.8 2924.4 2925.1 2932.4 2936.7 2941.9 5761.5 5774.9 5782.8 5790.9 5799.9 5381.4 5558.8 5590.0 5610.9 5617.4 5696.3 5712.4 5725.0 5751.8 5840.4 5257.9 5489.6 5522.2 5542.7 5570.6 5335.5 5371.6 5395.7 5409.4 5431.0 5627.0 5778.7 5793.0 5869.1 5926.3 4158.5 4162.5 4183.7 4210.5 4213.6 5599.4 5688.6 5753.2 5770.5 5784.4 5540.7 5549.1 5549.6 5601.7 5603.7 5517.5 5544.1 5545.2 5570.8 5574.4 5256.4 5518.2 5525.7 5538.4 5561.4 5625.2 5625.9 5629.6 5644.9 5645.6 5465.3 5508.6 5516.2 5516.8 5518.4 11:41:26 INFO - PROCESS | 25135 | 11:41:26 INFO - PROCESS | 25135 | [#5] yui.html Cycles:180 Average:18647.64 Median:4953.64 stddev:25025.68 (505.2%) stddev-sans-first:25059.99 11:41:26 INFO - PROCESS | 25135 | Values: 797.4 840.3 852.8 873.6 916.5 15200.5 16279.7 16306.4 16308.8 16325.1 13888.9 13955.1 13974.7 13976.8 13983.0 709.2 729.3 829.9 838.8 856.8 857.9 859.6 860.1 860.3 860.6 755.0 911.7 911.8 912.2 913.0 773.9 859.5 877.8 890.6 892.7 653.0 653.9 654.6 654.7 655.0 12669.6 12750.4 12808.7 12819.2 12981.6 13336.1 13463.3 13607.2 13932.9 14123.4 13234.7 13322.2 13379.1 13430.1 13530.1 4185.4 4245.3 4253.4 4278.6 4308.8 62395.7 64735.7 65382.3 66174.0 67300.0 11508.9 11605.4 11616.7 11649.1 11701.4 19359.4 19799.1 19843.8 19921.9 20579.0 8090.7 8340.5 8429.4 8453.7 8470.7 4248.3 4305.8 4333.5 4391.6 4400.1 3583.8 3706.7 3711.2 3711.3 3712.4 622.2 623.1 629.5 659.5 664.9 678.8 749.6 758.5 789.4 791.4 9644.7 9747.0 9807.2 9975.3 10139.5 717.6 733.7 742.2 751.4 757.4 4651.6 4900.4 4944.9 4948.3 4959.0 80201.2 88894.6 92369.0 92992.5 96487.0 80827.6 82055.0 82876.6 83575.0 86009.0 72319.3 74087.3 74646.6 75882.9 77439.6 9444.4 9481.1 9556.3 9577.2 9620.9 48332.9 49796.8 50669.7 51394.2 51698.2 65186.3 66671.7 67042.0 67783.3 69616.0 10782.3 10919.9 11058.9 11229.6 11330.0 12707.8 12931.2 13359.3 13377.3 13485.3 11934.7 12326.6 13424.7 13474.7 13640.2 13610.0 13644.3 13692.6 13866.0 14158.9 13297.2 13348.9 13388.3 13506.9 13684.6 10561.3 10715.8 10862.8 11004.2 11609.9 11262.6 11271.5 11583.1 11844.0 11925.0 11:41:26 INFO - PROCESS | 25135 | -------- Summary: end -------- 11:41:26 INFO - PROCESS | 25135 | 11:41:27 INFO - TEST-INFO | 25135: exit 0 11:41:27 INFO - TEST-OK | dromaeo_css | took 1115410ms 11:41:27 INFO - TEST-START | kraken 11:41:27 INFO - operating with platform_type : linux_ 11:41:27 INFO - Initialising browser for kraken test... 11:41:27 INFO - TEST-INFO | started process 25454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1ug7S/profile http://localhost:45302/getInfo.html) 11:41:31 INFO - PROCESS | 25454 | __metrics Screen width/height:1600/1200 11:41:31 INFO - PROCESS | 25454 | colorDepth:24 11:41:31 INFO - PROCESS | 25454 | Browser inner width/height: 1024/697 11:41:31 INFO - PROCESS | 25454 | __metrics 11:41:31 INFO - PROCESS | 25454 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:41:31 INFO - PROCESS | 25454 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:32 INFO - PROCESS | 25454 | console.error: PushService: 11:41:32 INFO - PROCESS | 25454 | stateChangeProcessEnqueue: Error transitioning state 11:41:32 INFO - PROCESS | 25454 | UnknownError 11:41:32 INFO - TEST-INFO | 25454: exit 0 11:41:32 INFO - Browser initialized. 11:41:32 INFO - Running cycle 1/1 for kraken test... 11:41:32 INFO - TEST-INFO | started process 25544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1ug7S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:44 INFO - PROCESS | 25544 | RSS: Main: 148414464 11:41:44 INFO - PROCESS | 25544 | 11:41:47 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:48 INFO - PROCESS | 25544 | RSS: Main: 188768256 11:41:48 INFO - PROCESS | 25544 | 11:41:50 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-dft) 11:41:51 INFO - PROCESS | 25544 | RSS: Main: 178495488 11:41:51 INFO - PROCESS | 25544 | 11:41:54 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-fft) 11:41:54 INFO - PROCESS | 25544 | RSS: Main: 270602240 11:41:54 INFO - PROCESS | 25544 | 11:41:56 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-oscillator) 11:41:57 INFO - PROCESS | 25544 | RSS: Main: 176406528 11:41:57 INFO - PROCESS | 25544 | 11:41:59 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:00 INFO - PROCESS | 25544 | RSS: Main: 179306496 11:42:00 INFO - PROCESS | 25544 | 11:42:02 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:03 INFO - PROCESS | 25544 | RSS: Main: 218005504 11:42:03 INFO - PROCESS | 25544 | 11:42:06 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:07 INFO - PROCESS | 25544 | RSS: Main: 216477696 11:42:07 INFO - PROCESS | 25544 | 11:42:10 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45302/tests/kraken/driver.html?testName=json-parse-financial) 11:42:10 INFO - PROCESS | 25544 | RSS: Main: 214880256 11:42:10 INFO - PROCESS | 25544 | 11:42:12 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:12 INFO - PROCESS | 25544 | RSS: Main: 176828416 11:42:12 INFO - PROCESS | 25544 | 11:42:14 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:15 INFO - PROCESS | 25544 | RSS: Main: 183975936 11:42:15 INFO - PROCESS | 25544 | 11:42:17 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:17 INFO - PROCESS | 25544 | RSS: Main: 190504960 11:42:17 INFO - PROCESS | 25544 | 11:42:20 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:20 INFO - PROCESS | 25544 | RSS: Main: 199471104 11:42:20 INFO - PROCESS | 25544 | 11:42:23 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:24 INFO - PROCESS | 25544 | RSS: Main: 195637248 11:42:24 INFO - PROCESS | 25544 | 11:42:25 INFO - PROCESS | 25544 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45302/tests/kraken/driver.html?testName=ai-astar) 11:42:26 INFO - PROCESS | 25544 | RSS: Main: 247037952 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | __start_tp_report 11:42:26 INFO - PROCESS | 25544 | _x_x_mozilla_page_load 11:42:26 INFO - PROCESS | 25544 | _x_x_mozilla_page_load_details 11:42:26 INFO - PROCESS | 25544 | |i|pagename|runs| 11:42:26 INFO - PROCESS | 25544 | |0;ai-astar;106;110;110;111;110;109;108;110;109;108 11:42:26 INFO - PROCESS | 25544 | |1;audio-beat-detection;143;119;117;153;119;124;130;117;141;116 11:42:26 INFO - PROCESS | 25544 | |2;audio-dft;161;161;161;162;161;161;162;161;161;161 11:42:26 INFO - PROCESS | 25544 | |3;audio-fft;75;76;77;112;76;77;76;76;100;75 11:42:26 INFO - PROCESS | 25544 | |4;audio-oscillator;83;81;111;82;83;82;99;82;82;114 11:42:26 INFO - PROCESS | 25544 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;119 11:42:26 INFO - PROCESS | 25544 | |6;imaging-darkroom;146;147;146;147;148;146;146;147;146;146 11:42:26 INFO - PROCESS | 25544 | |7;imaging-desaturate;85;85;84;85;85;84;85;85;85;85 11:42:26 INFO - PROCESS | 25544 | |8;json-parse-financial;52;49;52;50;52;50;49;50;51;50 11:42:26 INFO - PROCESS | 25544 | |9;json-stringify-tinderbox;59;60;59;59;59;59;60;60;60;61 11:42:26 INFO - PROCESS | 25544 | |10;stanford-crypto-aes;75;74;75;78;83;77;74;74;74;74 11:42:26 INFO - PROCESS | 25544 | |11;stanford-crypto-ccm;122;129;132;144;125;123;121;121;167;122 11:42:26 INFO - PROCESS | 25544 | |12;stanford-crypto-pbkdf2;157;150;152;153;151;157;153;150;151;158 11:42:26 INFO - PROCESS | 25544 | |13;stanford-crypto-sha256-iterative;61;61;62;62;62;61;62;61;60;61 11:42:26 INFO - PROCESS | 25544 | __end_tp_report 11:42:26 INFO - PROCESS | 25544 | __start_cc_report 11:42:26 INFO - PROCESS | 25544 | _x_x_mozilla_cycle_collect,1636 11:42:26 INFO - PROCESS | 25544 | __end_cc_report 11:42:26 INFO - PROCESS | 25544 | __startTimestamp1483558946021__endTimestamp 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | ------- Summary: start ------- 11:42:26 INFO - PROCESS | 25544 | Number of tests: 14 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.45 (1.3%) stddev-sans-first:1.01 11:42:26 INFO - PROCESS | 25544 | Values: 106.0 110.0 110.0 111.0 110.0 109.0 108.0 110.0 109.0 108.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:127.00 stddev:13.28 (10.5%) stddev-sans-first:12.91 11:42:26 INFO - PROCESS | 25544 | Values: 143.0 119.0 117.0 153.0 119.0 124.0 130.0 117.0 141.0 116.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:42:26 INFO - PROCESS | 25544 | Values: 161.0 161.0 161.0 162.0 161.0 161.0 162.0 161.0 161.0 161.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.98 (17.1%) stddev-sans-first:13.52 11:42:26 INFO - PROCESS | 25544 | Values: 75.0 76.0 77.0 112.0 76.0 77.0 76.0 76.0 100.0 75.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.05 (15.9%) stddev-sans-first:13.60 11:42:26 INFO - PROCESS | 25544 | Values: 83.0 81.0 111.0 82.0 83.0 82.0 99.0 82.0 82.0 114.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:42:26 INFO - PROCESS | 25544 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 11:42:26 INFO - PROCESS | 25544 | Values: 146.0 147.0 146.0 147.0 148.0 146.0 146.0 147.0 146.0 146.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 11:42:26 INFO - PROCESS | 25544 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:1.18 (2.3%) stddev-sans-first:1.12 11:42:26 INFO - PROCESS | 25544 | Values: 52.0 49.0 52.0 50.0 52.0 50.0 49.0 50.0 51.0 50.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 11:42:26 INFO - PROCESS | 25544 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 60.0 60.0 60.0 61.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:2.90 (3.9%) stddev-sans-first:3.06 11:42:26 INFO - PROCESS | 25544 | Values: 75.0 74.0 75.0 78.0 83.0 77.0 74.0 74.0 74.0 74.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:127.00 stddev:14.65 (11.5%) stddev-sans-first:15.20 11:42:26 INFO - PROCESS | 25544 | Values: 122.0 129.0 132.0 144.0 125.0 123.0 121.0 121.0 167.0 122.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:153.00 stddev:3.05 (2.0%) stddev-sans-first:2.91 11:42:26 INFO - PROCESS | 25544 | Values: 157.0 150.0 152.0 153.0 151.0 157.0 153.0 150.0 151.0 158.0 11:42:26 INFO - PROCESS | 25544 | 11:42:26 INFO - PROCESS | 25544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:42:26 INFO - PROCESS | 25544 | Values: 61.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 60.0 61.0 11:42:26 INFO - PROCESS | 25544 | -------- Summary: end -------- 11:42:26 INFO - PROCESS | 25544 | 11:42:27 INFO - TEST-INFO | 25544: exit 0 11:42:27 INFO - TEST-OK | kraken | took 59950ms 11:42:27 INFO - SUITE-END | took 1175s 11:42:27 INFO - Completed test suite (00:19:35) 11:42:27 INFO - javascript benchmark 11:42:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.5679233303504, 3238.125706059365, 3247.3342964692242, 3268.2483028903366, 3293.9505907411394, 5460.78156873725, 5576.944230557693, 5577.498025177733, 5593.636413633111, 5595.49640532352, 5496.4503549645015, 5525.309336332958, 5526.889462210754, 5530.419305972875, 5556.416576259495, 4980.950190498094, 4995.100881841267, 5024.371953505812, 5067.518585734368, 5072.898542029157, 4997.075541024904, 5002.799888004475, 5046.848594542152, 5094.388673359202, 5102.413222479426, 5037.848864534069, 5083.949160508403, 5095.0319439306595, 5097.7960881564695, 5104.310918026056, 5028.723420211887, 5034.0686972910125, 5071.797128114889, 5081.364829396325, 5092.872678183038, 5019.52314530119, 5042.445331013586, 5048.015636950796, 5083.974580127113, 5139.126348520723, 5548.0, 5570.359408667974, 5640.915386269209, 5643.5767317451355, 5656.462636049569, 5771.220885180531, 5818.2436283282905, 5822.330432000332, 5860.355360910296, 5898.705064746746, 5951.345352011275, 5953.493953013999, 5962.403759624046, 6083.665398403086, 6088.056351265561, 5662.09406494963, 5669.518090962232, 5672.943270567324, 5674.290713660793, 5678.744456499468, 5840.2991641003355, 5872.0, 5922.407759224043, 5924.822255332347, 5981.521478281814, 5763.942360576424, 5791.276090488689, 5794.82615521535, 5795.82612521625, 5799.88400231993, 5839.124131380242, 5845.064789633639, 5849.239598852122, 5858.033424484997, 5864.706764661835, 5740.196372507852, 5740.454656807597, 5786.1610066540115, 5796.217510636095, 5801.796937107181, 5918.408159184047, 5921.73352199152, 5922.466977972003, 5930.970345148333, 5947.881042379128, 4593.035462552902, 4597.885052873705, 4602.424696912886, 4609.723416594948, 4609.861704148881, 4014.8594799182474, 4047.514298284225, 4055.1889622075705, 4101.651359634465, 4144.958550414518, 5583.944160558342, 5648.0, 5677.233573467529, 5683.54531637468, 5737.053386191315, 5997.7001149942325, 6007.399260074045, 6010.789622363196, 6013.458788709037, 6015.849603759941, 5401.675899446046, 5452.727363631802, 5637.802676906289, 5648.858778530487, 5661.7735290588735, 5004.674696144739, 5062.265971434195, 5072.6195535335, 5092.490750924952, 5149.407818100966, 6131.509479241561, 6168.722407491674, 6169.2288463942, 6173.99999999991, 6182.752689892354, 5829.912551311819, 5925.05199168131, 5927.881442371042, 5939.67331796738, 5946.554008449297, 5968.940310596839, 6021.969890150521, 6101.725422356093, 6130.417610327012, 6155.199824022849, 5908.7045647718305, 5913.497352724895, 5914.172015917861, 5932.762689492544, 5947.524198064058, 5971.492423143907, 5975.521958243417, 5979.910301345396, 5981.0729336952845, 5991.0, 5654.491095801233, 5690.687012214368, 5766.711664416846, 5861.706914654165, 5907.852303692442, 5724.0555308375315, 5832.24180856486, 5848.298204215351, 5850.23946886902, 5853.0, 5776.971115144397, 5793.188953546591, 5815.2149459822385, 5815.447532484407, 5816.9127463088935, 5696.515796157373, 5707.286589176353, 5840.415958404125, 5882.94117058841, 5894.823155305347, 5633.239512665901, 5658.717064146694, 5663.490285874291, 5741.0, 5760.452756988079], "value": 5473.2548572236865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6658088437379, 595.2648479128277, 620.348633934369, 653.5523166630858, 661.4278648968643, 33967.66032339679, 37040.259194816084, 37088.62911370882, 37090.814545927264, 37101.62898371016, 37342.813285933604, 46506.0, 47313.76343118288, 47483.050338993286, 51537.226941595814, 8833.999999999984, 8950.14973577509, 8955.865662015074, 8956.820863582725, 8957.865632015493, 8477.703280385187, 8698.304135669132, 8854.247388971913, 8957.328200384965, 8961.462312261285, 10647.57409703611, 10901.182411319143, 10910.072643825284, 11262.324260544352, 11265.718357041098, 10737.51681174349, 10800.405977671226, 10806.35161890289, 10812.0, 10812.135029197685, 10552.683419497427, 10596.682099536949, 10643.521041553071, 10651.094656954168, 10665.9466702666, 44377.77811110956, 44961.0, 45008.54991450109, 45090.0, 45170.09659806785, 3768.623137686237, 3815.351390263662, 3843.3082045231845, 3871.361225397806, 3959.4060890866313, 34109.48835767466, 34140.0, 34227.0, 34271.0, 34485.0, 4204.432401625802, 4249.978750106261, 4260.211860805761, 4260.659147268211, 4376.759278239696, 357443.0, 357586.0, 357981.0, 359030.0, 359598.2020089909, 64525.354746452875, 65259.67370163119, 65287.0, 65311.67344163249, 65343.67328163424, 40398.39402408966, 41181.58818411837, 41320.0, 44129.0, 44179.337309940376, 19632.3128690498, 19797.208111675372, 19798.50503737418, 19825.603487930162, 19833.0, 15093.39626414953, 15178.848211517743, 15193.0, 15198.46805361807, 15198.468053618291, 18551.0, 18959.052047397574, 20829.1668333268, 21012.369628911158, 21738.0, 7522.887156692654, 7657.1959944205055, 7692.615369231516, 7697.576633285223, 7873.803154921058, 1013.7009582173276, 1042.5829668132808, 1113.1929351220463, 1130.5308297056795, 1134.28540019787, 32470.0, 33975.66024339725, 34265.0, 34432.48351274733, 34709.13227169341, 1106.7454485468227, 1113.8050841102774, 1167.8948894599528, 1239.305988646361, 1244.4089057697522, 17944.0, 18176.818231817513, 18199.63600727978, 18351.908240458713, 18368.63262734738, 495368.0, 546021.0, 550357.0, 553057.0, 800493.0, 65283.0, 65903.67048164824, 65913.34086659168, 65983.34016659867, 66036.33963660398, 1345.2399394342165, 1390.4924702483722, 1414.5968399006233, 1439.5321520505877, 1453.4694836384856, 34593.48109778405, 36162.19280535571, 36249.27501450009, 36477.63522364743, 36573.26853462969, 54298.72850635721, 54933.450665492834, 55061.449385505635, 55067.44932550623, 55067.72466137644, 307075.0, 310673.0, 311763.0, 311981.0, 312707.0, 30560.694393056674, 31065.223369415944, 31442.528362075045, 32447.702091917003, 32882.671173288916, 50678.0, 50842.491575083775, 50851.23723144082, 51681.7415912918, 51896.74051629869, 43238.0, 44406.3339049908, 44934.77532612316, 45014.324785127596, 46158.30762538497, 44286.778566106965, 45440.0, 45668.10376904481, 46198.53801462077, 46424.30363544482, 45000.54999450094, 45469.31796023128, 45660.315095272934, 46454.53545464637, 46477.0, 37789.244215114995, 39654.405183921685, 39685.0, 40659.0, 40722.389164163156, 29656.851715741283, 29860.253493662833, 30090.398192036475, 30629.540556891217, 30717.69282307238], "value": 21218.92504862965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.95527014393355, 425.8523040623817, 429.55970130616106, 435.71896126998087, 441.31816343748886, 15283.923580382096, 19039.855252562418, 20771.896140519275, 20839.791602083973, 20934.16263349464, 17412.912935435306, 18034.368797092106, 18220.81779182208, 18249.270029198848, 19667.5083122922, 5734.853029394117, 6003.879922401549, 6006.969965150168, 6010.1585777990895, 6012.278526576795, 4371.73769573825, 4581.9337841056595, 4623.606993405565, 6750.426213771835, 6779.62712050837, 6704.966475167617, 6709.396154346108, 6715.227748808877, 6718.05947167397, 6724.058631791553, 6441.516886233528, 6601.966990165042, 6613.834654133685, 6626.337366263335, 6640.1035860158745, 5725.799597014126, 5891.823245302605, 5899.997000509924, 5908.97045514774, 5958.940410595882, 23841.0, 23913.0, 24041.39896502584, 24056.87971560131, 24108.517829643308, 2609.086819613139, 2680.6917204521533, 2682.785377169822, 2715.579085241791, 2756.3109222694325, 14098.0, 14825.70348593022, 15057.096574205583, 15272.31274592646, 15437.614059648598, 1966.5771859050374, 1986.8311193548566, 1996.610660921121, 2037.7962203779653, 2065.2461851424273, 83265.16734832696, 84335.57832210862, 84734.57632711859, 85896.57051714702, 86637.56681216617, 9852.901470985198, 11014.669559913216, 11152.386618736047, 11202.719932001764, 11391.430428478543, 14295.213763243122, 14386.784198237036, 15071.698566028617, 15088.321025553876, 15121.0, 8418.452800567944, 8876.423032502867, 9022.278217742565, 9090.500022498825, 9203.309751768644, 8330.333573314121, 8439.662413503514, 8470.661173553111, 8543.273821725099, 8664.956675216583, 6635.4359879410795, 6789.728410863609, 6883.139607549057, 6964.512484126062, 7064.116985376828, 1976.1107501624326, 2008.7728043066668, 2029.5737895041912, 2029.857909946319, 2029.9797002030086, 1009.5557954499997, 1042.1298215989734, 1053.3890343600692, 1100.959593184433, 1128.3906690387264, 20611.484712881997, 20826.583468330547, 20971.37085887426, 21002.894985524974, 21242.78757212408, 1083.1334932054326, 1083.983740243897, 1089.1178145702006, 1097.5006372100675, 1107.0460636975745, 11107.0, 11939.88060119405, 11965.0, 12226.083043771574, 12239.632811015685, 462991.0, 469961.0, 471746.0, 473134.0, 481495.0, 80535.0, 80778.59610701908, 82320.0, 83690.0, 84540.0, 1049.92125590581, 1070.9946450267698, 1082.734729991157, 1097.0510508410327, 1097.4074000040048, 17458.30166793314, 17870.5532361692, 18020.36928707489, 18329.98370179306, 18408.26366945361, 27637.447251054466, 30019.399612008074, 35088.94733158009, 39523.40714889221, 40233.597664022986, 49702.25446618231, 49724.25413618871, 49894.25158622551, 50181.0, 51343.74328128336, 8785.780355490908, 8912.153345432174, 9076.820013398215, 9200.861987070066, 9206.355555111346, 13605.251711155586, 13969.720605587629, 14006.789898151332, 14130.576082717535, 14343.354549045527, 11630.476628551567, 11661.24201926872, 11770.823437648613, 11817.172797904064, 12019.75960480768, 9753.561089750836, 11811.468483918072, 12094.879051209375, 12102.939485302517, 12446.813297800722, 10440.373577585066, 10883.183761218099, 11149.442527873736, 11378.487968041292, 11754.11844111678, 8931.330150238628, 8997.775055623662, 9021.858005363501, 9102.817943641223, 9369.765755856159, 11570.305781653127, 11608.30350178992, 11650.88349116532, 11676.88323116792, 11734.119941004288], "value": 9647.355323101297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.5017943360958, 1489.1363009454517, 1496.4537943650564, 1676.1870492810986, 1821.6538857617052, 7355.3380195782365, 8295.253427191552, 8552.999999999984, 8617.612207450657, 8813.0, 8591.527465989368, 8667.69663061793, 8668.089850565695, 8670.43642163259, 8681.175288347613, 2483.962740558893, 2503.0113105323385, 2505.711843138035, 2506.0351764570682, 2510.924672259835, 2465.506898620274, 2528.1404322530334, 2529.8482091074593, 2531.0761572026263, 2535.6069809179608, 2442.535918175541, 2445.7798798108165, 2466.3094333586623, 2490.0786708917726, 2490.414752533153, 2391.796697280733, 2419.516096780651, 2447.229122826313, 2459.5203935232457, 2467.0501856785086, 2443.315871555967, 2463.3718401807605, 2484.6831179474907, 2489.5892177790643, 2489.73857744936, 8349.123342049119, 8532.744017679417, 8587.742367728915, 8595.398322117455, 8721.912780872173, 5267.604929630254, 5509.807156749534, 5523.7238138092935, 5530.668159910419, 5538.889222215533, 3535.1338921964284, 3558.395072837624, 3642.1805093853936, 3673.963260367389, 3720.441933709938, 1235.1600911380258, 1237.22055105284, 1279.2899940533, 1294.7928331467015, 1311.63929919272, 12006.759864802742, 12091.879081209252, 12162.209456385306, 12164.148509604243, 12172.208806427643, 4698.562014649349, 4719.079779442975, 4762.071396077801, 4801.279808028824, 4897.0, 9374.203192728559, 9404.38871473352, 9407.153356197838, 9410.623575057058, 9511.048895110434, 5417.322834645669, 5508.394076651565, 5516.972415137899, 5518.034343989866, 5518.806841760519, 4238.258304796648, 4453.3320001999955, 4543.204939135704, 5040.36995375578, 5171.922421163686, 3957.3074711925296, 3989.301872172416, 4079.184163167319, 4093.6520395766097, 4096.40602112692, 1273.452415461342, 1306.6210798868221, 1306.777847765863, 1310.2269660900115, 1323.5499930023839, 1027.5581499954942, 1028.1106842581114, 1054.2409465185056, 1063.5107850388754, 1064.4039337970762, 5971.5222782177325, 6059.303180134253, 6085.6348619083, 6086.9391306087255, 6398.8720225595225, 476.8783960090155, 483.2750873689466, 493.86171871875933, 495.88594623236133, 499.3159371660848, 4209.137126888981, 4237.660987121023, 4262.0, 4326.048269380732, 4350.216960946997, 10691.572337106429, 10841.620543280947, 10941.070009049161, 10957.671269861918, 10973.670789876316, 10289.691309260734, 10687.251892367614, 10691.358518488916, 10880.510377033053, 11032.558697652164, 8285.42002059862, 8472.745817625604, 8517.829643407098, 8519.275861551838, 8519.829603407898, 6022.0, 6036.709993053709, 6111.083337499411, 6167.1366008759705, 6308.71610777507, 10002.999700029939, 10063.798724025331, 10166.8474972874, 10191.796164076528, 10199.133073688523, 8339.54132522717, 8575.528345941033, 10070.647527336509, 10097.89902100999, 10258.846117308098, 7069.434445244471, 7243.891341629775, 7244.239354867663, 7553.471257011956, 7733.458657893893, 8474.66101355939, 8541.829163416573, 8621.784455388415, 8636.006859211271, 8652.913470865211, 7447.478676492594, 7488.326050655467, 7547.886781698169, 7555.73554925575, 7660.310572048543, 7406.296401842032, 7470.962645186957, 7590.506617069873, 7599.088109426904, 7611.809704757426, 7126.786196414116, 7168.85298352282, 7170.103737032871, 7170.211276759656, 7204.71181152769, 5216.66091704038, 5297.8145764898045, 5303.36359636846, 5443.129099344086, 5546.805861794818, 5129.846104616868, 5168.095583272988, 5275.788968441219, 5319.4414586467865, 5328.200769884548], "value": 4636.139169543723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7802684308885, 348.92846966371894, 352.73368606701933, 362.195925046397, 364.6499360613811, 5269.683818970864, 5343.519083282504, 5343.866403339918, 5390.218418329345, 5396.865078373043, 5256.2917051958075, 5261.210818377236, 5263.763015691309, 5267.815626453065, 5278.419373868871, 3969.7816620085882, 4242.693665929084, 4261.4460120184485, 4300.39794428781, 4327.221100201962, 3752.418375151856, 4128.8348466061325, 4196.412502249687, 4215.409842622035, 4223.472065991751, 4172.395002724603, 4180.47744031996, 4187.225363307783, 4205.684573656973, 4206.432131662233, 4181.560936101696, 4203.789810509493, 4237.618614324726, 4238.109996900655, 4241.0881660443, 3613.8012409317475, 3652.1600031992525, 3717.442383642448, 3782.6217378261954, 3793.3930571108767, 5140.0, 5151.124308867464, 5153.9742301288625, 5164.786275225319, 5172.715500647463, 4797.40032495938, 4808.639352048575, 4813.181759100926, 4860.0, 4883.4628190898975, 5324.334458192726, 5475.479829416239, 5503.559715222773, 5506.109292621366, 5525.972370138164, 4156.896077598054, 4160.292750232467, 4202.684798640114, 4203.327467605169, 4209.2423363794505, 5525.419830917736, 5560.694161821058, 5684.289463817023, 5802.506786923117, 5806.361300256968, 4236.5128010278595, 4245.150969806051, 4246.532881383046, 4258.446401967786, 4296.119295544406, 4328.523862375137, 4336.3278691802825, 4337.284348082594, 4343.066240758252, 4352.1513304905875, 4722.150012997693, 4778.12657826721, 4812.278158276286, 4849.442314133919, 4871.585915197248, 5527.281453411031, 5532.612717109763, 5555.111182210827, 5556.749946252347, 5604.719764011783, 1445.5302026841318, 1459.5694270190106, 1463.8609332113433, 1474.1376294867407, 1478.3643033495484, 987.7382493639192, 1023.357511194537, 1028.711960651019, 1042.5569133118395, 1057.7620035491952, 5247.347085668002, 5256.789728410898, 5266.447023062523, 5270.49930256625, 5278.5513231375, 5459.2902922619805, 5496.972515137399, 5514.172874068921, 5531.502164805187, 5555.749991250404, 4942.728149951788, 5173.198154286091, 5229.581633469314, 5231.8168864089575, 5277.7805538621415, 2924.400497897926, 2925.063979526531, 2932.3695405487924, 2936.7063293670462, 2941.8970336038137, 5761.481466667936, 5774.913376299359, 5782.797602083907, 5790.88418231633, 5799.926039199231, 5381.354237491526, 5558.805441809517, 5589.972050139723, 5610.915836262459, 5617.38208797032, 5696.3449203341315, 5712.428757124254, 5725.0, 5751.827445176567, 5840.445157710011, 5257.947420525746, 5489.560835133259, 5522.22688823573, 5542.674395362911, 5570.582206334622, 5335.519803217729, 5371.62398632092, 5395.676259424447, 5409.404965453876, 5430.972845135749, 5627.0434026214825, 5778.682172480554, 5792.9710351447975, 5869.06095024794, 5926.348101708722, 4158.521769996489, 4162.4796900387455, 4183.707140500136, 4210.473690788652, 4213.557576454428, 5599.356074051536, 5688.601797874109, 5753.238445546245, 5770.451807078321, 5784.363719990882, 5540.667559946416, 5549.139883318092, 5549.556035517229, 5601.719914004202, 5603.663780173202, 5517.475839795213, 5544.140658197985, 5545.1682247663175, 5570.832875013756, 5574.386817449996, 5256.39551451588, 5518.19986102021, 5525.668459892419, 5538.446155384429, 5561.416051314553, 5625.184348269559, 5625.8593535161945, 5629.577781666473, 5644.915326270027, 5645.633033852787, 5465.316835395575, 5508.641938274, 5516.227728117987, 5516.779328826802, 5518.42056584069], "value": 4265.874738691554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.3780451248025, 840.3403328387217, 852.8379607874504, 873.5894129759012, 916.5371487398864, 15200.467983620576, 16279.674406511862, 16306.429274975364, 16308.83691163088, 16325.102119383444, 13888.930555347235, 13955.092918960261, 13974.720505589881, 13976.790348144761, 13983.0, 709.1596458197052, 729.2780147653838, 829.8796674482227, 838.7861095420675, 856.7815207122175, 857.8584533551956, 859.6346552715103, 860.0797147052656, 860.2515811244226, 860.6084231674604, 754.9886751698729, 911.6672414568701, 911.8313112074254, 912.2473958983832, 912.9543522823866, 773.9071311442607, 859.5272600069968, 877.7937184761576, 890.5636238243214, 892.7366426904014, 652.9902051469231, 653.947684185264, 654.6268626882679, 654.7413771560255, 655.0240142188153, 12669.619911402673, 12750.362481875869, 12808.679783005406, 12819.16675416095, 12981.610551683465, 13336.133151345131, 13463.259520726357, 13607.183568985893, 13932.860671393257, 14123.364448599736, 13234.669133271746, 13322.200667959953, 13379.130356526892, 13430.127041742353, 13530.120542164728, 4185.393117997904, 4245.320748680197, 4253.447051883266, 4278.593533614302, 4308.849190278356, 62395.688021560054, 64735.67632161809, 65382.34617653858, 66174.0, 67300.0, 11508.884911150948, 11605.419729013516, 11616.651500455, 11649.12631552637, 11701.414929253504, 19359.4192174235, 19799.10904009323, 19843.801561984194, 19921.900390497955, 20579.0, 8090.676372945134, 8340.457870238415, 8429.367797415218, 8453.661853525913, 8470.703525376583, 4248.299030659907, 4305.784710764449, 4333.544977777288, 4391.604755572014, 4400.075984043323, 3583.8028908409765, 3706.6664000240107, 3711.183539621279, 3711.257748450321, 3712.3688972874675, 622.1662971618053, 623.1307326279814, 629.515273239612, 659.4592434203906, 664.9434798042221, 678.772611175252, 749.5577609210483, 758.5069704691995, 789.423720683904, 791.4183075439547, 9644.662436814679, 9746.976567460457, 9807.166390856715, 9975.25185611082, 10139.543720532594, 717.6474681059462, 733.7285204474379, 742.224375527575, 751.372603875759, 757.4130049211794, 4651.646962599436, 4900.387451568554, 4944.9258261126115, 4948.331975183376, 4958.9504104959215, 80201.19798802055, 88894.55552722195, 92369.0, 92992.53503732439, 96487.0, 80827.59586202032, 82055.0, 82876.58561707153, 83575.0, 86009.0, 72319.29924554887, 74087.25912740911, 74646.62676686581, 75882.86175707368, 77439.61280193563, 9444.386114902509, 9481.146696797321, 9556.331056825955, 9577.23382129442, 9620.855687164558, 48332.886119475166, 49796.751016244685, 50669.746651266505, 51394.229086562984, 51698.22452663288, 65186.348136519926, 66671.66664166648, 67042.0, 67783.3221667777, 69615.95576066464, 10782.299150555189, 10919.890801091888, 11058.889411106107, 11229.55081796719, 11330.036946859609, 12707.809382859079, 12931.224126552437, 13359.26524041187, 13377.264250466318, 13485.258310793, 11934.701632459259, 12326.568570100004, 13424.664383390103, 13474.730505389642, 13640.249786261851, 13610.0, 13644.317784110954, 13692.589222322948, 13866.0, 14158.929205353907, 13297.202167869958, 13348.866511334762, 13388.330583470593, 13506.864931350561, 13684.589462316146, 10561.260711750103, 10715.839262410915, 10862.837057443987, 11004.174686898676, 11609.941950290195, 11262.605808796652, 11271.549138034714, 11583.131265155316, 11844.0, 11925.0], "value": 7384.516781747125, "unit": "score"}], "name": "dromaeo_css", "value": 7395.799441972304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 110.0, 111.0, 110.0, 109.0, 108.0, 110.0, 109.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 117.0, 153.0, 119.0, 124.0, 130.0, 117.0, 141.0, 116.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 112.0, 76.0, 77.0, 76.0, 76.0, 100.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 111.0, 82.0, 83.0, 82.0, 99.0, 82.0, 82.0, 114.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 52.0, 50.0, 52.0, 50.0, 49.0, 50.0, 51.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 78.0, 83.0, 77.0, 74.0, 74.0, 74.0, 74.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 129.0, 132.0, 144.0, 125.0, 123.0, 121.0, 121.0, 167.0, 122.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 150.0, 152.0, 153.0, 151.0, 157.0, 153.0, 150.0, 151.0, 158.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1449.7999999999997, "alertThreshold": 2.0}]} 11:42:27 INFO - Return code: 0 11:42:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:27 INFO - # TBPL SUCCESS # 11:42:27 INFO - Running post-action listener: _resource_record_post_action 11:42:27 INFO - [mozharness: 2017-01-04 19:42:27.853416Z] Finished run-tests step (success) 11:42:27 INFO - Running post-run listener: _resource_record_post_run 11:42:27 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 367173632; Read time: 236; Write time: 248548 11:42:27 INFO - TinderboxPrint: CPU usage
13.0% 11:42:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 236 11:42:27 INFO - TinderboxPrint: I/O write bytes / time
367,173,632 / 248,548 11:42:27 INFO - TinderboxPrint: CPU idle
8,278.1 (87.0%) 11:42:27 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 11:42:27 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118775808; Read time: 0; Write time: 75476 11:42:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248397824; Read time: 224; Write time: 173072 11:42:28 INFO - Running post-run listener: _upload_blobber_files 11:42:28 INFO - Blob upload gear active. 11:42:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:42:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:29 INFO - (blobuploader) - INFO - Done attempting. 11:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:30 INFO - (blobuploader) - INFO - Done attempting. 11:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:33 INFO - (blobuploader) - INFO - Done attempting. 11:42:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:33 INFO - Return code: 0 11:42:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02523a4528a4fbba41267f9fb791e1e700b7f90f3a4f6c795450f3965e2a0cd50656b15ee63aaf19ce8840d04df7995ce0ba2d81e0b5293b7770e062a1840c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd40c396a118c9f3ce51cbc900ce2285f565d23a98ec6b9350e45ac746af4009db409eefdefad0fbe6719cc1b498de53232de916eb3236fe1712df11a344107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb3368dcef88e47b8bb861fe0f914a76c7f88906ff0d2bb3fbe481d8c9e653f4d1e74772c7d829d19e467545d036948d75d2e941011671c5e20241461c9aa37"} 11:42:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:33 INFO - Contents: 11:42:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02523a4528a4fbba41267f9fb791e1e700b7f90f3a4f6c795450f3965e2a0cd50656b15ee63aaf19ce8840d04df7995ce0ba2d81e0b5293b7770e062a1840c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd40c396a118c9f3ce51cbc900ce2285f565d23a98ec6b9350e45ac746af4009db409eefdefad0fbe6719cc1b498de53232de916eb3236fe1712df11a344107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb3368dcef88e47b8bb861fe0f914a76c7f88906ff0d2bb3fbe481d8c9e653f4d1e74772c7d829d19e467545d036948d75d2e941011671c5e20241461c9aa37"} 11:42:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:33 INFO - Copying logs to upload dir... 11:42:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.235363 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-04 11:42:33.047723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 11:42:33.051504) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02523a4528a4fbba41267f9fb791e1e700b7f90f3a4f6c795450f3965e2a0cd50656b15ee63aaf19ce8840d04df7995ce0ba2d81e0b5293b7770e062a1840c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd40c396a118c9f3ce51cbc900ce2285f565d23a98ec6b9350e45ac746af4009db409eefdefad0fbe6719cc1b498de53232de916eb3236fe1712df11a344107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb3368dcef88e47b8bb861fe0f914a76c7f88906ff0d2bb3fbe481d8c9e653f4d1e74772c7d829d19e467545d036948d75d2e941011671c5e20241461c9aa37"} build_url:https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/e1SbJ1CGRFCz96ecaPma2A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02523a4528a4fbba41267f9fb791e1e700b7f90f3a4f6c795450f3965e2a0cd50656b15ee63aaf19ce8840d04df7995ce0ba2d81e0b5293b7770e062a1840c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cd40c396a118c9f3ce51cbc900ce2285f565d23a98ec6b9350e45ac746af4009db409eefdefad0fbe6719cc1b498de53232de916eb3236fe1712df11a344107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb3368dcef88e47b8bb861fe0f914a76c7f88906ff0d2bb3fbe481d8c9e653f4d1e74772c7d829d19e467545d036948d75d2e941011671c5e20241461c9aa37"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 11:42:33.076080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:42:33.076399) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483555771.641345-90658308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 11:42:33.157841) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 11:42:33.158163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 11:42:33.158432) ========= ========= Total master_lag: 0.19 =========