builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1484258223.55 results: success (0) buildid: 20170112121216 builduid: b746a09e422e4a7f88526c25de345da0 revision: 8d0ece73d3278ee81807f7d5dcdd402f994954dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.553736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.554304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.554648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.573140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.573446) ========= 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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 13:57:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.3M=0s 2017-01-12 13:57:03 (63.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115954 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.703709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.704033) ========= 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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015849 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.754512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:03.754886) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8d0ece73d3278ee81807f7d5dcdd402f994954dc --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 8d0ece73d3278ee81807f7d5dcdd402f994954dc --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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 13:57:03,993 truncating revision to first 12 chars 2017-01-12 13:57:03,993 Setting DEBUG logging. 2017-01-12 13:57:03,993 attempt 1/10 2017-01-12 13:57:03,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8d0ece73d327?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 13:57:04,285 unpacking tar archive at: mozilla-aurora-8d0ece73d327/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:04.375117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:04.375438) ========= script_repo_revision: 8d0ece73d3278ee81807f7d5dcdd402f994954dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:04.375920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:04.376308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 13:57:04.386851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 13:57:04.387253) ========= /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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:57:04 INFO - MultiFileLogger online at 20170112 13:57:04 in /builds/slave/test 13:57:04 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 13:57:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:57:04 INFO - {'append_to_log': False, 13:57:04 INFO - 'base_work_dir': '/builds/slave/test', 13:57:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:57:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:57:04 INFO - 'branch': 'Mozilla-Aurora', 13:57:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:57:04 INFO - 'config_files': ('talos/linux_config.py',), 13:57:04 INFO - 'default_actions': ('clobber', 13:57:04 INFO - 'read-buildbot-config', 13:57:04 INFO - 'download-and-extract', 13:57:04 INFO - 'populate-webroot', 13:57:04 INFO - 'create-virtualenv', 13:57:04 INFO - 'install', 13:57:04 INFO - 'run-tests'), 13:57:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:57:04 INFO - 'download_minidump_stackwalk': True, 13:57:04 INFO - 'download_symbols': 'ondemand', 13:57:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:57:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:57:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:57:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:57:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:57:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:57:04 INFO - 'installer_path': 'installer.exe', 13:57:04 INFO - 'log_level': 'info', 13:57:04 INFO - 'log_name': 'talos', 13:57:04 INFO - 'log_to_console': True, 13:57:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:57:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:57:04 INFO - 'opt_config_files': (), 13:57:04 INFO - 'pip_index': False, 13:57:04 INFO - 'sps_profile': False, 13:57:04 INFO - 'sps_profile_interval': 0, 13:57:04 INFO - 'suite': 'dromaeojs', 13:57:04 INFO - 'system_bits': '32', 13:57:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:57:04 INFO - 'title': 'talos-linux64-ix-023', 13:57:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:57:04 INFO - 'use_talos_json': True, 13:57:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:57:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:57:04 INFO - 'work_dir': 'build'} 13:57:04 INFO - [mozharness: 2017-01-12 21:57:04.720203Z] Running clobber step. 13:57:04 INFO - Running pre-action listener: _resource_record_pre_action 13:57:04 INFO - Running main action method: clobber 13:57:04 INFO - rmtree: /builds/slave/test/build 13:57:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:57:05 INFO - Running post-action listener: _resource_record_post_action 13:57:05 INFO - [mozharness: 2017-01-12 21:57:05.676742Z] Finished clobber step (success) 13:57:05 INFO - [mozharness: 2017-01-12 21:57:05.676845Z] Running read-buildbot-config step. 13:57:05 INFO - Running pre-action listener: _resource_record_pre_action 13:57:05 INFO - Running main action method: read_buildbot_config 13:57:05 INFO - Using buildbot properties: 13:57:05 INFO - { 13:57:05 INFO - "project": "", 13:57:05 INFO - "product": "firefox", 13:57:05 INFO - "script_repo_revision": "production", 13:57:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:57:05 INFO - "repository": "", 13:57:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:57:05 INFO - "buildid": "20170112121216", 13:57:05 INFO - "pgo_build": "True", 13:57:05 INFO - "basedir": "/builds/slave/test", 13:57:05 INFO - "buildnumber": 697, 13:57:05 INFO - "slavename": "talos-linux64-ix-023", 13:57:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:57:05 INFO - "platform": "ubuntu64_hw", 13:57:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:57:05 INFO - "branch": "mozilla-aurora", 13:57:05 INFO - "repo_path": "releases/mozilla-aurora", 13:57:05 INFO - "revision": "8d0ece73d3278ee81807f7d5dcdd402f994954dc", 13:57:05 INFO - "stage_platform": "linux64-pgo", 13:57:05 INFO - "builduid": "b746a09e422e4a7f88526c25de345da0", 13:57:05 INFO - "slavebuilddir": "test" 13:57:05 INFO - } 13:57:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 13:57:05 INFO - Running post-action listener: _resource_record_post_action 13:57:05 INFO - [mozharness: 2017-01-12 21:57:05.679299Z] Finished read-buildbot-config step (success) 13:57:05 INFO - [mozharness: 2017-01-12 21:57:05.679388Z] Running download-and-extract step. 13:57:05 INFO - Running pre-action listener: _resource_record_pre_action 13:57:05 INFO - Running main action method: download_and_extract 13:57:05 INFO - mkdir: /builds/slave/test/build/tests 13:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:05 INFO - trying https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/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 13:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/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 13:57:06 INFO - Downloaded 1361 bytes. 13:57:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:57:06 INFO - Using the following test package requirements: 13:57:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:57:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:57:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:57:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'jsshell-linux-x86_64.zip'], 13:57:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:57:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:57:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:57:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:57:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:57:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:57:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:57:06 INFO - Http code: 200 13:57:06 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:57:06 INFO - x-amz-cf-id: WcQMk2eT_SpC8juw8fg0FSsW92Zi7c7f7-KuKGFpPvSHvM2fBQKQwg== 13:57:06 INFO - x-amz-version-id: 9yiiI.0Y16hwf15niChWxaQpCLfLlBbv 13:57:07 INFO - Expected file size: 21948778 13:57:07 INFO - Obtained file size: 21948778 13:57:11 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 13:57:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:57:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:11 INFO - Fetch https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:57:11 INFO - Http code: 200 13:57:11 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 13:57:11 INFO - x-amz-cf-id: ismJqJuc6BnFVdeuhjA8joQpK96cDzuTidLvoYKNhHBNFlD6Ar6DbQ== 13:57:11 INFO - x-amz-version-id: 9yiiI.0Y16hwf15niChWxaQpCLfLlBbv 13:57:11 INFO - Expected file size: 21948778 13:57:11 INFO - Obtained file size: 21948778 13:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 13:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 13:57:16 INFO - Http code: 200 13:57:16 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 13:57:16 INFO - x-amz-cf-id: XcCVNlx8NzEyjZK5rE0kX8CrEQF3zPTAceHNxUHcPAbQgu8xAL_bDg== 13:57:16 INFO - x-amz-version-id: JfskHABdYfKjcs7reV.JxyfMY4NLhZH9 13:57:17 INFO - Expected file size: 14409038 13:57:17 INFO - Obtained file size: 14409038 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:17 INFO - trying https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:57:17 INFO - Downloading https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/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 13:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/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 13:57:18 INFO - Downloaded 64139668 bytes. 13:57:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:57:18 INFO - mkdir: /builds/slave/test/properties 13:57:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:57:18 INFO - Writing to file /builds/slave/test/properties/build_url 13:57:18 INFO - Contents: 13:57:18 INFO - build_url:https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:57:19 INFO - Running post-action listener: _resource_record_post_action 13:57:19 INFO - Running post-action listener: set_extra_try_arguments 13:57:19 INFO - [mozharness: 2017-01-12 21:57:19.174710Z] Finished download-and-extract step (success) 13:57:19 INFO - [mozharness: 2017-01-12 21:57:19.175013Z] Running populate-webroot step. 13:57:19 INFO - Running pre-action listener: _resource_record_pre_action 13:57:19 INFO - Running main action method: populate_webroot 13:57:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:19 INFO - '--tppagecycles', 13:57:19 INFO - '7'], 13:57:19 INFO - 'tests': ['tsvgm']}}, 13:57:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:57:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:57:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:57:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['damp', 'tps']}, 13:57:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'tests': ['damp', 'tps']}, 13:57:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['dromaeo_dom']}, 13:57:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['basic_compositor_video']}, 13:57:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:57:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'other-e10s': {'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['a11yr', 13:57:19 INFO - 'ts_paint', 13:57:19 INFO - 'tpaint', 13:57:19 INFO - 'sessionrestore', 13:57:19 INFO - 'sessionrestore_no_auto_restore', 13:57:19 INFO - 'tabpaint']}, 13:57:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['tsvgx', 13:57:19 INFO - 'tsvgr_opacity', 13:57:19 INFO - 'tart', 13:57:19 INFO - 'tscrollx', 13:57:19 INFO - 'cart']}, 13:57:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:57:19 INFO - 'tsvgr_opacity', 13:57:19 INFO - 'tart', 13:57:19 INFO - 'tscrollx', 13:57:19 INFO - 'cart']}, 13:57:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'talos_options': ['--disable-e10s'], 13:57:19 INFO - 'tests': ['tp5o']}, 13:57:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'tests': ['tp5o']}, 13:57:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'talos_options': ['--disable-e10s', 13:57:19 INFO - '--xperf_path', 13:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:19 INFO - 'tests': ['tp5n']}, 13:57:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:19 INFO - 'talos_options': ['--xperf_path', 13:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:19 INFO - 'tests': ['tp5n']}}, 13:57:19 INFO - 'talos.zip': {'path': '', 13:57:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:19 INFO - Running post-action listener: _resource_record_post_action 13:57:19 INFO - [mozharness: 2017-01-12 21:57:19.198319Z] Finished populate-webroot step (success) 13:57:19 INFO - [mozharness: 2017-01-12 21:57:19.198412Z] Running create-virtualenv step. 13:57:19 INFO - Running pre-action listener: _resource_record_pre_action 13:57:19 INFO - Running main action method: create_virtualenv 13:57:19 INFO - Creating virtualenv /builds/slave/test/build/venv 13:57:19 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 13:57:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:57:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:19 INFO - Using real prefix '/usr' 13:57:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:57:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:21 INFO - Installing pip.................done. 13:57:21 INFO - Return code: 0 13:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:57:21 INFO - Reading from file tmpfile_stdout 13:57:21 INFO - Output received: 13:57:21 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) 13:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57: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', 'pip>=1.5'] in /builds/slave/test/build 13:57: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 pip>=1.5 13:57:21 INFO - Using env: {'DISPLAY': ':0', 13:57:21 INFO - 'HOME': '/home/cltbld', 13:57:21 INFO - 'LANG': 'en_US.UTF-8', 13:57:21 INFO - 'LANGUAGE': 'en_US:en', 13:57:21 INFO - 'LOGNAME': 'cltbld', 13:57:21 INFO - 'MAIL': '/var/mail/cltbld', 13:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:21 INFO - 'MOZ_NO_REMOTE': '1', 13:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:21 INFO - 'NO_EM_RESTART': '1', 13:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:21 INFO - 'PWD': '/builds/slave/test', 13:57:21 INFO - 'SHELL': '/bin/bash', 13:57:21 INFO - 'SHLVL': '1', 13:57:21 INFO - 'TERM': 'linux', 13:57:21 INFO - 'TMOUT': '86400', 13:57:21 INFO - 'USER': 'cltbld', 13:57:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:21 INFO - '_': '/tools/buildbot/bin/python'} 13:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:22 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 13:57:22 INFO - Cleaning up... 13:57:22 INFO - Return code: 0 13:57:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:57:22 INFO - Using env: {'DISPLAY': ':0', 13:57:22 INFO - 'HOME': '/home/cltbld', 13:57:22 INFO - 'LANG': 'en_US.UTF-8', 13:57:22 INFO - 'LANGUAGE': 'en_US:en', 13:57:22 INFO - 'LOGNAME': 'cltbld', 13:57:22 INFO - 'MAIL': '/var/mail/cltbld', 13:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:22 INFO - 'MOZ_NO_REMOTE': '1', 13:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:22 INFO - 'NO_EM_RESTART': '1', 13:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:22 INFO - 'PWD': '/builds/slave/test', 13:57:22 INFO - 'SHELL': '/bin/bash', 13:57:22 INFO - 'SHLVL': '1', 13:57:22 INFO - 'TERM': 'linux', 13:57:22 INFO - 'TMOUT': '86400', 13:57:22 INFO - 'USER': 'cltbld', 13:57:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:22 INFO - '_': '/tools/buildbot/bin/python'} 13:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:22 INFO - Downloading/unpacking psutil>=3.1.1 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:24 INFO - Installing collected packages: psutil 13:57:24 INFO - Running setup.py install for psutil 13:57:24 INFO - building 'psutil._psutil_linux' extension 13:57:24 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 13:57:24 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 13:57:24 INFO - building 'psutil._psutil_posix' extension 13:57:24 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 13:57:24 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 13:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:25 INFO - Successfully installed psutil 13:57:25 INFO - Cleaning up... 13:57:25 INFO - Return code: 0 13:57:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:57:25 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')]} 13:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 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')]} 13:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:25 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 13:57:25 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 13:57:25 INFO - Using env: {'DISPLAY': ':0', 13:57:25 INFO - 'HOME': '/home/cltbld', 13:57:25 INFO - 'LANG': 'en_US.UTF-8', 13:57:25 INFO - 'LANGUAGE': 'en_US:en', 13:57:25 INFO - 'LOGNAME': 'cltbld', 13:57:25 INFO - 'MAIL': '/var/mail/cltbld', 13:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:25 INFO - 'MOZ_NO_REMOTE': '1', 13:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:25 INFO - 'NO_EM_RESTART': '1', 13:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:25 INFO - 'PWD': '/builds/slave/test', 13:57:25 INFO - 'SHELL': '/bin/bash', 13:57:25 INFO - 'SHLVL': '1', 13:57:25 INFO - 'TERM': 'linux', 13:57:25 INFO - 'TMOUT': '86400', 13:57:25 INFO - 'USER': 'cltbld', 13:57:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:25 INFO - '_': '/tools/buildbot/bin/python'} 13:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:57:27 INFO - Installing collected packages: mozsystemmonitor 13:57:27 INFO - Running setup.py install for mozsystemmonitor 13:57:27 INFO - Successfully installed mozsystemmonitor 13:57:27 INFO - Cleaning up... 13:57:27 INFO - Return code: 0 13:57:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:57:27 INFO - Using env: {'DISPLAY': ':0', 13:57:27 INFO - 'HOME': '/home/cltbld', 13:57:27 INFO - 'LANG': 'en_US.UTF-8', 13:57:27 INFO - 'LANGUAGE': 'en_US:en', 13:57:27 INFO - 'LOGNAME': 'cltbld', 13:57:27 INFO - 'MAIL': '/var/mail/cltbld', 13:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:27 INFO - 'MOZ_NO_REMOTE': '1', 13:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:27 INFO - 'NO_EM_RESTART': '1', 13:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:27 INFO - 'PWD': '/builds/slave/test', 13:57:27 INFO - 'SHELL': '/bin/bash', 13:57:27 INFO - 'SHLVL': '1', 13:57:27 INFO - 'TERM': 'linux', 13:57:27 INFO - 'TMOUT': '86400', 13:57:27 INFO - 'USER': 'cltbld', 13:57:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:27 INFO - '_': '/tools/buildbot/bin/python'} 13:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:27 INFO - Downloading/unpacking jsonschema==2.5.1 13:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:57:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:57:29 INFO - warning: no files found matching '*.txt' 13:57:29 INFO - no previously-included directories found matching 'build' 13:57:29 INFO - no previously-included directories found matching 'dist' 13:57:29 INFO - no previously-included directories found matching '.git*' 13:57:30 INFO - Installing collected packages: jsonschema, functools32 13:57:30 INFO - Running setup.py install for functools32 13:57:30 INFO - warning: no files found matching '*.txt' 13:57:30 INFO - no previously-included directories found matching 'build' 13:57:30 INFO - no previously-included directories found matching 'dist' 13:57:30 INFO - no previously-included directories found matching '.git*' 13:57:30 INFO - Successfully installed jsonschema functools32 13:57:30 INFO - Cleaning up... 13:57:30 INFO - Return code: 0 13:57:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:57:30 INFO - Using env: {'DISPLAY': ':0', 13:57:30 INFO - 'HOME': '/home/cltbld', 13:57:30 INFO - 'LANG': 'en_US.UTF-8', 13:57:30 INFO - 'LANGUAGE': 'en_US:en', 13:57:30 INFO - 'LOGNAME': 'cltbld', 13:57:30 INFO - 'MAIL': '/var/mail/cltbld', 13:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:30 INFO - 'MOZ_NO_REMOTE': '1', 13:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:30 INFO - 'NO_EM_RESTART': '1', 13:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:30 INFO - 'PWD': '/builds/slave/test', 13:57:30 INFO - 'SHELL': '/bin/bash', 13:57:30 INFO - 'SHLVL': '1', 13:57:30 INFO - 'TERM': 'linux', 13:57:30 INFO - 'TMOUT': '86400', 13:57:30 INFO - 'USER': 'cltbld', 13:57:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:30 INFO - '_': '/tools/buildbot/bin/python'} 13:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:57:30 INFO - Cleaning up... 13:57:30 INFO - Return code: 0 13:57:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:57:30 INFO - Using env: {'DISPLAY': ':0', 13:57:30 INFO - 'HOME': '/home/cltbld', 13:57:30 INFO - 'LANG': 'en_US.UTF-8', 13:57:30 INFO - 'LANGUAGE': 'en_US:en', 13:57:30 INFO - 'LOGNAME': 'cltbld', 13:57:30 INFO - 'MAIL': '/var/mail/cltbld', 13:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:30 INFO - 'MOZ_NO_REMOTE': '1', 13:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:30 INFO - 'NO_EM_RESTART': '1', 13:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:30 INFO - 'PWD': '/builds/slave/test', 13:57:30 INFO - 'SHELL': '/bin/bash', 13:57:30 INFO - 'SHLVL': '1', 13:57:30 INFO - 'TERM': 'linux', 13:57:30 INFO - 'TMOUT': '86400', 13:57:30 INFO - 'USER': 'cltbld', 13:57:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:30 INFO - '_': '/tools/buildbot/bin/python'} 13:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:34 INFO - Downloading docopt-0.6.1.tar.gz 13:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:34 INFO - Running setup.py install for blobuploader 13:57:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:34 INFO - Running setup.py install for requests 13:57:34 INFO - Running setup.py install for docopt 13:57:35 INFO - Successfully installed blobuploader requests docopt 13:57:35 INFO - Cleaning up... 13:57:35 INFO - Return code: 0 13:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:35 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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:35 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 13:57:35 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 13:57:35 INFO - Using env: {'DISPLAY': ':0', 13:57:35 INFO - 'HOME': '/home/cltbld', 13:57:35 INFO - 'LANG': 'en_US.UTF-8', 13:57:35 INFO - 'LANGUAGE': 'en_US:en', 13:57:35 INFO - 'LOGNAME': 'cltbld', 13:57:35 INFO - 'MAIL': '/var/mail/cltbld', 13:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:35 INFO - 'MOZ_NO_REMOTE': '1', 13:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:35 INFO - 'NO_EM_RESTART': '1', 13:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:35 INFO - 'PWD': '/builds/slave/test', 13:57:35 INFO - 'SHELL': '/bin/bash', 13:57:35 INFO - 'SHLVL': '1', 13:57:35 INFO - 'TERM': 'linux', 13:57:35 INFO - 'TMOUT': '86400', 13:57:35 INFO - 'USER': 'cltbld', 13:57:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:35 INFO - '_': '/tools/buildbot/bin/python'} 13:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:35 INFO - Running setup.py (path:/tmp/pip-KaCjVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:35 INFO - Running setup.py (path:/tmp/pip-iumbE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:35 INFO - Running setup.py (path:/tmp/pip-nWuI_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:35 INFO - Running setup.py (path:/tmp/pip-4uT4y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:35 INFO - Running setup.py (path:/tmp/pip-mHEd2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:35 INFO - Running setup.py (path:/tmp/pip-FfU_45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:35 INFO - Running setup.py (path:/tmp/pip-IvJlPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:35 INFO - Running setup.py (path:/tmp/pip-nh6MfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:35 INFO - Running setup.py (path:/tmp/pip-oDC23T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:35 INFO - Running setup.py (path:/tmp/pip-ds9HQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:36 INFO - Running setup.py (path:/tmp/pip-o3JeEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:36 INFO - Running setup.py (path:/tmp/pip-wB8Ju6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:36 INFO - Running setup.py (path:/tmp/pip-5v7k3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:36 INFO - Running setup.py (path:/tmp/pip-GoCNSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:36 INFO - Running setup.py (path:/tmp/pip-q5JUV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:36 INFO - Running setup.py (path:/tmp/pip-TSGoSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:36 INFO - Running setup.py (path:/tmp/pip-_epZIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:36 INFO - Running setup.py install for manifestparser 13:57:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:36 INFO - Running setup.py install for mozcrash 13:57:36 INFO - Running setup.py install for mozdebug 13:57:36 INFO - Running setup.py install for mozdevice 13:57:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozfile 13:57:37 INFO - Running setup.py install for mozhttpd 13:57:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozinfo 13:57:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozInstall 13:57:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozleak 13:57:37 INFO - Running setup.py install for mozlog 13:57:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for moznetwork 13:57:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozprocess 13:57:37 INFO - Running setup.py install for mozprofile 13:57:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozrunner 13:57:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Running setup.py install for mozscreenshot 13:57:38 INFO - Running setup.py install for moztest 13:57:38 INFO - Running setup.py install for mozversion 13:57:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:38 INFO - Cleaning up... 13:57:38 INFO - Return code: 0 13:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:38 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 13:57:38 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 13:57:38 INFO - Using env: {'DISPLAY': ':0', 13:57:38 INFO - 'HOME': '/home/cltbld', 13:57:38 INFO - 'LANG': 'en_US.UTF-8', 13:57:38 INFO - 'LANGUAGE': 'en_US:en', 13:57:38 INFO - 'LOGNAME': 'cltbld', 13:57:38 INFO - 'MAIL': '/var/mail/cltbld', 13:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:38 INFO - 'MOZ_NO_REMOTE': '1', 13:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:38 INFO - 'NO_EM_RESTART': '1', 13:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:38 INFO - 'PWD': '/builds/slave/test', 13:57:38 INFO - 'SHELL': '/bin/bash', 13:57:38 INFO - 'SHLVL': '1', 13:57:38 INFO - 'TERM': 'linux', 13:57:38 INFO - 'TMOUT': '86400', 13:57:38 INFO - 'USER': 'cltbld', 13:57:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:38 INFO - '_': '/tools/buildbot/bin/python'} 13:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:38 INFO - Running setup.py (path:/tmp/pip-9GnYPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:38 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)) 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:38 INFO - Running setup.py (path:/tmp/pip-JRGeI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:38 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)) 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:38 INFO - Running setup.py (path:/tmp/pip-khbhMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:38 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)) 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:38 INFO - Running setup.py (path:/tmp/pip-iEuETB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:38 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)) 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:38 INFO - Running setup.py (path:/tmp/pip-mAvFzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:38 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)) 13:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:38 INFO - Running setup.py (path:/tmp/pip-_ET2JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:39 INFO - Running setup.py (path:/tmp/pip-vXeKz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:39 INFO - Running setup.py (path:/tmp/pip-llOuJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:39 INFO - Running setup.py (path:/tmp/pip-v6mo5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:39 INFO - Running setup.py (path:/tmp/pip-NYK_jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:39 INFO - Running setup.py (path:/tmp/pip-Ip_EHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:39 INFO - Running setup.py (path:/tmp/pip-sznAdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:39 INFO - Running setup.py (path:/tmp/pip-ampIZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:39 INFO - Running setup.py (path:/tmp/pip-DqbfLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:39 INFO - Running setup.py (path:/tmp/pip-WjK5Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:39 INFO - Running setup.py (path:/tmp/pip-wBzjE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:39 INFO - Running setup.py (path:/tmp/pip-SvULg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:39 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)) 13:57:39 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)) 13:57:39 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)) 13:57:39 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)) 13:57:39 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)) 13:57:39 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)) 13:57:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:41 INFO - Downloading blessings-1.6.tar.gz 13:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:41 INFO - Installing collected packages: blessings 13:57:41 INFO - Running setup.py install for blessings 13:57:42 INFO - Successfully installed blessings 13:57:42 INFO - Cleaning up... 13:57:42 INFO - Return code: 0 13:57:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:42 INFO - Reading from file tmpfile_stdout 13:57:42 INFO - Current package versions: 13:57:42 INFO - argparse == 1.2.1 13:57:42 INFO - blessings == 1.6 13:57:42 INFO - blobuploader == 1.2.4 13:57:42 INFO - docopt == 0.6.1 13:57:42 INFO - functools32 == 3.2.3-2 13:57:42 INFO - jsonschema == 2.5.1 13:57:42 INFO - manifestparser == 1.1 13:57:42 INFO - mozInstall == 1.12 13:57:42 INFO - mozcrash == 1.0 13:57:42 INFO - mozdebug == 0.1 13:57:42 INFO - mozdevice == 0.48 13:57:42 INFO - mozfile == 1.2 13:57:42 INFO - mozhttpd == 0.7 13:57:42 INFO - mozinfo == 0.9 13:57:42 INFO - mozleak == 0.1 13:57:42 INFO - mozlog == 3.4 13:57:42 INFO - moznetwork == 0.27 13:57:42 INFO - mozprocess == 0.23 13:57:42 INFO - mozprofile == 0.28 13:57:42 INFO - mozrunner == 6.13 13:57:42 INFO - mozscreenshot == 0.1 13:57:42 INFO - mozsystemmonitor == 0.3 13:57:42 INFO - moztest == 0.8 13:57:42 INFO - mozversion == 1.4 13:57:42 INFO - psutil == 3.1.1 13:57:42 INFO - requests == 1.2.3 13:57:42 INFO - wsgiref == 0.1.2 13:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:42 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 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:42 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 13:57:42 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 13:57:42 INFO - Using env: {'DISPLAY': ':0', 13:57:42 INFO - 'HOME': '/home/cltbld', 13:57:42 INFO - 'LANG': 'en_US.UTF-8', 13:57:42 INFO - 'LANGUAGE': 'en_US:en', 13:57:42 INFO - 'LOGNAME': 'cltbld', 13:57:42 INFO - 'MAIL': '/var/mail/cltbld', 13:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:42 INFO - 'MOZ_NO_REMOTE': '1', 13:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:42 INFO - 'NO_EM_RESTART': '1', 13:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:42 INFO - 'PWD': '/builds/slave/test', 13:57:42 INFO - 'SHELL': '/bin/bash', 13:57:42 INFO - 'SHLVL': '1', 13:57:42 INFO - 'TERM': 'linux', 13:57:42 INFO - 'TMOUT': '86400', 13:57:42 INFO - 'USER': 'cltbld', 13:57:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:42 INFO - '_': '/tools/buildbot/bin/python'} 13:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 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)) 13:57:42 INFO - Cleaning up... 13:57:42 INFO - Return code: 0 13:57:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46a8e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', '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 13:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:57:42 INFO - Using env: {'DISPLAY': ':0', 13:57:42 INFO - 'HOME': '/home/cltbld', 13:57:42 INFO - 'LANG': 'en_US.UTF-8', 13:57:42 INFO - 'LANGUAGE': 'en_US:en', 13:57:42 INFO - 'LOGNAME': 'cltbld', 13:57:42 INFO - 'MAIL': '/var/mail/cltbld', 13:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:42 INFO - 'MOZ_NO_REMOTE': '1', 13:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:42 INFO - 'NO_EM_RESTART': '1', 13:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:42 INFO - 'PWD': '/builds/slave/test', 13:57:42 INFO - 'SHELL': '/bin/bash', 13:57:42 INFO - 'SHLVL': '1', 13:57:42 INFO - 'TERM': 'linux', 13:57:42 INFO - 'TMOUT': '86400', 13:57:42 INFO - 'USER': 'cltbld', 13:57:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:42 INFO - '_': '/tools/buildbot/bin/python'} 13:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:42 INFO - Cleaning up... 13:57:42 INFO - Return code: 0 13:57:42 INFO - Running post-action listener: _resource_record_post_action 13:57:42 INFO - Running post-action listener: _start_resource_monitoring 13:57:42 INFO - Starting resource monitoring. 13:57:42 INFO - [mozharness: 2017-01-12 21:57:42.820399Z] Finished create-virtualenv step (success) 13:57:42 INFO - [mozharness: 2017-01-12 21:57:42.820913Z] Running install step. 13:57:42 INFO - Running pre-action listener: _resource_record_pre_action 13:57:42 INFO - Running main action method: install 13:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:43 INFO - Reading from file tmpfile_stdout 13:57:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:43 INFO - Reading from file tmpfile_stdout 13:57:43 INFO - Output received: 13:57:43 INFO - Usage: mozinstall [options] installer 13:57:43 INFO - Options: 13:57:43 INFO - -h, --help show this help message and exit 13:57:43 INFO - -d DEST, --destination=DEST 13:57:43 INFO - Directory to install application into. [default: 13:57:43 INFO - "/builds/slave/test"] 13:57:43 INFO - --app=APP Application being installed. [default: firefox] 13:57:43 INFO - mkdir: /builds/slave/test/build/application 13:57:43 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'] 13:57:43 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 13:57:59 INFO - Reading from file tmpfile_stdout 13:57:59 INFO - Output received: 13:57:59 INFO - /builds/slave/test/build/application/firefox/firefox 13:57:59 INFO - Running post-action listener: _resource_record_post_action 13:57:59 INFO - [mozharness: 2017-01-12 21:57:59.167117Z] Finished install step (success) 13:57:59 INFO - [mozharness: 2017-01-12 21:57:59.167365Z] Running run-tests step. 13:57:59 INFO - Running pre-action listener: _resource_record_pre_action 13:57:59 INFO - Running main action method: run_tests 13:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:57:59 INFO - Python 2.7.3 13:57:59 INFO - Return code: 0 13:57:59 INFO - grabbing minidump binary from tooltool 13:57: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')]} 13:57:59 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 0x139bf60>, '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 0x139cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:57:59 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 13:57:59 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 13:57:59 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 13:57:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:59 INFO - Return code: 0 13:57:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:57:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:57:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:57:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:57:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:57:59 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/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:57:59 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/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 13:57:59 INFO - Using env: {'DISPLAY': ':0', 13:57:59 INFO - 'HOME': '/home/cltbld', 13:57:59 INFO - 'LANG': 'en_US.UTF-8', 13:57:59 INFO - 'LANGUAGE': 'en_US:en', 13:57:59 INFO - 'LOGNAME': 'cltbld', 13:57:59 INFO - 'MAIL': '/var/mail/cltbld', 13:57:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:57:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:59 INFO - 'MOZ_NO_REMOTE': '1', 13:57:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:59 INFO - 'NO_EM_RESTART': '1', 13:57:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:59 INFO - 'PWD': '/builds/slave/test', 13:57:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:57:59 INFO - 'SHELL': '/bin/bash', 13:57:59 INFO - 'SHLVL': '1', 13:57:59 INFO - 'TERM': 'linux', 13:57:59 INFO - 'TMOUT': '86400', 13:57:59 INFO - 'USER': 'cltbld', 13:57:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890', 13:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:59 INFO - '_': '/tools/buildbot/bin/python'} 13:57:59 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/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:57:59 INFO - mozversion application_buildid: 20170112121216 13:57:59 INFO - mozversion application_changeset: 8d0ece73d3278ee81807f7d5dcdd402f994954dc 13:57:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:57:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:59 INFO - mozversion application_name: Firefox 13:57:59 INFO - mozversion application_remotingname: firefox-dev 13:57:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:59 INFO - mozversion application_vendor: Mozilla 13:57:59 INFO - mozversion application_version: 52.0a2 13:57:59 INFO - mozversion platform_buildid: 20170112121216 13:57:59 INFO - mozversion platform_changeset: 8d0ece73d3278ee81807f7d5dcdd402f994954dc 13:57:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:59 INFO - mozversion platform_version: 52.0a2 13:57:59 INFO - using testdate: 1484258279 13:57:59 INFO - actual date: 1484258279 13:57:59 INFO - starting webserver on 'localhost:45355' 13:57:59 INFO - SUITE-START | Running 2 tests 13:57:59 INFO - TEST-START | dromaeo_css 13:57:59 INFO - operating with platform_type : linux_ 13:57:59 INFO - Initialising browser for dromaeo_css test... 13:57:59 INFO - TEST-INFO | started process 1333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsUXL6/profile http://localhost:45355/getInfo.html) 13:58:03 INFO - PROCESS | 1333 | __metrics Screen width/height:1600/1200 13:58:03 INFO - PROCESS | 1333 | colorDepth:24 13:58:03 INFO - PROCESS | 1333 | Browser inner width/height: 1024/697 13:58:03 INFO - PROCESS | 1333 | __metrics 13:58:04 INFO - PROCESS | 1333 | 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" 13:58:04 INFO - PROCESS | 1333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:04 INFO - PROCESS | 1333 | console.error: PushService: 13:58:04 INFO - PROCESS | 1333 | stateChangeProcessEnqueue: Error transitioning state 13:58:04 INFO - PROCESS | 1333 | UnknownError 13:58:05 INFO - TEST-INFO | 1333: exit 0 13:58:05 INFO - Browser initialized. 13:58:05 INFO - Running cycle 1/1 for dromaeo_css test... 13:58:05 INFO - TEST-INFO | started process 1425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsUXL6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:16 INFO - PROCESS | 1425 | RSS: Main: 144420864 13:58:16 INFO - PROCESS | 1425 | 14:01:18 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45355/tests/dromaeo/cssquery-ext.html) 14:01:19 INFO - PROCESS | 1425 | RSS: Main: 237707264 14:01:19 INFO - PROCESS | 1425 | 14:04:21 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-ext.html (next: http://localhost:45355/tests/dromaeo/cssquery-jquery.html) 14:04:22 INFO - PROCESS | 1425 | RSS: Main: 226660352 14:04:22 INFO - PROCESS | 1425 | 14:07:24 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45355/tests/dromaeo/cssquery-mootools.html) 14:07:25 INFO - PROCESS | 1425 | RSS: Main: 175198208 14:07:25 INFO - PROCESS | 1425 | 14:10:26 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45355/tests/dromaeo/cssquery-prototype.html) 14:10:27 INFO - PROCESS | 1425 | RSS: Main: 175222784 14:10:27 INFO - PROCESS | 1425 | 14:13:30 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45355/tests/dromaeo/cssquery-yui.html) 14:13:30 INFO - PROCESS | 1425 | RSS: Main: 176222208 14:13:30 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | Cycle 1(1): loaded http://localhost:45355/tests/dromaeo/cssquery-yui.html (next: http://localhost:45355/tests/dromaeo/cssquery-dojo.html) 14:16:33 INFO - PROCESS | 1425 | RSS: Main: 267812864 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | __start_tp_report 14:16:33 INFO - PROCESS | 1425 | _x_x_mozilla_page_load 14:16:33 INFO - PROCESS | 1425 | _x_x_mozilla_page_load_details 14:16:33 INFO - PROCESS | 1425 | |i|pagename|runs| 14:16:33 INFO - PROCESS | 1425 | |0;dojo.html;3166.6358368787587;3179.60254968129;3204.7275981541575;3217.678232176783;3237.692419220173;5532.446755324466;5599.244102046223;5618.943810561904;5629.971850140743;5631.239782629344;5593.664380137185;5634.521065709409;5647.830565083054;5670.631408958415;5678.290213723285;5111.437741848394;5133.255677926699;5151.253068305094;5167.121589329823;5208.921866172011;5032.194848824171;5207.6354655174155;5219.269302297681;5222.608304377168;5224.39919409269;4999.425066117388;5019.899602007958;5084.262781896623;5091.0581542414775;5125.487451254882;5139.306193663845;5192.324997750287;5203.19350500673;5256.106461901486;5268.025415298182;5092.79628814847;5160.251763494272;5225.790968361261;5244.527992480657;5265.52610265078;5317.8404647860625;5369.62412631116;5446.618736688394;5507.228987941691;5551.528120109796;5836.883262334772;5844.970775146139;5845.503132233765;5945.256842894638;5949.6727679977585;6000.939990600082;6001.639901605874;6012.488938440238;6018.879622407528;6035.698215089228;5460.535854452376;5513.751881165317;5609.943900561024;5664.093745000862;5673.092305231144;6163.630182188993;6177;6207.16203312547;6208.441240288395;6225.439710426083;5954.3152537458745;5969.970150149222;5982.40175982407;5991.430814072656;5993.550483713739;5748.798792042342;5784.94215057844;5880.8235752927485;5911.438413350725;5920.5559583031445;5976.491998180117;5978.970105149447;5980.372060933626;6004;6004.219451471281;5932.228810254725;5979.491743201789;5979.970100149559;5986.4013598639785;5988.700564971734;4280.5291417944;4308.18144552534;4375.7155784873885;4396.560343965578;4400.119976004812;4019.8995025124605;4026.2350153470748;4033.3748269018347;4042.2319759245647;4071.1654110907193;5783.450572195635;5800.8259752207505;5801.042827933428;5807.245058142499;5820.738066787005;5753.367129615739;5805.36141024487;5954.196183515257;6083.969580152159;6094.664793436404;5734.397888221677;5806.82579522615;5829.8251052468495;5837.94162058374;5847.1229315603;5195.636305458582;5202.2196670499725;5204.843854684365;5206.7917283309;5210.5831533477985;5973.910391344047;6279.560430769802;6330.936690633035;6345.397187267202;6346.746130154835;5791.768329266951;5896.616719913192;5972.552058595709;5972.880542389041;6068.787592434243;6229.470495007975;6287;6290.150829637941;6290.874182516415;6295.716692748929;5911.201987731602;5913.497352724895;5913.733881975236;5916.142159386951;5950.910736338872;5784.7107644618445;5899.085641725539;5947.6431414115295;5981.671008094597;6007.939920600738;5842.211301474246;5878.764849405976;5888.440598143169;5892.646441213541;5916.023856063702;5873.295204575478;5878.529717622666;5881.73532191061;5884.411558844081;5890.617109887844;5529.668219906818;5648.265725455664;5742.224799652161;5797.681127538026;5822.679752613647;5931.555133365101;5934;5952.464278214981;5964.165016897725;5965.313988891159;5586.664800112007;5744.741486633028;5768;5771.884562308646;5773.451522105393 14:16:33 INFO - PROCESS | 1425 | |1;ext.html;580.457272450259;641.9165508483896;647.3526473526474;674.0159367323704;674.8549061951679;35184.64815351846;35783.28433431333;38007.42988855169;38027.61972380275;38078.048048798795;37843.4323485148;38622.22755544887;46590.301145482845;47303.76348118263;47529.52470475294;8811;8930.106989301083;8935.508547029911;8936.463812171258;8946.150115738994;8783.165599268059;8879.156480134377;8885.200331970122;8890.288776897833;8893.4663920165;8546.914530854705;8749.081346458626;8882.378233523656;10672.252942294042;10941.28881622696;10664;10740.677779666623;10756.139508839275;10757.300775449648;10765.946170269177;10699.786004279871;10793.406362650052;10793.5682572697;10793.838092428541;10805.297655652357;44157;44158.55841441577;44422.33366499505;44442.555574444166;44574.77712611416;3478.9478157827652;3507.4037413639744;3510.069831494656;3514.2795726876184;3540.3627347077772;33074.83462582696;33667.663323366694;33816.6618333816;34182.14544636379;34714.479282810775;4402.713823601488;4449.307075127668;4453.487848897385;4467.553244675506;4489.775511224426;357651;357927;361233;362563;363498.1825090884;61754.382456175765;62111;62138;62213;62238.37761622416;39590;41043.38434923479;41056.79471602623;43367.783161084626;43455.56544434578;19093;19227.327043553407;19268.22927082901;19268.4219473416;19270.132844022053;14243.78634320486;14327.78508322376;14330.57008289753;14343;14345.354459049368;18392.26430942747;20571.897140514502;20644.38066857997;20650.690239646417;20706.275280365116;6107.450329470369;7192.892106618405;7295.161056478573;7491.850162996819;7651.120121186023;1022.5602990713916;1098.4946924414699;1147.5295128997238;1162.604714397109;1178.5462596900254;34445.48331775025;34769.478457822646;35018;35055.29889402249;35182.12044698903;1098.6758906122714;1156.3524426321287;1188.1326631559011;1193.1111322065117;1238.6779437346354;17784.644307113784;18374.81625183758;18384.448466546026;18388.908055459906;18489.352872649393;543833;547059;549032;549761;549861;56089.43910560842;57139;59664.10503842446;63166.684166578874;64047.67976160089;1396.8812650924785;1405.8875289976777;1415.1579810013027;1428.3144090836456;1452.063419094678;32684.673153268162;35399.469007964384;35752.64247357597;35757.82121089378;35812.28375432529;55173.72413137909;55625;55678;55724.16413753878;55733;484993;501881;501882;662440;662788;45738.77130614326;46070;46243;46441.53558464507;46911.765441172574;50259.49740502548;50463.24305135499;50575.49424505855;50993.74503127461;51221;43845.342319865864;44384.55615443804;44582.55417445914;44754.05598854852;45286;43771.56228437802;44456.77771611121;44774.77612611916;44835.55164448314;46017.53982460133;43545;44360.334594981745;44655.55344446514;45111.32333014942;45129.774351128035;35722.28555428929;37104.81447592745;37841.62158378381;38132;38170.809145954096;29149.271268218465;29602.555961661023;29686.257843554085;29787.255318617208;30167.396652067273 14:16:33 INFO - PROCESS | 1425 | |2;jquery.html;389.4158761857214;420.2960041929767;422.4972282983249;428.15866821695374;449.67398635988894;14759.77860332096;19316.903415482902;19327.806721932793;19619.80380196201;20546.28088016916;12736.55422060228;13256;13305.800412993813;13365.532206372778;13379.130356526819;4159.958400416002;4334.739915605074;5400.351957765064;5556.138798486241;5560.749766260507;5958.314793798703;6211.254649442073;6247.219097612799;6255.843603909916;6262.12330273762;6039.094135879609;6170.413810687977;6199.752009919598;6205.5345849061505;6264.091706702526;6153.446189842891;6190.41191086846;6215.720292586844;6216.191895053659;6221.937780622181;5980.910286345708;6032.547558933097;6033.185519954794;6036.396360363972;6039.879202415971;15837.366505339773;24068.759312406826;24399.390015249584;24439.26682199537;24586.262412127664;2257.8758168300737;2330.475642980333;2576.1756238003845;2832.872520736572;2836.957445638317;10827.891721082768;10906.836397454044;11189.49647265875;11367.715807104805;11417.714557136138;1960.2746983616153;1971.3001884331;2001.989990050055;2044.9795502044938;2124.830013598924;89392;97881.51059244658;97914.0208597912;98130.99999999929;100327;11461.598844040585;11828.822567661491;11860.76278474443;12220.3278819664;12292;17494.562635933948;17505;17532.912335438243;17537.912310438365;17541.824581754274;8813.25087367568;8834.072422395557;9028.458292502472;9166.633334666538;9194.218491428304;8401.705940292182;8824.514651694219;9051.547422628842;9080.364374493854;9279.257659387233;4783.234682450791;5243.580513558906;5266.552343050884;5281.313429254173;5291.603129765283;1924.9903750481158;2009.166196028661;2144.3888491779767;2209.281983355416;2222.7888350606668;927.2628260532892;980.2011360740973;1006.9345492542961;1035.2132379391717;1077.3051381858813;20161.193552257744;20415.693764593543;20428.79571204269;20524.179032838816;20649;970.1075010989906;1006.4716024087267;1044.195969103801;1069.844872493484;1077.7413420778958;10692.786144277072;11476.942615286871;11496.137789665809;11563.479643416067;11645.883541164649;484239;491523;494067;495089;501037;97232;97891;98320;100247.49876250573;101186;947.4930911962067;983.975400614976;994.8557459168525;1004.542932965499;1010.151472762868;17687.734683979492;17698.91150544239;18078.45764627063;18080.90959545194;18408;42767.3584896233;44046;44359.77820110879;44701.32948005848;44800.55199447964;60928.39071609227;61558;61560.69219653873;62473.37526624675;64354.35645643671;7813.921860781319;8722.67328258698;8772.824543508967;9065.184133428023;9108.681196158102;13252.602421927357;13479.460821567027;14067.155970641794;14257.358418870968;14534.85465145335;12016.218945768496;12064.638060857837;12200.755984880076;12491.75016499683;12579.622611321674;11654.30074195551;11740.823887641864;12213.511459541518;12383.133180677627;12431;11991.460384282555;12062.577809776616;12541.498340066295;12710.173838700455;12870.67823304425;8419.115992820665;8484.61819218149;8595.355348348774;8632.223099920786;8680.21878030955;11096;12466.252024878537;12499.125061245626;12527.123101382816;12772.87227127754 14:16:33 INFO - PROCESS | 1425 | |3;mootools.html;1468.456671031718;1499.1005396761943;1653.4130383713782;1801.8828776129542;1828.6251318479722;7409.48133630646;7629.465937384385;8484.406091573584;9018.458892466448;9018.684346047898;8515;8777.648894044247;8786.165314295147;8984.955075224614;8986.640534378617;2522.369407648088;2544.694636643596;2546.6562014128135;2548.0444833187553;2550.7831834294016;2213.1921848525253;2288.702468679069;2508.1723031399683;2558.2581051495135;2564.999650136439;2402.027178992511;2474.270090323359;2480;2491.9003239870385;2501.2996361018854;2453.717822450414;2463.4334103156284;2495.0892924082577;2506.548821212181;2507.0723832182025;2451.460678650694;2460.6186041163646;2480.045182604692;2502.1367628168255;2515.622656601506;8810.603522841488;8944.508052057134;9001.279897608176;9005.234555062762;9009.774755631097;5468.453154684539;5634.183043458716;5637.154426835967;5640.858978525529;5649.717514124319;3625.782453052825;3817.2938006468894;3870.1679138984973;3890.1636148227985;3935.9803200984097;1172.7185475485908;1241.2986662535639;1243.6828608704723;1299.571141523295;1304.2500562176692;12351.629451116482;12451.501939922393;12539;12543.749125017539;12544.184627999151;4868.440129385166;5104.464031276737;5145.511176438233;5153.742312884341;5191.195364718475;10475.528601212964;10481.475926203659;10492.370457772558;10494;10494.370337779757;5694.117411801178;5716.485516303553;5723.942760572424;5732.283464566929;5733.111367738007;5191.32512773337;5269.894602107936;5270.1040823060175;5327.360716713942;5343.599230057761;4170.72890262132;4203.306454434984;4236.957630423656;4293.2701440755145;4301.806418711166;1273.4333221716247;1300.2393599744066;1387.341013018828;1410.7742761158165;1464.8461911499353;835.9665613375397;965.1844191658038;993.6770549571273;1019.7705516258931;1053.599632139782;6232.750689972441;6263.467605253604;6396.968015159988;6430.967845160744;6475.061116138228;976.9804603907882;989.1493315748451;1000.4847503535685;1003.6637726361605;1027.8869324374314;4297.677674174387;4387.363832244307;4417.204903117469;4425.137098265872;4455.68810183284;10841.241113122163;11091.833622495507;11197.832032519518;11231.15766317513;11257.268277561932;10724.89275107239;10861.07680847121;11047.668569942914;11112.944435277934;11122;8380.580970951429;8382.916170838458;8475.872861907077;8480.067192608809;8497.065322814486;6143.877122457437;6173.475254603409;6178.104174894705;6264.561480696308;6267.2479302484;10187.643432479828;10242.180625549789;10258.897411025795;10283;10297.9485102577;9736.95131524338;9874.654387096418;9974.800503990025;10024.599016039278;10313.22650801178;7792.493487923267;7958.602069896598;7963.243491868263;7967.442279040411;7974.601269936364;8311.625976830936;8521.190486903733;8592.484450932963;8659.653613855375;8666.263367613823;7928.31849125207;7982.361411086983;8077.87883181741;8136.511809291462;8242.093369729444;7617.200193979553;7772.45592808498;7829.942957700638;7839.412044096602;8123.18768123183;7083.964580177066;7279.162896266997;7328.487005909536;7331.706731730671;7339.486235963432;5483.396826349178;5486.396496385474;5533.6956467393065;5562.610617256915;5762.740676669476;5512.944870551243;5673.489385955284;5706.144078388275;5710.914336285042;5727.369989301257 14:16:33 INFO - PROCESS | 1425 | |4;prototype.html;356.5240404060578;358.2601927020703;361.4253337193863;361.92942376236647;362.9582598001231;5457.536109430698;5516.365617953937;5517.944820551793;5519.9448005519935;5543.6396634218745;5383.81156659517;5401.216823560581;5416.593755468346;5430;5444.455554444554;3787.6591106800383;4059.614336638022;4272.931767058236;4306.57371711644;4337.110892267094;4311.6335111515555;4324.82700691972;4326.394304797331;4331.155424692186;4342.609165175134;4299.828006879737;4306.440162778835;4309.913801723964;4311.676624253178;4317.179735850178;4062.6546743526837;4110.787317741274;4267.359896015591;4285.635720963722;4315;3819.9427008594894;3825.5218097737784;3837.4435706822633;3845.1540661054523;3872.1481274119647;5309.017831701148;5324.1215199492035;5345.893082138375;5349.43830897754;5353.57171426285;4740.952590474086;4883.926741098886;4905.6320775941595;4908.361912951329;4944.208926571731;5642.7742890284335;5662.6036177467595;5667.603267771257;5670.829875103754;5693.77224911003;4245;4249.511306199795;4255.829766809324;4256.573458366014;4258.212230737324;5622.690752008638;5892.263467066617;5902.498287645555;5911.704414779244;5956.583039187215;4196.727212731163;4207.789610519461;4210.431591735077;4224.619784219435;4231.238377092153;4275.700700950966;4276.593723596254;4283.678724095643;4284.100338928797;4284.400183974246;4755.2153894607;4811.797050737316;4858.5384388483035;4863.689747370042;4873.731944743073;5604.6356986796545;5683.499260325526;5707.404335268837;5727.341355744143;5730.856728581819;1416.8653977872086;1427.421894132878;1430.7281616492833;1444.949426770079;1445.8626430489087;973.728797055448;980.8283550378655;984.7542858284277;992.4243938515788;1019.9698304712294;5375.274337964324;5376.973115134478;5396.379416367168;5399.811006614828;5407.378151512547;5656.179853921159;5659.518940889988;5672.376038635747;5676.318841739017;5681.147827825776;5214.504622060898;5365.409804921455;5367.75845086972;5390.811321603725;5397.973010134924;2998.5352270398125;3001.529250667157;3002.9249268768453;3015.1708280222674;3016.834074125944;5588.273524441796;5836.9124463133085;5886.264216972879;5928.258967629046;5933.199018132583;5704.543636509069;5734.655920644775;5748.540116790647;5794.88410231793;5896.380880007538;5940.673262970578;6091.695415229132;6097.451229389288;6098.847528811726;6126.785562505291;5822.184894114912;5826.970865145647;5855.3266374367495;5855.502282306052;5856.882862342814;5573.888522229451;5760.567957403296;5870.442307980735;5876.118582212703;5887.4406931341455;6116.694165291628;6130.754769809158;6140.907886381798;6142.969285153546;6157.753689852356;4063.4920634920636;4232.576742325743;4250.744955302692;4251.59609837065;4269.146170765921;5876.853078673067;5879.176915231786;5888.73283785737;5900.970495147497;5908.852278692895;5726.541876649775;5729.742161602655;5735.340435849931;5739.799107031234;5749.390170752196;5480.890382192413;5719.2279042328755;5729.9713501432225;5765.769369225184;5778.422157784356;5654.321481422256;5700.942990570207;5710.942890571041;5715.914261286167;5739.827805165852;5601.5238704710555;5742.971285143548;5761.48146666802;5785.871755007902;5793.333766616893;5590;5593.580481463825;5597.832065038056;5603.8879222416135;5608.915866262091 14:16:33 INFO - PROCESS | 1425 | |5;yui.html;766.7316439246265;778.5752073705119;779.1624004195488;817.8364327134573;874.6501399440219;15082.396704131836;15324.157171355571;15558;15873.206339683027;16158.030518168918;13474.326283685801;14296.71406571868;14549;14727.558173254793;14746.262686865668;817.648411183191;845.3575282785097;845.471580262336;849.1169184048582;849.2611428057598;846.0989046665312;850.8468475674376;851.6252848746562;854.0136142755127;854.2610641794834;888.0054339140172;888.9022207557164;892.3485855325616;893.1202765276198;893.7006102955518;885.234272354412;887.5917078144062;887.928965682747;889.1020069729619;889.4574309671128;646.6184950879004;650.0509256485536;650.2652003236312;650.9446697030758;650.9544331896769;13228.669283267898;13483.66290842727;13512.05415620907;14185.148891066568;14329.78505322421;12223.2666040037;12746.80879786804;12772.36138193096;12948;13027.28349940753;11288.040516556102;11326.320420774697;11412.600558980395;11541.307521548733;11668.533258669642;3802.9619703802887;3841.0695133813715;3898.8440462381473;3969.0672691917375;3993.0217096811175;40527;48815.26777098346;58466.70766646182;67760.3223967759;70688.99999999949;12089.818652720216;12294.569690060805;12323.507059717691;12340.81488777669;12375.566855160027;20965.89517052405;21003;21041.579168416545;21201.15195392167;21360.893195534234;8530.360222983301;8696.652133914698;8734.563271836383;8776.034636190014;8798.604062817061;4746.833860814855;4763.7618119094595;4824.396950381202;4836.226203807374;4844.32179494871;3626.5648122225502;3742.326381251401;3746.587875333711;3747;3748.5314335708035;608.8750261587118;630.0989584893555;635.5265327331075;638.5147288061107;639.5970538560676;679.3681875855502;687.2131409536054;694.2779509310361;698.6332175607846;704.1339152841931;8654.524001179869;9145.314101442418;9176.174144327042;9196.988331283554;9379.20276776468;567.6679142701565;610.786224821309;618.832915112917;627.3256249531771;662.3078882567728;4272.359146128106;4359.411479450234;4377.562243775661;4411.18393097278;4419.447569053868;90007;91690;92523.53738231266;93413.59879601811;95604;52182;64824.35175648278;66874.33125668779;66922;81415.59292203501;65036;67205.32794672088;67730;67955;68340;9778.853317200106;10087.546060427152;10098.343607665478;10254.128399086161;10270.178385728974;45133.0973380524;45398;45462.09075818399;45883;46304.30543541917;38946.80526597349;39617.40573891452;62109.689451552455;64595.4472503998;65994;12507;12626.936865315614;12656.493740250287;12809.743805124031;13098.541551045668;13878;14473.348699308766;14516.934758716818;14574;14617.707645846811;12110.75778484443;12530.812037819258;12682.239065656091;12873.935630321788;12911;12348.444320005801;12374.566890158801;12881.35593220354;13462.86537134616;13795.448182072605;13109.868901310865;13211.867881321064;13318.800217996932;13520.12119212248;13552;11214.943925280648;11360.602378916697;11406.258593191416;11451.370174640475;11906.165978670562;11541.538338466367;11676.182667213214;11769.17615766888;11793.705157371134;12021.639350819489 14:16:33 INFO - PROCESS | 1425 | __end_tp_report 14:16:33 INFO - PROCESS | 1425 | __start_cc_report 14:16:33 INFO - PROCESS | 1425 | _x_x_mozilla_cycle_collect,1009 14:16:33 INFO - PROCESS | 1425 | __end_cc_report 14:16:33 INFO - PROCESS | 1425 | __startTimestamp1484259393473__endTimestamp 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | ------- Summary: start ------- 14:16:33 INFO - PROCESS | 1425 | Number of tests: 6 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#0] dojo.html Cycles:165 Average:5569.21 Median:5801.04 stddev:649.19 (11.2%) stddev-sans-first:623.22 14:16:33 INFO - PROCESS | 1425 | Values: 3166.6 3179.6 3204.7 3217.7 3237.7 5532.4 5599.2 5618.9 5630.0 5631.2 5593.7 5634.5 5647.8 5670.6 5678.3 5111.4 5133.3 5151.3 5167.1 5208.9 5032.2 5207.6 5219.3 5222.6 5224.4 4999.4 5019.9 5084.3 5091.1 5125.5 5139.3 5192.3 5203.2 5256.1 5268.0 5092.8 5160.3 5225.8 5244.5 5265.5 5317.8 5369.6 5446.6 5507.2 5551.5 5836.9 5845.0 5845.5 5945.3 5949.7 6000.9 6001.6 6012.5 6018.9 6035.7 5460.5 5513.8 5609.9 5664.1 5673.1 6163.6 6177.0 6207.2 6208.4 6225.4 5954.3 5970.0 5982.4 5991.4 5993.6 5748.8 5784.9 5880.8 5911.4 5920.6 5976.5 5979.0 5980.4 6004.0 6004.2 5932.2 5979.5 5980.0 5986.4 5988.7 4280.5 4308.2 4375.7 4396.6 4400.1 4019.9 4026.2 4033.4 4042.2 4071.2 5783.5 5800.8 5801.0 5807.2 5820.7 5753.4 5805.4 5954.2 6084.0 6094.7 5734.4 5806.8 5829.8 5837.9 5847.1 5195.6 5202.2 5204.8 5206.8 5210.6 5973.9 6279.6 6330.9 6345.4 6346.7 5791.8 5896.6 5972.6 5972.9 6068.8 6229.5 6287.0 6290.2 6290.9 6295.7 5911.2 5913.5 5913.7 5916.1 5950.9 5784.7 5899.1 5947.6 5981.7 6007.9 5842.2 5878.8 5888.4 5892.6 5916.0 5873.3 5878.5 5881.7 5884.4 5890.6 5529.7 5648.3 5742.2 5797.7 5822.7 5931.6 5934.0 5952.5 5964.2 5965.3 5586.7 5744.7 5768.0 5771.9 5773.5 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#1] ext.html Cycles:180 Average:65494.30 Median:41050.09 stddev:133207.28 (324.5%) stddev-sans-first:133491.80 14:16:33 INFO - PROCESS | 1425 | Values: 580.5 641.9 647.4 674.0 674.9 35184.6 35783.3 38007.4 38027.6 38078.0 37843.4 38622.2 46590.3 47303.8 47529.5 8811.0 8930.1 8935.5 8936.5 8946.2 8783.2 8879.2 8885.2 8890.3 8893.5 8546.9 8749.1 8882.4 10672.3 10941.3 10664.0 10740.7 10756.1 10757.3 10765.9 10699.8 10793.4 10793.6 10793.8 10805.3 44157.0 44158.6 44422.3 44442.6 44574.8 3478.9 3507.4 3510.1 3514.3 3540.4 33074.8 33667.7 33816.7 34182.1 34714.5 4402.7 4449.3 4453.5 4467.6 4489.8 357651.0 357927.0 361233.0 362563.0 363498.2 61754.4 62111.0 62138.0 62213.0 62238.4 39590.0 41043.4 41056.8 43367.8 43455.6 19093.0 19227.3 19268.2 19268.4 19270.1 14243.8 14327.8 14330.6 14343.0 14345.4 18392.3 20571.9 20644.4 20650.7 20706.3 6107.5 7192.9 7295.2 7491.9 7651.1 1022.6 1098.5 1147.5 1162.6 1178.5 34445.5 34769.5 35018.0 35055.3 35182.1 1098.7 1156.4 1188.1 1193.1 1238.7 17784.6 18374.8 18384.4 18388.9 18489.4 543833.0 547059.0 549032.0 549761.0 549861.0 56089.4 57139.0 59664.1 63166.7 64047.7 1396.9 1405.9 1415.2 1428.3 1452.1 32684.7 35399.5 35752.6 35757.8 35812.3 55173.7 55625.0 55678.0 55724.2 55733.0 484993.0 501881.0 501882.0 662440.0 662788.0 45738.8 46070.0 46243.0 46441.5 46911.8 50259.5 50463.2 50575.5 50993.7 51221.0 43845.3 44384.6 44582.6 44754.1 45286.0 43771.6 44456.8 44774.8 44835.6 46017.5 43545.0 44360.3 44655.6 45111.3 45129.8 35722.3 37104.8 37841.6 38132.0 38170.8 29149.3 29602.6 29686.3 29787.3 30167.4 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#2] jquery.html Cycles:180 Average:30090.81 Median:24234.07 stddev:81789.12 (337.5%) stddev-sans-first:81988.16 14:16:33 INFO - PROCESS | 1425 | Values: 389.4 420.3 422.5 428.2 449.7 14759.8 19316.9 19327.8 19619.8 20546.3 12736.6 13256.0 13305.8 13365.5 13379.1 4160.0 4334.7 5400.4 5556.1 5560.7 5958.3 6211.3 6247.2 6255.8 6262.1 6039.1 6170.4 6199.8 6205.5 6264.1 6153.4 6190.4 6215.7 6216.2 6221.9 5980.9 6032.5 6033.2 6036.4 6039.9 15837.4 24068.8 24399.4 24439.3 24586.3 2257.9 2330.5 2576.2 2832.9 2837.0 10827.9 10906.8 11189.5 11367.7 11417.7 1960.3 1971.3 2002.0 2045.0 2124.8 89392.0 97881.5 97914.0 98131.0 100327.0 11461.6 11828.8 11860.8 12220.3 12292.0 17494.6 17505.0 17532.9 17537.9 17541.8 8813.3 8834.1 9028.5 9166.6 9194.2 8401.7 8824.5 9051.5 9080.4 9279.3 4783.2 5243.6 5266.6 5281.3 5291.6 1925.0 2009.2 2144.4 2209.3 2222.8 927.3 980.2 1006.9 1035.2 1077.3 20161.2 20415.7 20428.8 20524.2 20649.0 970.1 1006.5 1044.2 1069.8 1077.7 10692.8 11476.9 11496.1 11563.5 11645.9 484239.0 491523.0 494067.0 495089.0 501037.0 97232.0 97891.0 98320.0 100247.5 101186.0 947.5 984.0 994.9 1004.5 1010.2 17687.7 17698.9 18078.5 18080.9 18408.0 42767.4 44046.0 44359.8 44701.3 44800.6 60928.4 61558.0 61560.7 62473.4 64354.4 7813.9 8722.7 8772.8 9065.2 9108.7 13252.6 13479.5 14067.2 14257.4 14534.9 12016.2 12064.6 12200.8 12491.8 12579.6 11654.3 11740.8 12213.5 12383.1 12431.0 11991.5 12062.6 12541.5 12710.2 12870.7 8419.1 8484.6 8595.4 8632.2 8680.2 11096.0 12466.3 12499.1 12527.1 12772.9 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#3] mootools.html Cycles:180 Average:6002.92 Median:5172.47 stddev:3270.65 (63.2%) stddev-sans-first:3262.07 14:16:33 INFO - PROCESS | 1425 | Values: 1468.5 1499.1 1653.4 1801.9 1828.6 7409.5 7629.5 8484.4 9018.5 9018.7 8515.0 8777.6 8786.2 8985.0 8986.6 2522.4 2544.7 2546.7 2548.0 2550.8 2213.2 2288.7 2508.2 2558.3 2565.0 2402.0 2474.3 2480.0 2491.9 2501.3 2453.7 2463.4 2495.1 2506.5 2507.1 2451.5 2460.6 2480.0 2502.1 2515.6 8810.6 8944.5 9001.3 9005.2 9009.8 5468.5 5634.2 5637.2 5640.9 5649.7 3625.8 3817.3 3870.2 3890.2 3936.0 1172.7 1241.3 1243.7 1299.6 1304.3 12351.6 12451.5 12539.0 12543.7 12544.2 4868.4 5104.5 5145.5 5153.7 5191.2 10475.5 10481.5 10492.4 10494.0 10494.4 5694.1 5716.5 5723.9 5732.3 5733.1 5191.3 5269.9 5270.1 5327.4 5343.6 4170.7 4203.3 4237.0 4293.3 4301.8 1273.4 1300.2 1387.3 1410.8 1464.8 836.0 965.2 993.7 1019.8 1053.6 6232.8 6263.5 6397.0 6431.0 6475.1 977.0 989.1 1000.5 1003.7 1027.9 4297.7 4387.4 4417.2 4425.1 4455.7 10841.2 11091.8 11197.8 11231.2 11257.3 10724.9 10861.1 11047.7 11112.9 11122.0 8380.6 8382.9 8475.9 8480.1 8497.1 6143.9 6173.5 6178.1 6264.6 6267.2 10187.6 10242.2 10258.9 10283.0 10297.9 9737.0 9874.7 9974.8 10024.6 10313.2 7792.5 7958.6 7963.2 7967.4 7974.6 8311.6 8521.2 8592.5 8659.7 8666.3 7928.3 7982.4 8077.9 8136.5 8242.1 7617.2 7772.5 7829.9 7839.4 8123.2 7084.0 7279.2 7328.5 7331.7 7339.5 5483.4 5486.4 5533.7 5562.6 5762.7 5512.9 5673.5 5706.1 5710.9 5727.4 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#4] prototype.html Cycles:180 Average:4805.64 Median:5451.00 stddev:1401.17 (25.7%) stddev-sans-first:1364.72 14:16:33 INFO - PROCESS | 1425 | Values: 356.5 358.3 361.4 361.9 363.0 5457.5 5516.4 5517.9 5519.9 5543.6 5383.8 5401.2 5416.6 5430.0 5444.5 3787.7 4059.6 4272.9 4306.6 4337.1 4311.6 4324.8 4326.4 4331.2 4342.6 4299.8 4306.4 4309.9 4311.7 4317.2 4062.7 4110.8 4267.4 4285.6 4315.0 3819.9 3825.5 3837.4 3845.2 3872.1 5309.0 5324.1 5345.9 5349.4 5353.6 4741.0 4883.9 4905.6 4908.4 4944.2 5642.8 5662.6 5667.6 5670.8 5693.8 4245.0 4249.5 4255.8 4256.6 4258.2 5622.7 5892.3 5902.5 5911.7 5956.6 4196.7 4207.8 4210.4 4224.6 4231.2 4275.7 4276.6 4283.7 4284.1 4284.4 4755.2 4811.8 4858.5 4863.7 4873.7 5604.6 5683.5 5707.4 5727.3 5730.9 1416.9 1427.4 1430.7 1444.9 1445.9 973.7 980.8 984.8 992.4 1020.0 5375.3 5377.0 5396.4 5399.8 5407.4 5656.2 5659.5 5672.4 5676.3 5681.1 5214.5 5365.4 5367.8 5390.8 5398.0 2998.5 3001.5 3002.9 3015.2 3016.8 5588.3 5836.9 5886.3 5928.3 5933.2 5704.5 5734.7 5748.5 5794.9 5896.4 5940.7 6091.7 6097.5 6098.8 6126.8 5822.2 5827.0 5855.3 5855.5 5856.9 5573.9 5760.6 5870.4 5876.1 5887.4 6116.7 6130.8 6140.9 6143.0 6157.8 4063.5 4232.6 4250.7 4251.6 4269.1 5876.9 5879.2 5888.7 5901.0 5908.9 5726.5 5729.7 5735.3 5739.8 5749.4 5480.9 5719.2 5730.0 5765.8 5778.4 5654.3 5700.9 5710.9 5715.9 5739.8 5601.5 5743.0 5761.5 5785.9 5793.3 5590.0 5593.6 5597.8 5603.9 5608.9 14:16:33 INFO - PROCESS | 1425 | 14:16:33 INFO - PROCESS | 1425 | [#5] yui.html Cycles:180 Average:17379.81 Median:4415.32 stddev:22630.57 (512.5%) stddev-sans-first:22659.67 14:16:33 INFO - PROCESS | 1425 | Values: 766.7 778.6 779.2 817.8 874.7 15082.4 15324.2 15558.0 15873.2 16158.0 13474.3 14296.7 14549.0 14727.6 14746.3 817.6 845.4 845.5 849.1 849.3 846.1 850.8 851.6 854.0 854.3 888.0 888.9 892.3 893.1 893.7 885.2 887.6 887.9 889.1 889.5 646.6 650.1 650.3 650.9 651.0 13228.7 13483.7 13512.1 14185.1 14329.8 12223.3 12746.8 12772.4 12948.0 13027.3 11288.0 11326.3 11412.6 11541.3 11668.5 3803.0 3841.1 3898.8 3969.1 3993.0 40527.0 48815.3 58466.7 67760.3 70689.0 12089.8 12294.6 12323.5 12340.8 12375.6 20965.9 21003.0 21041.6 21201.2 21360.9 8530.4 8696.7 8734.6 8776.0 8798.6 4746.8 4763.8 4824.4 4836.2 4844.3 3626.6 3742.3 3746.6 3747.0 3748.5 608.9 630.1 635.5 638.5 639.6 679.4 687.2 694.3 698.6 704.1 8654.5 9145.3 9176.2 9197.0 9379.2 567.7 610.8 618.8 627.3 662.3 4272.4 4359.4 4377.6 4411.2 4419.4 90007.0 91690.0 92523.5 93413.6 95604.0 52182.0 64824.4 66874.3 66922.0 81415.6 65036.0 67205.3 67730.0 67955.0 68340.0 9778.9 10087.5 10098.3 10254.1 10270.2 45133.1 45398.0 45462.1 45883.0 46304.3 38946.8 39617.4 62109.7 64595.4 65994.0 12507.0 12626.9 12656.5 12809.7 13098.5 13878.0 14473.3 14516.9 14574.0 14617.7 12110.8 12530.8 12682.2 12873.9 12911.0 12348.4 12374.6 12881.4 13462.9 13795.4 13109.9 13211.9 13318.8 13520.1 13552.0 11214.9 11360.6 11406.3 11451.4 11906.2 11541.5 11676.2 11769.2 11793.7 12021.6 14:16:33 INFO - PROCESS | 1425 | -------- Summary: end -------- 14:16:33 INFO - PROCESS | 1425 | 14:16:34 INFO - TEST-INFO | 1425: exit 0 14:16:34 INFO - TEST-OK | dromaeo_css | took 1114756ms 14:16:34 INFO - TEST-START | kraken 14:16:34 INFO - operating with platform_type : linux_ 14:16:34 INFO - Initialising browser for kraken test... 14:16:34 INFO - TEST-INFO | started process 1748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSHoLH_/profile http://localhost:45355/getInfo.html) 14:16:37 INFO - PROCESS | 1748 | __metrics Screen width/height:1600/1200 14:16:37 INFO - PROCESS | 1748 | colorDepth:24 14:16:37 INFO - PROCESS | 1748 | Browser inner width/height: 1024/697 14:16:37 INFO - PROCESS | 1748 | __metrics 14:16:38 INFO - PROCESS | 1748 | 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" 14:16:38 INFO - PROCESS | 1748 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:39 INFO - PROCESS | 1748 | console.error: PushService: 14:16:39 INFO - PROCESS | 1748 | stateChangeProcessEnqueue: Error transitioning state 14:16:39 INFO - PROCESS | 1748 | UnknownError 14:16:39 INFO - TEST-INFO | 1748: exit 0 14:16:39 INFO - Browser initialized. 14:16:39 INFO - Running cycle 1/1 for kraken test... 14:16:39 INFO - TEST-INFO | started process 1840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSHoLH_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:51 INFO - PROCESS | 1840 | RSS: Main: 144265216 14:16:51 INFO - PROCESS | 1840 | 14:16:53 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection) 14:16:54 INFO - PROCESS | 1840 | RSS: Main: 185049088 14:16:54 INFO - PROCESS | 1840 | 14:16:57 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-dft) 14:16:57 INFO - PROCESS | 1840 | RSS: Main: 175431680 14:16:57 INFO - PROCESS | 1840 | 14:17:00 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-fft) 14:17:01 INFO - PROCESS | 1840 | RSS: Main: 267096064 14:17:01 INFO - PROCESS | 1840 | 14:17:03 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator) 14:17:03 INFO - PROCESS | 1840 | RSS: Main: 173277184 14:17:03 INFO - PROCESS | 1840 | 14:17:06 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:06 INFO - PROCESS | 1840 | RSS: Main: 176025600 14:17:06 INFO - PROCESS | 1840 | 14:17:09 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:10 INFO - PROCESS | 1840 | RSS: Main: 213647360 14:17:10 INFO - PROCESS | 1840 | 14:17:13 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:14 INFO - PROCESS | 1840 | RSS: Main: 212365312 14:17:14 INFO - PROCESS | 1840 | 14:17:16 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial) 14:17:17 INFO - PROCESS | 1840 | RSS: Main: 212209664 14:17:17 INFO - PROCESS | 1840 | 14:17:18 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:19 INFO - PROCESS | 1840 | RSS: Main: 174387200 14:17:19 INFO - PROCESS | 1840 | 14:17:21 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:21 INFO - PROCESS | 1840 | RSS: Main: 181440512 14:17:21 INFO - PROCESS | 1840 | 14:17:23 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:24 INFO - PROCESS | 1840 | RSS: Main: 190054400 14:17:24 INFO - PROCESS | 1840 | 14:17:26 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:27 INFO - PROCESS | 1840 | RSS: Main: 199073792 14:17:27 INFO - PROCESS | 1840 | 14:17:30 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:30 INFO - PROCESS | 1840 | RSS: Main: 195276800 14:17:30 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | Cycle 1(1): loaded http://localhost:45355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45355/tests/kraken/driver.html?testName=ai-astar) 14:17:32 INFO - PROCESS | 1840 | RSS: Main: 247615488 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | __start_tp_report 14:17:32 INFO - PROCESS | 1840 | _x_x_mozilla_page_load 14:17:32 INFO - PROCESS | 1840 | _x_x_mozilla_page_load_details 14:17:32 INFO - PROCESS | 1840 | |i|pagename|runs| 14:17:32 INFO - PROCESS | 1840 | |0;ai-astar;101;110;111;111;112;110;110;110;110;110 14:17:32 INFO - PROCESS | 1840 | |1;audio-beat-detection;148;123;123;153;120;117;120;116;154;123 14:17:32 INFO - PROCESS | 1840 | |2;audio-dft;162;161;163;162;162;160;162;163;161;161 14:17:32 INFO - PROCESS | 1840 | |3;audio-fft;76;75;74;109;75;76;78;76;96;75 14:17:32 INFO - PROCESS | 1840 | |4;audio-oscillator;82;83;117;82;81;81;105;81;82;119 14:17:32 INFO - PROCESS | 1840 | |5;imaging-gaussian-blur;117;116;116;117;116;116;117;117;117;117 14:17:32 INFO - PROCESS | 1840 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 14:17:32 INFO - PROCESS | 1840 | |7;imaging-desaturate;86;84;84;85;84;85;84;85;85;84 14:17:32 INFO - PROCESS | 1840 | |8;json-parse-financial;53;50;54;50;51;52;53;52;50;54 14:17:32 INFO - PROCESS | 1840 | |9;json-stringify-tinderbox;59;58;58;58;63;59;59;59;59;58 14:17:32 INFO - PROCESS | 1840 | |10;stanford-crypto-aes;75;74;82;75;74;74;78;74;74;75 14:17:32 INFO - PROCESS | 1840 | |11;stanford-crypto-ccm;128;124;130;127;138;129;128;121;157;141 14:17:32 INFO - PROCESS | 1840 | |12;stanford-crypto-pbkdf2;157;156;155;157;156;157;153;154;153;154 14:17:32 INFO - PROCESS | 1840 | |13;stanford-crypto-sha256-iterative;64;62;63;62;63;70;61;61;61;61 14:17:32 INFO - PROCESS | 1840 | __end_tp_report 14:17:32 INFO - PROCESS | 1840 | __start_cc_report 14:17:32 INFO - PROCESS | 1840 | _x_x_mozilla_cycle_collect,1594 14:17:32 INFO - PROCESS | 1840 | __end_cc_report 14:17:32 INFO - PROCESS | 1840 | __startTimestamp1484259452640__endTimestamp 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | ------- Summary: start ------- 14:17:32 INFO - PROCESS | 1840 | Number of tests: 14 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.73 14:17:32 INFO - PROCESS | 1840 | Values: 101.0 110.0 111.0 111.0 112.0 110.0 110.0 110.0 110.0 110.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:123.00 stddev:15.42 (12.5%) stddev-sans-first:14.87 14:17:32 INFO - PROCESS | 1840 | Values: 148.0 123.0 123.0 153.0 120.0 117.0 120.0 116.0 154.0 123.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 14:17:32 INFO - PROCESS | 1840 | Values: 162.0 161.0 163.0 162.0 162.0 160.0 162.0 163.0 161.0 161.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.79 (15.5%) stddev-sans-first:12.36 14:17:32 INFO - PROCESS | 1840 | Values: 76.0 75.0 74.0 109.0 75.0 76.0 78.0 76.0 96.0 75.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:81.50 stddev:15.85 (19.5%) stddev-sans-first:16.45 14:17:32 INFO - PROCESS | 1840 | Values: 82.0 83.0 117.0 82.0 81.0 81.0 105.0 81.0 82.0 119.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:17:32 INFO - PROCESS | 1840 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 14:17:32 INFO - PROCESS | 1840 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 14:17:32 INFO - PROCESS | 1840 | Values: 86.0 84.0 84.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.50 stddev:1.60 (3.0%) stddev-sans-first:1.64 14:17:32 INFO - PROCESS | 1840 | Values: 53.0 50.0 54.0 50.0 51.0 52.0 53.0 52.0 50.0 54.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:1.49 (2.5%) stddev-sans-first:1.58 14:17:32 INFO - PROCESS | 1840 | Values: 59.0 58.0 58.0 58.0 63.0 59.0 59.0 59.0 59.0 58.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.59 (3.5%) stddev-sans-first:2.74 14:17:32 INFO - PROCESS | 1840 | Values: 75.0 74.0 82.0 75.0 74.0 74.0 78.0 74.0 74.0 75.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:129.50 stddev:10.52 (8.1%) stddev-sans-first:11.04 14:17:32 INFO - PROCESS | 1840 | Values: 128.0 124.0 130.0 127.0 138.0 129.0 128.0 121.0 157.0 141.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:1.62 (1.0%) stddev-sans-first:1.58 14:17:32 INFO - PROCESS | 1840 | Values: 157.0 156.0 155.0 157.0 156.0 157.0 153.0 154.0 153.0 154.0 14:17:32 INFO - PROCESS | 1840 | 14:17:32 INFO - PROCESS | 1840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:2.74 (4.4%) stddev-sans-first:2.87 14:17:32 INFO - PROCESS | 1840 | Values: 64.0 62.0 63.0 62.0 63.0 70.0 61.0 61.0 61.0 61.0 14:17:32 INFO - PROCESS | 1840 | -------- Summary: end -------- 14:17:32 INFO - PROCESS | 1840 | 14:17:33 INFO - TEST-INFO | 1840: exit 0 14:17:33 INFO - TEST-OK | kraken | took 59485ms 14:17:33 INFO - SUITE-END | took 1174s 14:17:33 INFO - Completed test suite (00:19:34) 14:17:33 INFO - javascript benchmark 14:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.6358368787587, 3179.60254968129, 3204.7275981541575, 3217.678232176783, 3237.692419220173, 5532.446755324466, 5599.244102046223, 5618.943810561904, 5629.971850140743, 5631.239782629344, 5593.664380137185, 5634.521065709409, 5647.830565083054, 5670.631408958415, 5678.290213723285, 5111.437741848394, 5133.255677926699, 5151.253068305094, 5167.121589329823, 5208.921866172011, 5032.194848824171, 5207.6354655174155, 5219.269302297681, 5222.608304377168, 5224.39919409269, 4999.425066117388, 5019.899602007958, 5084.262781896623, 5091.0581542414775, 5125.487451254882, 5139.306193663845, 5192.324997750287, 5203.19350500673, 5256.106461901486, 5268.025415298182, 5092.79628814847, 5160.251763494272, 5225.790968361261, 5244.527992480657, 5265.52610265078, 5317.8404647860625, 5369.62412631116, 5446.618736688394, 5507.228987941691, 5551.528120109796, 5836.883262334772, 5844.970775146139, 5845.503132233765, 5945.256842894638, 5949.6727679977585, 6000.939990600082, 6001.639901605874, 6012.488938440238, 6018.879622407528, 6035.698215089228, 5460.535854452376, 5513.751881165317, 5609.943900561024, 5664.093745000862, 5673.092305231144, 6163.630182188993, 6177.0, 6207.16203312547, 6208.441240288395, 6225.439710426083, 5954.3152537458745, 5969.970150149222, 5982.40175982407, 5991.430814072656, 5993.550483713739, 5748.798792042342, 5784.94215057844, 5880.8235752927485, 5911.438413350725, 5920.5559583031445, 5976.491998180117, 5978.970105149447, 5980.372060933626, 6004.0, 6004.219451471281, 5932.228810254725, 5979.491743201789, 5979.970100149559, 5986.4013598639785, 5988.700564971734, 4280.5291417944, 4308.18144552534, 4375.7155784873885, 4396.560343965578, 4400.119976004812, 4019.8995025124605, 4026.2350153470748, 4033.3748269018347, 4042.2319759245647, 4071.1654110907193, 5783.450572195635, 5800.8259752207505, 5801.042827933428, 5807.245058142499, 5820.738066787005, 5753.367129615739, 5805.36141024487, 5954.196183515257, 6083.969580152159, 6094.664793436404, 5734.397888221677, 5806.82579522615, 5829.8251052468495, 5837.94162058374, 5847.1229315603, 5195.636305458582, 5202.2196670499725, 5204.843854684365, 5206.7917283309, 5210.5831533477985, 5973.910391344047, 6279.560430769802, 6330.936690633035, 6345.397187267202, 6346.746130154835, 5791.768329266951, 5896.616719913192, 5972.552058595709, 5972.880542389041, 6068.787592434243, 6229.470495007975, 6287.0, 6290.150829637941, 6290.874182516415, 6295.716692748929, 5911.201987731602, 5913.497352724895, 5913.733881975236, 5916.142159386951, 5950.910736338872, 5784.7107644618445, 5899.085641725539, 5947.6431414115295, 5981.671008094597, 6007.939920600738, 5842.211301474246, 5878.764849405976, 5888.440598143169, 5892.646441213541, 5916.023856063702, 5873.295204575478, 5878.529717622666, 5881.73532191061, 5884.411558844081, 5890.617109887844, 5529.668219906818, 5648.265725455664, 5742.224799652161, 5797.681127538026, 5822.679752613647, 5931.555133365101, 5934.0, 5952.464278214981, 5964.165016897725, 5965.313988891159, 5586.664800112007, 5744.741486633028, 5768.0, 5771.884562308646, 5773.451522105393], "value": 5523.854440238469, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.457272450259, 641.9165508483896, 647.3526473526474, 674.0159367323704, 674.8549061951679, 35184.64815351846, 35783.28433431333, 38007.42988855169, 38027.61972380275, 38078.048048798795, 37843.4323485148, 38622.22755544887, 46590.301145482845, 47303.76348118263, 47529.52470475294, 8811.0, 8930.106989301083, 8935.508547029911, 8936.463812171258, 8946.150115738994, 8783.165599268059, 8879.156480134377, 8885.200331970122, 8890.288776897833, 8893.4663920165, 8546.914530854705, 8749.081346458626, 8882.378233523656, 10672.252942294042, 10941.28881622696, 10664.0, 10740.677779666623, 10756.139508839275, 10757.300775449648, 10765.946170269177, 10699.786004279871, 10793.406362650052, 10793.5682572697, 10793.838092428541, 10805.297655652357, 44157.0, 44158.55841441577, 44422.33366499505, 44442.555574444166, 44574.77712611416, 3478.9478157827652, 3507.4037413639744, 3510.069831494656, 3514.2795726876184, 3540.3627347077772, 33074.83462582696, 33667.663323366694, 33816.6618333816, 34182.14544636379, 34714.479282810775, 4402.713823601488, 4449.307075127668, 4453.487848897385, 4467.553244675506, 4489.775511224426, 357651.0, 357927.0, 361233.0, 362563.0, 363498.1825090884, 61754.382456175765, 62111.0, 62138.0, 62213.0, 62238.37761622416, 39590.0, 41043.38434923479, 41056.79471602623, 43367.783161084626, 43455.56544434578, 19093.0, 19227.327043553407, 19268.22927082901, 19268.4219473416, 19270.132844022053, 14243.78634320486, 14327.78508322376, 14330.57008289753, 14343.0, 14345.354459049368, 18392.26430942747, 20571.897140514502, 20644.38066857997, 20650.690239646417, 20706.275280365116, 6107.450329470369, 7192.892106618405, 7295.161056478573, 7491.850162996819, 7651.120121186023, 1022.5602990713916, 1098.4946924414699, 1147.5295128997238, 1162.604714397109, 1178.5462596900254, 34445.48331775025, 34769.478457822646, 35018.0, 35055.29889402249, 35182.12044698903, 1098.6758906122714, 1156.3524426321287, 1188.1326631559011, 1193.1111322065117, 1238.6779437346354, 17784.644307113784, 18374.81625183758, 18384.448466546026, 18388.908055459906, 18489.352872649393, 543833.0, 547059.0, 549032.0, 549761.0, 549861.0, 56089.43910560842, 57139.0, 59664.10503842446, 63166.684166578874, 64047.67976160089, 1396.8812650924785, 1405.8875289976777, 1415.1579810013027, 1428.3144090836456, 1452.063419094678, 32684.673153268162, 35399.469007964384, 35752.64247357597, 35757.82121089378, 35812.28375432529, 55173.72413137909, 55625.0, 55678.0, 55724.16413753878, 55733.0, 484993.0, 501881.0, 501882.0, 662440.0, 662788.0, 45738.77130614326, 46070.0, 46243.0, 46441.53558464507, 46911.765441172574, 50259.49740502548, 50463.24305135499, 50575.49424505855, 50993.74503127461, 51221.0, 43845.342319865864, 44384.55615443804, 44582.55417445914, 44754.05598854852, 45286.0, 43771.56228437802, 44456.77771611121, 44774.77612611916, 44835.55164448314, 46017.53982460133, 43545.0, 44360.334594981745, 44655.55344446514, 45111.32333014942, 45129.774351128035, 35722.28555428929, 37104.81447592745, 37841.62158378381, 38132.0, 38170.809145954096, 29149.271268218465, 29602.555961661023, 29686.257843554085, 29787.255318617208, 30167.396652067273], "value": 21405.594423843504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.4158761857214, 420.2960041929767, 422.4972282983249, 428.15866821695374, 449.67398635988894, 14759.77860332096, 19316.903415482902, 19327.806721932793, 19619.80380196201, 20546.28088016916, 12736.55422060228, 13256.0, 13305.800412993813, 13365.532206372778, 13379.130356526819, 4159.958400416002, 4334.739915605074, 5400.351957765064, 5556.138798486241, 5560.749766260507, 5958.314793798703, 6211.254649442073, 6247.219097612799, 6255.843603909916, 6262.12330273762, 6039.094135879609, 6170.413810687977, 6199.752009919598, 6205.5345849061505, 6264.091706702526, 6153.446189842891, 6190.41191086846, 6215.720292586844, 6216.191895053659, 6221.937780622181, 5980.910286345708, 6032.547558933097, 6033.185519954794, 6036.396360363972, 6039.879202415971, 15837.366505339773, 24068.759312406826, 24399.390015249584, 24439.26682199537, 24586.262412127664, 2257.8758168300737, 2330.475642980333, 2576.1756238003845, 2832.872520736572, 2836.957445638317, 10827.891721082768, 10906.836397454044, 11189.49647265875, 11367.715807104805, 11417.714557136138, 1960.2746983616153, 1971.3001884331, 2001.989990050055, 2044.9795502044938, 2124.830013598924, 89392.0, 97881.51059244658, 97914.0208597912, 98130.99999999929, 100327.0, 11461.598844040585, 11828.822567661491, 11860.76278474443, 12220.3278819664, 12292.0, 17494.562635933948, 17505.0, 17532.912335438243, 17537.912310438365, 17541.824581754274, 8813.25087367568, 8834.072422395557, 9028.458292502472, 9166.633334666538, 9194.218491428304, 8401.705940292182, 8824.514651694219, 9051.547422628842, 9080.364374493854, 9279.257659387233, 4783.234682450791, 5243.580513558906, 5266.552343050884, 5281.313429254173, 5291.603129765283, 1924.9903750481158, 2009.166196028661, 2144.3888491779767, 2209.281983355416, 2222.7888350606668, 927.2628260532892, 980.2011360740973, 1006.9345492542961, 1035.2132379391717, 1077.3051381858813, 20161.193552257744, 20415.693764593543, 20428.79571204269, 20524.179032838816, 20649.0, 970.1075010989906, 1006.4716024087267, 1044.195969103801, 1069.844872493484, 1077.7413420778958, 10692.786144277072, 11476.942615286871, 11496.137789665809, 11563.479643416067, 11645.883541164649, 484239.0, 491523.0, 494067.0, 495089.0, 501037.0, 97232.0, 97891.0, 98320.0, 100247.49876250573, 101186.0, 947.4930911962067, 983.975400614976, 994.8557459168525, 1004.542932965499, 1010.151472762868, 17687.734683979492, 17698.91150544239, 18078.45764627063, 18080.90959545194, 18408.0, 42767.3584896233, 44046.0, 44359.77820110879, 44701.32948005848, 44800.55199447964, 60928.39071609227, 61558.0, 61560.69219653873, 62473.37526624675, 64354.35645643671, 7813.921860781319, 8722.67328258698, 8772.824543508967, 9065.184133428023, 9108.681196158102, 13252.602421927357, 13479.460821567027, 14067.155970641794, 14257.358418870968, 14534.85465145335, 12016.218945768496, 12064.638060857837, 12200.755984880076, 12491.75016499683, 12579.622611321674, 11654.30074195551, 11740.823887641864, 12213.511459541518, 12383.133180677627, 12431.0, 11991.460384282555, 12062.577809776616, 12541.498340066295, 12710.173838700455, 12870.67823304425, 8419.115992820665, 8484.61819218149, 8595.355348348774, 8632.223099920786, 8680.21878030955, 11096.0, 12466.252024878537, 12499.125061245626, 12527.123101382816, 12772.87227127754], "value": 9604.658979385411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.456671031718, 1499.1005396761943, 1653.4130383713782, 1801.8828776129542, 1828.6251318479722, 7409.48133630646, 7629.465937384385, 8484.406091573584, 9018.458892466448, 9018.684346047898, 8515.0, 8777.648894044247, 8786.165314295147, 8984.955075224614, 8986.640534378617, 2522.369407648088, 2544.694636643596, 2546.6562014128135, 2548.0444833187553, 2550.7831834294016, 2213.1921848525253, 2288.702468679069, 2508.1723031399683, 2558.2581051495135, 2564.999650136439, 2402.027178992511, 2474.270090323359, 2480.0, 2491.9003239870385, 2501.2996361018854, 2453.717822450414, 2463.4334103156284, 2495.0892924082577, 2506.548821212181, 2507.0723832182025, 2451.460678650694, 2460.6186041163646, 2480.045182604692, 2502.1367628168255, 2515.622656601506, 8810.603522841488, 8944.508052057134, 9001.279897608176, 9005.234555062762, 9009.774755631097, 5468.453154684539, 5634.183043458716, 5637.154426835967, 5640.858978525529, 5649.717514124319, 3625.782453052825, 3817.2938006468894, 3870.1679138984973, 3890.1636148227985, 3935.9803200984097, 1172.7185475485908, 1241.2986662535639, 1243.6828608704723, 1299.571141523295, 1304.2500562176692, 12351.629451116482, 12451.501939922393, 12539.0, 12543.749125017539, 12544.184627999151, 4868.440129385166, 5104.464031276737, 5145.511176438233, 5153.742312884341, 5191.195364718475, 10475.528601212964, 10481.475926203659, 10492.370457772558, 10494.0, 10494.370337779757, 5694.117411801178, 5716.485516303553, 5723.942760572424, 5732.283464566929, 5733.111367738007, 5191.32512773337, 5269.894602107936, 5270.1040823060175, 5327.360716713942, 5343.599230057761, 4170.72890262132, 4203.306454434984, 4236.957630423656, 4293.2701440755145, 4301.806418711166, 1273.4333221716247, 1300.2393599744066, 1387.341013018828, 1410.7742761158165, 1464.8461911499353, 835.9665613375397, 965.1844191658038, 993.6770549571273, 1019.7705516258931, 1053.599632139782, 6232.750689972441, 6263.467605253604, 6396.968015159988, 6430.967845160744, 6475.061116138228, 976.9804603907882, 989.1493315748451, 1000.4847503535685, 1003.6637726361605, 1027.8869324374314, 4297.677674174387, 4387.363832244307, 4417.204903117469, 4425.137098265872, 4455.68810183284, 10841.241113122163, 11091.833622495507, 11197.832032519518, 11231.15766317513, 11257.268277561932, 10724.89275107239, 10861.07680847121, 11047.668569942914, 11112.944435277934, 11122.0, 8380.580970951429, 8382.916170838458, 8475.872861907077, 8480.067192608809, 8497.065322814486, 6143.877122457437, 6173.475254603409, 6178.104174894705, 6264.561480696308, 6267.2479302484, 10187.643432479828, 10242.180625549789, 10258.897411025795, 10283.0, 10297.9485102577, 9736.95131524338, 9874.654387096418, 9974.800503990025, 10024.599016039278, 10313.22650801178, 7792.493487923267, 7958.602069896598, 7963.243491868263, 7967.442279040411, 7974.601269936364, 8311.625976830936, 8521.190486903733, 8592.484450932963, 8659.653613855375, 8666.263367613823, 7928.31849125207, 7982.361411086983, 8077.87883181741, 8136.511809291462, 8242.093369729444, 7617.200193979553, 7772.45592808498, 7829.942957700638, 7839.412044096602, 8123.18768123183, 7083.964580177066, 7279.162896266997, 7328.487005909536, 7331.706731730671, 7339.486235963432, 5483.396826349178, 5486.396496385474, 5533.6956467393065, 5562.610617256915, 5762.740676669476, 5512.944870551243, 5673.489385955284, 5706.144078388275, 5710.914336285042, 5727.369989301257], "value": 4869.437589366026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5240404060578, 358.2601927020703, 361.4253337193863, 361.92942376236647, 362.9582598001231, 5457.536109430698, 5516.365617953937, 5517.944820551793, 5519.9448005519935, 5543.6396634218745, 5383.81156659517, 5401.216823560581, 5416.593755468346, 5430.0, 5444.455554444554, 3787.6591106800383, 4059.614336638022, 4272.931767058236, 4306.57371711644, 4337.110892267094, 4311.6335111515555, 4324.82700691972, 4326.394304797331, 4331.155424692186, 4342.609165175134, 4299.828006879737, 4306.440162778835, 4309.913801723964, 4311.676624253178, 4317.179735850178, 4062.6546743526837, 4110.787317741274, 4267.359896015591, 4285.635720963722, 4315.0, 3819.9427008594894, 3825.5218097737784, 3837.4435706822633, 3845.1540661054523, 3872.1481274119647, 5309.017831701148, 5324.1215199492035, 5345.893082138375, 5349.43830897754, 5353.57171426285, 4740.952590474086, 4883.926741098886, 4905.6320775941595, 4908.361912951329, 4944.208926571731, 5642.7742890284335, 5662.6036177467595, 5667.603267771257, 5670.829875103754, 5693.77224911003, 4245.0, 4249.511306199795, 4255.829766809324, 4256.573458366014, 4258.212230737324, 5622.690752008638, 5892.263467066617, 5902.498287645555, 5911.704414779244, 5956.583039187215, 4196.727212731163, 4207.789610519461, 4210.431591735077, 4224.619784219435, 4231.238377092153, 4275.700700950966, 4276.593723596254, 4283.678724095643, 4284.100338928797, 4284.400183974246, 4755.2153894607, 4811.797050737316, 4858.5384388483035, 4863.689747370042, 4873.731944743073, 5604.6356986796545, 5683.499260325526, 5707.404335268837, 5727.341355744143, 5730.856728581819, 1416.8653977872086, 1427.421894132878, 1430.7281616492833, 1444.949426770079, 1445.8626430489087, 973.728797055448, 980.8283550378655, 984.7542858284277, 992.4243938515788, 1019.9698304712294, 5375.274337964324, 5376.973115134478, 5396.379416367168, 5399.811006614828, 5407.378151512547, 5656.179853921159, 5659.518940889988, 5672.376038635747, 5676.318841739017, 5681.147827825776, 5214.504622060898, 5365.409804921455, 5367.75845086972, 5390.811321603725, 5397.973010134924, 2998.5352270398125, 3001.529250667157, 3002.9249268768453, 3015.1708280222674, 3016.834074125944, 5588.273524441796, 5836.9124463133085, 5886.264216972879, 5928.258967629046, 5933.199018132583, 5704.543636509069, 5734.655920644775, 5748.540116790647, 5794.88410231793, 5896.380880007538, 5940.673262970578, 6091.695415229132, 6097.451229389288, 6098.847528811726, 6126.785562505291, 5822.184894114912, 5826.970865145647, 5855.3266374367495, 5855.502282306052, 5856.882862342814, 5573.888522229451, 5760.567957403296, 5870.442307980735, 5876.118582212703, 5887.4406931341455, 6116.694165291628, 6130.754769809158, 6140.907886381798, 6142.969285153546, 6157.753689852356, 4063.4920634920636, 4232.576742325743, 4250.744955302692, 4251.59609837065, 4269.146170765921, 5876.853078673067, 5879.176915231786, 5888.73283785737, 5900.970495147497, 5908.852278692895, 5726.541876649775, 5729.742161602655, 5735.340435849931, 5739.799107031234, 5749.390170752196, 5480.890382192413, 5719.2279042328755, 5729.9713501432225, 5765.769369225184, 5778.422157784356, 5654.321481422256, 5700.942990570207, 5710.942890571041, 5715.914261286167, 5739.827805165852, 5601.5238704710555, 5742.971285143548, 5761.48146666802, 5785.871755007902, 5793.333766616893, 5590.0, 5593.580481463825, 5597.832065038056, 5603.8879222416135, 5608.915866262091], "value": 4363.692781149626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.7316439246265, 778.5752073705119, 779.1624004195488, 817.8364327134573, 874.6501399440219, 15082.396704131836, 15324.157171355571, 15558.0, 15873.206339683027, 16158.030518168918, 13474.326283685801, 14296.71406571868, 14549.0, 14727.558173254793, 14746.262686865668, 817.648411183191, 845.3575282785097, 845.471580262336, 849.1169184048582, 849.2611428057598, 846.0989046665312, 850.8468475674376, 851.6252848746562, 854.0136142755127, 854.2610641794834, 888.0054339140172, 888.9022207557164, 892.3485855325616, 893.1202765276198, 893.7006102955518, 885.234272354412, 887.5917078144062, 887.928965682747, 889.1020069729619, 889.4574309671128, 646.6184950879004, 650.0509256485536, 650.2652003236312, 650.9446697030758, 650.9544331896769, 13228.669283267898, 13483.66290842727, 13512.05415620907, 14185.148891066568, 14329.78505322421, 12223.2666040037, 12746.80879786804, 12772.36138193096, 12948.0, 13027.28349940753, 11288.040516556102, 11326.320420774697, 11412.600558980395, 11541.307521548733, 11668.533258669642, 3802.9619703802887, 3841.0695133813715, 3898.8440462381473, 3969.0672691917375, 3993.0217096811175, 40527.0, 48815.26777098346, 58466.70766646182, 67760.3223967759, 70688.99999999949, 12089.818652720216, 12294.569690060805, 12323.507059717691, 12340.81488777669, 12375.566855160027, 20965.89517052405, 21003.0, 21041.579168416545, 21201.15195392167, 21360.893195534234, 8530.360222983301, 8696.652133914698, 8734.563271836383, 8776.034636190014, 8798.604062817061, 4746.833860814855, 4763.7618119094595, 4824.396950381202, 4836.226203807374, 4844.32179494871, 3626.5648122225502, 3742.326381251401, 3746.587875333711, 3747.0, 3748.5314335708035, 608.8750261587118, 630.0989584893555, 635.5265327331075, 638.5147288061107, 639.5970538560676, 679.3681875855502, 687.2131409536054, 694.2779509310361, 698.6332175607846, 704.1339152841931, 8654.524001179869, 9145.314101442418, 9176.174144327042, 9196.988331283554, 9379.20276776468, 567.6679142701565, 610.786224821309, 618.832915112917, 627.3256249531771, 662.3078882567728, 4272.359146128106, 4359.411479450234, 4377.562243775661, 4411.18393097278, 4419.447569053868, 90007.0, 91690.0, 92523.53738231266, 93413.59879601811, 95604.0, 52182.0, 64824.35175648278, 66874.33125668779, 66922.0, 81415.59292203501, 65036.0, 67205.32794672088, 67730.0, 67955.0, 68340.0, 9778.853317200106, 10087.546060427152, 10098.343607665478, 10254.128399086161, 10270.178385728974, 45133.0973380524, 45398.0, 45462.09075818399, 45883.0, 46304.30543541917, 38946.80526597349, 39617.40573891452, 62109.689451552455, 64595.4472503998, 65994.0, 12507.0, 12626.936865315614, 12656.493740250287, 12809.743805124031, 13098.541551045668, 13878.0, 14473.348699308766, 14516.934758716818, 14574.0, 14617.707645846811, 12110.75778484443, 12530.812037819258, 12682.239065656091, 12873.935630321788, 12911.0, 12348.444320005801, 12374.566890158801, 12881.35593220354, 13462.86537134616, 13795.448182072605, 13109.868901310865, 13211.867881321064, 13318.800217996932, 13520.12119212248, 13552.0, 11214.943925280648, 11360.602378916697, 11406.258593191416, 11451.370174640475, 11906.165978670562, 11541.538338466367, 11676.182667213214, 11769.17615766888, 11793.705157371134, 12021.639350819489], "value": 7198.894609925774, "unit": "score"}], "name": "dromaeo_css", "value": 7469.916766666911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 123.0, 153.0, 120.0, 117.0, 120.0, 116.0, 154.0, 123.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 160.0, 162.0, 163.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 109.0, 75.0, 76.0, 78.0, 76.0, 96.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 117.0, 82.0, 81.0, 81.0, 105.0, 81.0, 82.0, 119.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 54.0, 50.0, 51.0, 52.0, 53.0, 52.0, 50.0, 54.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 63.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 82.0, 75.0, 74.0, 74.0, 78.0, 74.0, 74.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 130.0, 127.0, 138.0, 129.0, 128.0, 121.0, 157.0, 141.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 155.0, 157.0, 156.0, 157.0, 153.0, 154.0, 153.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 63.0, 70.0, 61.0, 61.0, 61.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1457.2, "alertThreshold": 2.0}]} 14:17:33 INFO - Return code: 0 14:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:17:33 INFO - # TBPL SUCCESS # 14:17:33 INFO - Running post-action listener: _resource_record_post_action 14:17:33 INFO - [mozharness: 2017-01-12 22:17:33.964589Z] Finished run-tests step (success) 14:17:33 INFO - Running post-run listener: _resource_record_post_run 14:17:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 374898688; Read time: 28; Write time: 226444 14:17:34 INFO - TinderboxPrint: CPU usage
13.0% 14:17:34 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 14:17:34 INFO - TinderboxPrint: I/O write bytes / time
374,898,688 / 226,444 14:17:34 INFO - TinderboxPrint: CPU idle
8,273.6 (87.0%) 14:17:34 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 14:17:34 INFO - TinderboxPrint: Swap in / out
0 / 0 14:17:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110538752; Read time: 0; Write time: 79296 14:17:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249831424; Read time: 12; Write time: 143596 14:17:34 INFO - Running post-run listener: _upload_blobber_files 14:17:34 INFO - Blob upload gear active. 14:17:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:17:34 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 14:17:34 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'] 14:17:34 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 14:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:35 INFO - (blobuploader) - INFO - Done attempting. 14:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:36 INFO - (blobuploader) - INFO - Done attempting. 14:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:39 INFO - (blobuploader) - INFO - Done attempting. 14:17:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:17:39 INFO - Return code: 0 14:17:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:17:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:17:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49901aa05b45a6c032b540de38b905be50d9617cf32987ba43dbf03abeaeab7bd52a8217c1634f71110bbbdb528c6d725542c2c31d742a823115652718020083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24fb4cfbd6bbeda717a4f71a96e6084e64b042938a1cc52056e4c77cc93fe73ebbf35451ab4230cd53bb62fa0f9db1c35885f5cfe680120949bf4413281e107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3470990546a8bbd745e5985cc11e5f36dc2838c0f8e6bbf87f168baf5cb1fa47e72604093c2ba3de76e643182fdba9cf87171badd2bce34c3934b4c06d346fd9"} 14:17:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:17:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:17:39 INFO - Contents: 14:17:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49901aa05b45a6c032b540de38b905be50d9617cf32987ba43dbf03abeaeab7bd52a8217c1634f71110bbbdb528c6d725542c2c31d742a823115652718020083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24fb4cfbd6bbeda717a4f71a96e6084e64b042938a1cc52056e4c77cc93fe73ebbf35451ab4230cd53bb62fa0f9db1c35885f5cfe680120949bf4413281e107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3470990546a8bbd745e5985cc11e5f36dc2838c0f8e6bbf87f168baf5cb1fa47e72604093c2ba3de76e643182fdba9cf87171badd2bce34c3934b4c06d346fd9"} 14:17:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:17:39 INFO - Copying logs to upload dir... 14:17:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:17:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.081417 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 14:17:39.475081) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:17:39.478569) ========= 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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 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/49901aa05b45a6c032b540de38b905be50d9617cf32987ba43dbf03abeaeab7bd52a8217c1634f71110bbbdb528c6d725542c2c31d742a823115652718020083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24fb4cfbd6bbeda717a4f71a96e6084e64b042938a1cc52056e4c77cc93fe73ebbf35451ab4230cd53bb62fa0f9db1c35885f5cfe680120949bf4413281e107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3470990546a8bbd745e5985cc11e5f36dc2838c0f8e6bbf87f168baf5cb1fa47e72604093c2ba3de76e643182fdba9cf87171badd2bce34c3934b4c06d346fd9"} build_url:https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011498 build_url: 'https://queue.taskcluster.net/v1/task/QOHEpDueQHy_XHFYKgmt3w/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/49901aa05b45a6c032b540de38b905be50d9617cf32987ba43dbf03abeaeab7bd52a8217c1634f71110bbbdb528c6d725542c2c31d742a823115652718020083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24fb4cfbd6bbeda717a4f71a96e6084e64b042938a1cc52056e4c77cc93fe73ebbf35451ab4230cd53bb62fa0f9db1c35885f5cfe680120949bf4413281e107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3470990546a8bbd745e5985cc11e5f36dc2838c0f8e6bbf87f168baf5cb1fa47e72604093c2ba3de76e643182fdba9cf87171badd2bce34c3934b4c06d346fd9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:17:39.503637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:17:39.504006) ========= 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=6d15e502d8e29d5d2676d664000001c3-1484258143.272273-2879890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:17:39.588311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:17:39.588633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:17:39.588926) ========= ========= Total master_lag: 0.16 =========