builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1482834470.03 results: success (0) buildid: 20161227004018 builduid: 57787d9771274caaa560716bbbcc03b7 revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.032578) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.033071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.033388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.064630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.065285) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-27 02:27:53-- 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% 70.2M=0s 2016-12-27 02:27:53 (70.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145672 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.237128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.237445) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017234 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.301697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:50.302082) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5434909ba45c6df65a4e769ba80fe67ead95b785 --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 5434909ba45c6df65a4e769ba80fe67ead95b785 --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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-27 02:27:54,017 truncating revision to first 12 chars 2016-12-27 02:27:54,017 Setting DEBUG logging. 2016-12-27 02:27:54,017 attempt 1/10 2016-12-27 02:27:54,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5434909ba45c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 02:27:54,362 unpacking tar archive at: mozilla-aurora-5434909ba45c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:51.035258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:51.035571) ========= script_repo_revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:51.036029) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:51.036339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 02:27:51.047767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-27 02:27:51.048095) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:27:54 INFO - MultiFileLogger online at 20161227 02:27:54 in /builds/slave/test 02:27:54 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 02:27:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:54 INFO - {'append_to_log': False, 02:27:54 INFO - 'base_work_dir': '/builds/slave/test', 02:27:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:54 INFO - 'branch': 'Mozilla-Aurora', 02:27:54 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:54 INFO - 'config_files': ('talos/linux_config.py',), 02:27:54 INFO - 'default_actions': ('clobber', 02:27:54 INFO - 'read-buildbot-config', 02:27:54 INFO - 'download-and-extract', 02:27:54 INFO - 'populate-webroot', 02:27:54 INFO - 'create-virtualenv', 02:27:54 INFO - 'install', 02:27:54 INFO - 'run-tests'), 02:27:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:54 INFO - 'download_minidump_stackwalk': True, 02:27:54 INFO - 'download_symbols': 'ondemand', 02:27:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:54 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:54 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:54 INFO - 'installer_path': 'installer.exe', 02:27:54 INFO - 'log_level': 'info', 02:27:54 INFO - 'log_name': 'talos', 02:27:54 INFO - 'log_to_console': True, 02:27:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:27:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:27:54 INFO - 'opt_config_files': (), 02:27:54 INFO - 'pip_index': False, 02:27:54 INFO - 'sps_profile': False, 02:27:54 INFO - 'sps_profile_interval': 0, 02:27:54 INFO - 'suite': 'dromaeojs', 02:27:54 INFO - 'system_bits': '32', 02:27:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:54 INFO - 'title': 'talos-linux64-ix-066', 02:27:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:54 INFO - 'use_talos_json': True, 02:27:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:54 INFO - 'work_dir': 'build'} 02:27:54 INFO - [mozharness: 2016-12-27 10:27:54.862110Z] Running clobber step. 02:27:54 INFO - Running pre-action listener: _resource_record_pre_action 02:27:54 INFO - Running main action method: clobber 02:27:54 INFO - rmtree: /builds/slave/test/build 02:27:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:55 INFO - Running post-action listener: _resource_record_post_action 02:27:55 INFO - [mozharness: 2016-12-27 10:27:55.327502Z] Finished clobber step (success) 02:27:55 INFO - [mozharness: 2016-12-27 10:27:55.327603Z] Running read-buildbot-config step. 02:27:55 INFO - Running pre-action listener: _resource_record_pre_action 02:27:55 INFO - Running main action method: read_buildbot_config 02:27:55 INFO - Using buildbot properties: 02:27:55 INFO - { 02:27:55 INFO - "project": "", 02:27:55 INFO - "product": "firefox", 02:27:55 INFO - "script_repo_revision": "production", 02:27:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:27:55 INFO - "repository": "", 02:27:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:27:55 INFO - "buildid": "20161227004018", 02:27:55 INFO - "stage_platform": "linux64-pgo", 02:27:55 INFO - "basedir": "/builds/slave/test", 02:27:55 INFO - "nightly_build": "True", 02:27:55 INFO - "buildnumber": 696, 02:27:55 INFO - "slavename": "talos-linux64-ix-066", 02:27:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:27:55 INFO - "platform": "ubuntu64_hw", 02:27:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:27:55 INFO - "branch": "mozilla-aurora", 02:27:55 INFO - "repo_path": "releases/mozilla-aurora", 02:27:55 INFO - "revision": "5434909ba45c6df65a4e769ba80fe67ead95b785", 02:27:55 INFO - "pgo_build": "True", 02:27:55 INFO - "builduid": "57787d9771274caaa560716bbbcc03b7", 02:27:55 INFO - "slavebuilddir": "test" 02:27:55 INFO - } 02:27:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:27:55 INFO - Running post-action listener: _resource_record_post_action 02:27:55 INFO - [mozharness: 2016-12-27 10:27:55.330097Z] Finished read-buildbot-config step (success) 02:27:55 INFO - [mozharness: 2016-12-27 10:27:55.330185Z] Running download-and-extract step. 02:27:55 INFO - Running pre-action listener: _resource_record_pre_action 02:27:55 INFO - Running main action method: download_and_extract 02:27:55 INFO - mkdir: /builds/slave/test/build/tests 02:27:55 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')]} 02:27:55 INFO - trying https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:55 INFO - Downloading https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/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 02:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/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 02:27:55 INFO - Downloaded 1361 bytes. 02:27:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:55 INFO - Using the following test package requirements: 02:27:55 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:27:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:27:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'jsshell-linux-x86_64.zip'], 02:27:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:27:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:27:55 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:27:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:27:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:27:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:27:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:27:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:27:56 INFO - Http code: 200 02:27:56 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 02:27:56 INFO - x-amz-cf-id: Uh_RvZzVJFfjdhbi74SONy_xOmsGWl_My_quVLbz5s2xMXNn9uYl-Q== 02:27:56 INFO - x-amz-version-id: ZTRQ1WcH.if6SwGyxnhzEvjuvAIoa0gQ 02:27:56 INFO - Expected file size: 21941578 02:27:56 INFO - Obtained file size: 21941578 02:28:00 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 02:28:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:28:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:28:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:28:01 INFO - Http code: 200 02:28:01 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 02:28:01 INFO - x-amz-cf-id: ocRYzy6ZEU7A3C3TMYg-FQ1tOGr8Nm0g7drUXjyvGF32oIcWcL7Ppw== 02:28:01 INFO - x-amz-version-id: ZTRQ1WcH.if6SwGyxnhzEvjuvAIoa0gQ 02:28:01 INFO - Expected file size: 21941578 02:28:01 INFO - Obtained file size: 21941578 02:28:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:28:05 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:28:06 INFO - Http code: 200 02:28:06 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 02:28:06 INFO - x-amz-cf-id: UXR_b17MsquPmfHV-ETt6R8CHZ8GOyDcsNQt2oIqzFk-VKb-exoLMw== 02:28:06 INFO - x-amz-version-id: oX1cPGbi4JPQscucFlW2m5x08zlbg9x2 02:28:06 INFO - Expected file size: 14409038 02:28:06 INFO - Obtained file size: 14409038 02:28:06 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')]} 02:28:06 INFO - trying https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/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 02:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/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 02:28:08 INFO - Downloaded 64011548 bytes. 02:28:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:08 INFO - mkdir: /builds/slave/test/properties 02:28:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:08 INFO - Contents: 02:28:08 INFO - build_url:https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - Running post-action listener: set_extra_try_arguments 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.743461Z] Finished download-and-extract step (success) 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.743759Z] Running populate-webroot step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: populate_webroot 02:28:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:08 INFO - '--tppagecycles', 02:28:08 INFO - '7'], 02:28:08 INFO - 'tests': ['tsvgm']}}, 02:28:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['damp', 'tps']}, 02:28:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'tests': ['damp', 'tps']}, 02:28:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['dromaeo_dom']}, 02:28:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['basic_compositor_video']}, 02:28:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['a11yr', 02:28:08 INFO - 'ts_paint', 02:28:08 INFO - 'tpaint', 02:28:08 INFO - 'sessionrestore', 02:28:08 INFO - 'sessionrestore_no_auto_restore', 02:28:08 INFO - 'tabpaint']}, 02:28:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['tsvgx', 02:28:08 INFO - 'tsvgr_opacity', 02:28:08 INFO - 'tart', 02:28:08 INFO - 'tscrollx', 02:28:08 INFO - 'cart']}, 02:28:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:08 INFO - 'tsvgr_opacity', 02:28:08 INFO - 'tart', 02:28:08 INFO - 'tscrollx', 02:28:08 INFO - 'cart']}, 02:28:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'talos_options': ['--disable-e10s'], 02:28:08 INFO - 'tests': ['tp5o']}, 02:28:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'tests': ['tp5o']}, 02:28:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'talos_options': ['--disable-e10s', 02:28:08 INFO - '--xperf_path', 02:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:08 INFO - 'tests': ['tp5n']}, 02:28:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:08 INFO - 'talos_options': ['--xperf_path', 02:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:08 INFO - 'tests': ['tp5n']}}, 02:28:08 INFO - 'talos.zip': {'path': '', 02:28:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.765772Z] Finished populate-webroot step (success) 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.765865Z] Running create-virtualenv step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: create_virtualenv 02:28:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:08 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 02:28:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:08 INFO - Using real prefix '/usr' 02:28:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:11 INFO - Installing pip.................done. 02:28:11 INFO - Return code: 0 02:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:28:11 INFO - Reading from file tmpfile_stdout 02:28:11 INFO - Output received: 02:28:11 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) 02:28:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:28:11 INFO - Using env: {'DISPLAY': ':0', 02:28:11 INFO - 'HOME': '/home/cltbld', 02:28:11 INFO - 'LANG': 'en_US.UTF-8', 02:28:11 INFO - 'LANGUAGE': 'en_US:en', 02:28:11 INFO - 'LOGNAME': 'cltbld', 02:28:11 INFO - 'MAIL': '/var/mail/cltbld', 02:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:11 INFO - 'MOZ_NO_REMOTE': '1', 02:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:11 INFO - 'NO_EM_RESTART': '1', 02:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:11 INFO - 'PWD': '/builds/slave/test', 02:28:11 INFO - 'SHELL': '/bin/bash', 02:28:11 INFO - 'SHLVL': '1', 02:28:11 INFO - 'TERM': 'linux', 02:28:11 INFO - 'TMOUT': '86400', 02:28:11 INFO - 'USER': 'cltbld', 02:28:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:11 INFO - '_': '/tools/buildbot/bin/python'} 02:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:11 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 02:28:11 INFO - Cleaning up... 02:28:11 INFO - Return code: 0 02:28:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:28:11 INFO - Using env: {'DISPLAY': ':0', 02:28:11 INFO - 'HOME': '/home/cltbld', 02:28:11 INFO - 'LANG': 'en_US.UTF-8', 02:28:11 INFO - 'LANGUAGE': 'en_US:en', 02:28:11 INFO - 'LOGNAME': 'cltbld', 02:28:11 INFO - 'MAIL': '/var/mail/cltbld', 02:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:11 INFO - 'MOZ_NO_REMOTE': '1', 02:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:11 INFO - 'NO_EM_RESTART': '1', 02:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:11 INFO - 'PWD': '/builds/slave/test', 02:28:11 INFO - 'SHELL': '/bin/bash', 02:28:11 INFO - 'SHLVL': '1', 02:28:11 INFO - 'TERM': 'linux', 02:28:11 INFO - 'TMOUT': '86400', 02:28:11 INFO - 'USER': 'cltbld', 02:28:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:11 INFO - '_': '/tools/buildbot/bin/python'} 02:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:12 INFO - Downloading/unpacking psutil>=3.1.1 02:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:14 INFO - Installing collected packages: psutil 02:28:14 INFO - Running setup.py install for psutil 02:28:14 INFO - building 'psutil._psutil_linux' extension 02:28:14 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 02:28:14 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 02:28:14 INFO - building 'psutil._psutil_posix' extension 02:28:14 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 02:28:14 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 02:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:14 INFO - Successfully installed psutil 02:28:14 INFO - Cleaning up... 02:28:14 INFO - Return code: 0 02:28:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:14 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')]} 02:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:14 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')]} 02:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:14 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:14 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 02:28:14 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 02:28:14 INFO - Using env: {'DISPLAY': ':0', 02:28:14 INFO - 'HOME': '/home/cltbld', 02:28:14 INFO - 'LANG': 'en_US.UTF-8', 02:28:14 INFO - 'LANGUAGE': 'en_US:en', 02:28:14 INFO - 'LOGNAME': 'cltbld', 02:28:14 INFO - 'MAIL': '/var/mail/cltbld', 02:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:14 INFO - 'MOZ_NO_REMOTE': '1', 02:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:14 INFO - 'NO_EM_RESTART': '1', 02:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:14 INFO - 'PWD': '/builds/slave/test', 02:28:14 INFO - 'SHELL': '/bin/bash', 02:28:14 INFO - 'SHLVL': '1', 02:28:14 INFO - 'TERM': 'linux', 02:28:14 INFO - 'TMOUT': '86400', 02:28:14 INFO - 'USER': 'cltbld', 02:28:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:14 INFO - '_': '/tools/buildbot/bin/python'} 02:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:17 INFO - Installing collected packages: mozsystemmonitor 02:28:17 INFO - Running setup.py install for mozsystemmonitor 02:28:17 INFO - Successfully installed mozsystemmonitor 02:28:17 INFO - Cleaning up... 02:28:17 INFO - Return code: 0 02:28:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:17 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:17 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 02:28:17 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 02:28:17 INFO - Using env: {'DISPLAY': ':0', 02:28:17 INFO - 'HOME': '/home/cltbld', 02:28:17 INFO - 'LANG': 'en_US.UTF-8', 02:28:17 INFO - 'LANGUAGE': 'en_US:en', 02:28:17 INFO - 'LOGNAME': 'cltbld', 02:28:17 INFO - 'MAIL': '/var/mail/cltbld', 02:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:17 INFO - 'MOZ_NO_REMOTE': '1', 02:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:17 INFO - 'NO_EM_RESTART': '1', 02:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:17 INFO - 'PWD': '/builds/slave/test', 02:28:17 INFO - 'SHELL': '/bin/bash', 02:28:17 INFO - 'SHLVL': '1', 02:28:17 INFO - 'TERM': 'linux', 02:28:17 INFO - 'TMOUT': '86400', 02:28:17 INFO - 'USER': 'cltbld', 02:28:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:17 INFO - '_': '/tools/buildbot/bin/python'} 02:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:17 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:17 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 02:28:17 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 02:28:17 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 02:28:17 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 02:28:17 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 02:28:17 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 02:28:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:19 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 02:28:19 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 02:28:19 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 02:28:19 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 02:28:19 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 02:28:19 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 02:28:19 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:19 INFO - warning: no files found matching '*.txt' 02:28:19 INFO - no previously-included directories found matching 'build' 02:28:19 INFO - no previously-included directories found matching 'dist' 02:28:19 INFO - no previously-included directories found matching '.git*' 02:28:19 INFO - Installing collected packages: jsonschema, functools32 02:28:19 INFO - Running setup.py install for functools32 02:28:19 INFO - warning: no files found matching '*.txt' 02:28:19 INFO - no previously-included directories found matching 'build' 02:28:19 INFO - no previously-included directories found matching 'dist' 02:28:19 INFO - no previously-included directories found matching '.git*' 02:28:19 INFO - Successfully installed jsonschema functools32 02:28:19 INFO - Cleaning up... 02:28:19 INFO - Return code: 0 02:28:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:28:19 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')]} 02:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:19 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')]} 02:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:19 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:19 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 02:28:19 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 02:28:19 INFO - Using env: {'DISPLAY': ':0', 02:28:19 INFO - 'HOME': '/home/cltbld', 02:28:19 INFO - 'LANG': 'en_US.UTF-8', 02:28:19 INFO - 'LANGUAGE': 'en_US:en', 02:28:19 INFO - 'LOGNAME': 'cltbld', 02:28:19 INFO - 'MAIL': '/var/mail/cltbld', 02:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:19 INFO - 'MOZ_NO_REMOTE': '1', 02:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:19 INFO - 'NO_EM_RESTART': '1', 02:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:19 INFO - 'PWD': '/builds/slave/test', 02:28:19 INFO - 'SHELL': '/bin/bash', 02:28:19 INFO - 'SHLVL': '1', 02:28:19 INFO - 'TERM': 'linux', 02:28:19 INFO - 'TMOUT': '86400', 02:28:19 INFO - 'USER': 'cltbld', 02:28:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:19 INFO - '_': '/tools/buildbot/bin/python'} 02:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:28:20 INFO - Cleaning up... 02:28:20 INFO - Return code: 0 02:28:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:20 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')]} 02:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:20 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')]} 02:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:20 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:20 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 02:28:20 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 02:28:20 INFO - Using env: {'DISPLAY': ':0', 02:28:20 INFO - 'HOME': '/home/cltbld', 02:28:20 INFO - 'LANG': 'en_US.UTF-8', 02:28:20 INFO - 'LANGUAGE': 'en_US:en', 02:28:20 INFO - 'LOGNAME': 'cltbld', 02:28:20 INFO - 'MAIL': '/var/mail/cltbld', 02:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:20 INFO - 'MOZ_NO_REMOTE': '1', 02:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:20 INFO - 'NO_EM_RESTART': '1', 02:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:20 INFO - 'PWD': '/builds/slave/test', 02:28:20 INFO - 'SHELL': '/bin/bash', 02:28:20 INFO - 'SHLVL': '1', 02:28:20 INFO - 'TERM': 'linux', 02:28:20 INFO - 'TMOUT': '86400', 02:28:20 INFO - 'USER': 'cltbld', 02:28:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:20 INFO - '_': '/tools/buildbot/bin/python'} 02:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:20 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:23 INFO - Downloading docopt-0.6.1.tar.gz 02:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:23 INFO - Running setup.py install for blobuploader 02:28:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:23 INFO - Running setup.py install for requests 02:28:23 INFO - Running setup.py install for docopt 02:28:23 INFO - Successfully installed blobuploader requests docopt 02:28:23 INFO - Cleaning up... 02:28:23 INFO - Return code: 0 02:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:23 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:23 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 02:28:23 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 02:28:23 INFO - Using env: {'DISPLAY': ':0', 02:28:23 INFO - 'HOME': '/home/cltbld', 02:28:23 INFO - 'LANG': 'en_US.UTF-8', 02:28:23 INFO - 'LANGUAGE': 'en_US:en', 02:28:23 INFO - 'LOGNAME': 'cltbld', 02:28:23 INFO - 'MAIL': '/var/mail/cltbld', 02:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:23 INFO - 'MOZ_NO_REMOTE': '1', 02:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:23 INFO - 'NO_EM_RESTART': '1', 02:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:23 INFO - 'PWD': '/builds/slave/test', 02:28:23 INFO - 'SHELL': '/bin/bash', 02:28:23 INFO - 'SHLVL': '1', 02:28:23 INFO - 'TERM': 'linux', 02:28:23 INFO - 'TMOUT': '86400', 02:28:23 INFO - 'USER': 'cltbld', 02:28:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:23 INFO - '_': '/tools/buildbot/bin/python'} 02:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:23 INFO - Running setup.py (path:/tmp/pip-x0Pd0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:24 INFO - Running setup.py (path:/tmp/pip-9KTUfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:24 INFO - Running setup.py (path:/tmp/pip-eDoJgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:24 INFO - Running setup.py (path:/tmp/pip-VUNOkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:24 INFO - Running setup.py (path:/tmp/pip-KMNRwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:24 INFO - Running setup.py (path:/tmp/pip-eSSmIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:24 INFO - Running setup.py (path:/tmp/pip-pXD0Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:24 INFO - Running setup.py (path:/tmp/pip-UuzIbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:24 INFO - Running setup.py (path:/tmp/pip-OOEXj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:24 INFO - Running setup.py (path:/tmp/pip-ANsVUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:24 INFO - Running setup.py (path:/tmp/pip-iMqL4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:24 INFO - Running setup.py (path:/tmp/pip-iIdXC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:24 INFO - Running setup.py (path:/tmp/pip-vnLQAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:24 INFO - Running setup.py (path:/tmp/pip-4cF7zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:24 INFO - Running setup.py (path:/tmp/pip-ZlXMpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:25 INFO - Running setup.py (path:/tmp/pip-25fvWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:25 INFO - Running setup.py (path:/tmp/pip-JdXgXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:25 INFO - Running setup.py install for manifestparser 02:28:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozcrash 02:28:25 INFO - Running setup.py install for mozdebug 02:28:25 INFO - Running setup.py install for mozdevice 02:28:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozfile 02:28:25 INFO - Running setup.py install for mozhttpd 02:28:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozinfo 02:28:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozInstall 02:28:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozleak 02:28:26 INFO - Running setup.py install for mozlog 02:28:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for moznetwork 02:28:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozprocess 02:28:26 INFO - Running setup.py install for mozprofile 02:28:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozrunner 02:28:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozscreenshot 02:28:26 INFO - Running setup.py install for moztest 02:28:26 INFO - Running setup.py install for mozversion 02:28:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:26 INFO - Cleaning up... 02:28:27 INFO - Return code: 0 02:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:27 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:27 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 02:28:27 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 02:28:27 INFO - Using env: {'DISPLAY': ':0', 02:28:27 INFO - 'HOME': '/home/cltbld', 02:28:27 INFO - 'LANG': 'en_US.UTF-8', 02:28:27 INFO - 'LANGUAGE': 'en_US:en', 02:28:27 INFO - 'LOGNAME': 'cltbld', 02:28:27 INFO - 'MAIL': '/var/mail/cltbld', 02:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:27 INFO - 'MOZ_NO_REMOTE': '1', 02:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:27 INFO - 'NO_EM_RESTART': '1', 02:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:27 INFO - 'PWD': '/builds/slave/test', 02:28:27 INFO - 'SHELL': '/bin/bash', 02:28:27 INFO - 'SHLVL': '1', 02:28:27 INFO - 'TERM': 'linux', 02:28:27 INFO - 'TMOUT': '86400', 02:28:27 INFO - 'USER': 'cltbld', 02:28:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:27 INFO - '_': '/tools/buildbot/bin/python'} 02:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:27 INFO - Running setup.py (path:/tmp/pip-Hr2JBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:27 INFO - Running setup.py (path:/tmp/pip-GOFeQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:27 INFO - Running setup.py (path:/tmp/pip-YDPYG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:27 INFO - Running setup.py (path:/tmp/pip-mSMYN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:27 INFO - Running setup.py (path:/tmp/pip-hR2H79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:27 INFO - Running setup.py (path:/tmp/pip-OMlecv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:27 INFO - Running setup.py (path:/tmp/pip-RvsBJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:27 INFO - Running setup.py (path:/tmp/pip-luK9BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:27 INFO - Running setup.py (path:/tmp/pip-WUPspe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:27 INFO - Running setup.py (path:/tmp/pip-Uk1AXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:27 INFO - Running setup.py (path:/tmp/pip-e8ouID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:28 INFO - Running setup.py (path:/tmp/pip-b8lvw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:28 INFO - Running setup.py (path:/tmp/pip-5qQ6s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:28 INFO - Running setup.py (path:/tmp/pip-c2gE_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:28 INFO - Running setup.py (path:/tmp/pip-zGvBL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:28 INFO - Running setup.py (path:/tmp/pip-_jVQaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:28 INFO - Running setup.py (path:/tmp/pip-cRYatE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:28 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)) 02:28:28 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)) 02:28:28 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)) 02:28:28 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)) 02:28:28 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)) 02:28:28 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)) 02:28:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:30 INFO - Downloading blessings-1.6.tar.gz 02:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:30 INFO - Installing collected packages: blessings 02:28:30 INFO - Running setup.py install for blessings 02:28:30 INFO - Successfully installed blessings 02:28:30 INFO - Cleaning up... 02:28:30 INFO - Return code: 0 02:28:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:30 INFO - Reading from file tmpfile_stdout 02:28:30 INFO - Current package versions: 02:28:30 INFO - argparse == 1.2.1 02:28:30 INFO - blessings == 1.6 02:28:30 INFO - blobuploader == 1.2.4 02:28:30 INFO - docopt == 0.6.1 02:28:30 INFO - functools32 == 3.2.3-2 02:28:30 INFO - jsonschema == 2.5.1 02:28:30 INFO - manifestparser == 1.1 02:28:30 INFO - mozInstall == 1.12 02:28:30 INFO - mozcrash == 1.0 02:28:30 INFO - mozdebug == 0.1 02:28:30 INFO - mozdevice == 0.48 02:28:30 INFO - mozfile == 1.2 02:28:30 INFO - mozhttpd == 0.7 02:28:30 INFO - mozinfo == 0.9 02:28:30 INFO - mozleak == 0.1 02:28:30 INFO - mozlog == 3.4 02:28:30 INFO - moznetwork == 0.27 02:28:30 INFO - mozprocess == 0.23 02:28:30 INFO - mozprofile == 0.28 02:28:30 INFO - mozrunner == 6.13 02:28:30 INFO - mozscreenshot == 0.1 02:28:30 INFO - mozsystemmonitor == 0.3 02:28:30 INFO - moztest == 0.7 02:28:30 INFO - mozversion == 1.4 02:28:30 INFO - psutil == 3.1.1 02:28:30 INFO - requests == 1.2.3 02:28:30 INFO - wsgiref == 0.1.2 02:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:30 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:30 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 02:28:30 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 02:28:30 INFO - Using env: {'DISPLAY': ':0', 02:28:30 INFO - 'HOME': '/home/cltbld', 02:28:30 INFO - 'LANG': 'en_US.UTF-8', 02:28:30 INFO - 'LANGUAGE': 'en_US:en', 02:28:30 INFO - 'LOGNAME': 'cltbld', 02:28:30 INFO - 'MAIL': '/var/mail/cltbld', 02:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:30 INFO - 'MOZ_NO_REMOTE': '1', 02:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:30 INFO - 'NO_EM_RESTART': '1', 02:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:30 INFO - 'PWD': '/builds/slave/test', 02:28:30 INFO - 'SHELL': '/bin/bash', 02:28:30 INFO - 'SHLVL': '1', 02:28:30 INFO - 'TERM': 'linux', 02:28:30 INFO - 'TMOUT': '86400', 02:28:30 INFO - 'USER': 'cltbld', 02:28:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:30 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x7f959256af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', '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 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Running post-action listener: _resource_record_post_action 02:28:31 INFO - Running post-action listener: _start_resource_monitoring 02:28:31 INFO - Starting resource monitoring. 02:28:31 INFO - [mozharness: 2016-12-27 10:28:31.415661Z] Finished create-virtualenv step (success) 02:28:31 INFO - [mozharness: 2016-12-27 10:28:31.416174Z] Running install step. 02:28:31 INFO - Running pre-action listener: _resource_record_pre_action 02:28:31 INFO - Running main action method: install 02:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:31 INFO - Reading from file tmpfile_stdout 02:28:31 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:31 INFO - Reading from file tmpfile_stdout 02:28:31 INFO - Output received: 02:28:31 INFO - Usage: mozinstall [options] installer 02:28:31 INFO - Options: 02:28:31 INFO - -h, --help show this help message and exit 02:28:31 INFO - -d DEST, --destination=DEST 02:28:31 INFO - Directory to install application into. [default: 02:28:31 INFO - "/builds/slave/test"] 02:28:31 INFO - --app=APP Application being installed. [default: firefox] 02:28:31 INFO - mkdir: /builds/slave/test/build/application 02:28:31 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'] 02:28:31 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 02:28:47 INFO - Reading from file tmpfile_stdout 02:28:47 INFO - Output received: 02:28:47 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:47 INFO - Running post-action listener: _resource_record_post_action 02:28:47 INFO - [mozharness: 2016-12-27 10:28:47.641871Z] Finished install step (success) 02:28:47 INFO - [mozharness: 2016-12-27 10:28:47.642114Z] Running run-tests step. 02:28:47 INFO - Running pre-action listener: _resource_record_pre_action 02:28:47 INFO - Running main action method: run_tests 02:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:47 INFO - Python 2.7.3 02:28:47 INFO - Return code: 0 02:28:47 INFO - grabbing minidump binary from tooltool 02:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:47 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 0x2ac9f60>, '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 0x2acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:47 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 02:28:47 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 02:28:47 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 02:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:47 INFO - Return code: 0 02:28:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:47 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/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 02:28:47 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/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 02:28:47 INFO - Using env: {'DISPLAY': ':0', 02:28:47 INFO - 'HOME': '/home/cltbld', 02:28:47 INFO - 'LANG': 'en_US.UTF-8', 02:28:47 INFO - 'LANGUAGE': 'en_US:en', 02:28:47 INFO - 'LOGNAME': 'cltbld', 02:28:47 INFO - 'MAIL': '/var/mail/cltbld', 02:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:47 INFO - 'MOZ_NO_REMOTE': '1', 02:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:47 INFO - 'NO_EM_RESTART': '1', 02:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:47 INFO - 'PWD': '/builds/slave/test', 02:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:47 INFO - 'SHELL': '/bin/bash', 02:28:47 INFO - 'SHLVL': '1', 02:28:47 INFO - 'TERM': 'linux', 02:28:47 INFO - 'TMOUT': '86400', 02:28:47 INFO - 'USER': 'cltbld', 02:28:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718', 02:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:47 INFO - '_': '/tools/buildbot/bin/python'} 02:28:47 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/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 02:28:47 INFO - mozversion application_buildid: 20161227004018 02:28:47 INFO - mozversion application_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 02:28:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:47 INFO - mozversion application_name: Firefox 02:28:47 INFO - mozversion application_remotingname: firefox-dev 02:28:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:47 INFO - mozversion application_vendor: Mozilla 02:28:47 INFO - mozversion application_version: 52.0a2 02:28:47 INFO - mozversion platform_buildid: 20161227004018 02:28:47 INFO - mozversion platform_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 02:28:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:47 INFO - mozversion platform_version: 52.0a2 02:28:47 INFO - using testdate: 1482834527 02:28:47 INFO - actual date: 1482834527 02:28:47 INFO - starting webserver on 'localhost:58448' 02:28:47 INFO - SUITE-START | Running 2 tests 02:28:47 INFO - TEST-START | dromaeo_css 02:28:47 INFO - operating with platform_type : linux_ 02:28:47 INFO - Initialising browser for dromaeo_css test... 02:28:47 INFO - TEST-INFO | started process 14419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Wd0WU/profile http://localhost:58448/getInfo.html) 02:28:52 INFO - PROCESS | 14419 | __metrics Screen width/height:1600/1200 02:28:52 INFO - PROCESS | 14419 | colorDepth:24 02:28:52 INFO - PROCESS | 14419 | Browser inner width/height: 1024/697 02:28:52 INFO - PROCESS | 14419 | __metrics 02:28:52 INFO - PROCESS | 14419 | 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" 02:28:52 INFO - PROCESS | 14419 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:53 INFO - PROCESS | 14419 | console.error: PushService: 02:28:53 INFO - PROCESS | 14419 | stateChangeProcessEnqueue: Error transitioning state 02:28:53 INFO - PROCESS | 14419 | UnknownError 02:28:53 INFO - TEST-INFO | 14419: exit 0 02:28:53 INFO - Browser initialized. 02:28:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:54 INFO - TEST-INFO | started process 14512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Wd0WU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:05 INFO - PROCESS | 14512 | RSS: Main: 144011264 02:29:05 INFO - PROCESS | 14512 | 02:29:57 INFO - PROCESS | 14512 | 1482834597466 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:32:07 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58448/tests/dromaeo/cssquery-ext.html) 02:32:09 INFO - PROCESS | 14512 | RSS: Main: 242511872 02:32:09 INFO - PROCESS | 14512 | 02:35:11 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-ext.html (next: http://localhost:58448/tests/dromaeo/cssquery-jquery.html) 02:35:11 INFO - PROCESS | 14512 | RSS: Main: 234852352 02:35:11 INFO - PROCESS | 14512 | 02:38:13 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58448/tests/dromaeo/cssquery-mootools.html) 02:38:14 INFO - PROCESS | 14512 | RSS: Main: 207294464 02:38:14 INFO - PROCESS | 14512 | 02:41:16 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58448/tests/dromaeo/cssquery-prototype.html) 02:41:17 INFO - PROCESS | 14512 | RSS: Main: 217243648 02:41:17 INFO - PROCESS | 14512 | 02:44:19 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58448/tests/dromaeo/cssquery-yui.html) 02:44:20 INFO - PROCESS | 14512 | RSS: Main: 174460928 02:44:20 INFO - PROCESS | 14512 | 02:47:22 INFO - PROCESS | 14512 | Cycle 1(1): loaded http://localhost:58448/tests/dromaeo/cssquery-yui.html (next: http://localhost:58448/tests/dromaeo/cssquery-dojo.html) 02:47:23 INFO - PROCESS | 14512 | RSS: Main: 263155712 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | __start_tp_report 02:47:23 INFO - PROCESS | 14512 | _x_x_mozilla_page_load 02:47:23 INFO - PROCESS | 14512 | _x_x_mozilla_page_load_details 02:47:23 INFO - PROCESS | 14512 | |i|pagename|runs| 02:47:23 INFO - PROCESS | 14512 | |0;dojo.html;3222.3072039511508;3253.0240927721684;3257.771955963082;3293.736501079914;3295.6045274567055;5575.219469274305;5623.4938855503;5658.745356458959;5672.12082127271;5690.743916523756;5624.100143976964;5694.4590263924865;5694.487496125348;5710;5720.513756330706;5149.0731668299695;5176.7929282828645;5190.091733946544;5206.167013277876;5250.973745131269;5025.522575355335;5040.344755181821;5245.921311180336;5254.658447200939;5292.947070529303;5059.49405059493;5079.822206222783;5081.085404627165;5157.8452646420665;5167.199084141964;5139.946311006235;5173.534381905628;5244.842654720364;5248.0553500369915;5267.947320526784;4907.092187945206;5021.49785021495;5129.358830146231;5147.562457191143;5211.270422140903;5510.228568000483;5513.751881165357;5517.503424691797;5542.307211598551;5582.190582365534;5942.435468630516;6040.637561746309;6064.818055458343;6071.271447426293;6073.423024812636;5900.144479050557;5934.851628709273;6108.358622344679;6123.112148738453;6130.264368275835;5646.858828529279;5689.260396148474;5696.401877802854;5707.286589176353;5736.053551164095;6220.440160385497;6229.750809967551;6229.909765790969;6236.688165591702;6238.220222472191;5741.282339707536;5778.104393818965;5920.141579470953;5932.7330270137945;5933.881322373615;5905.852353691193;5998.100284957204;6030.427109424598;6059.939400606026;6101.328853826076;6039.4262545058145;6041.909371359433;6042.335343112254;6044.304904935901;6049.001914684116;5862.12068189775;6010.429009244115;6059.454649081604;6061.151438798572;6064.575479716465;4616.330632058332;4635.582797548237;4638.768061596907;4663.580277775017;4665.883352916137;4182.665386769051;4183.163367326547;4189.958100419018;4205.558416366299;4208.747475151439;5763;5766.5675074368755;5770.567207459373;5775.595708300379;5778.36437991829;5912.76348946046;5964.343922168558;5981.880362392728;6009.549283803644;6032;5773.047447171254;5780.421957804186;5783.797567085132;5800.100984347433;5816.185733997244;5163.870903227449;5241.68549887008;5246.291750613695;5250.816221432232;5251.396089449686;6120;6143.665407145435;6213.9067913982235;6324.620522768649;6332.873342533124;6016.368281330398;6043.516518678583;6054.7275372607455;6077.635341879324;6082.118092876596;6285.874282514415;6310.337414571404;6311.368863113652;6315.905261421174;6318.873622527615;5730.398308177748;5740.770369185186;5923.170756094237;5944.613600115978;5960.314563825215;5935;5973.522118230618;5985.760569577168;5986.970065149646;6054.39456054391;5856.882862342814;5862.443067908542;5864.824055278348;5865.120231965068;5868.354481007171;5760.539156867524;5812.360640329645;5818.76724930998;5819.15622234782;5828.679422631626;5599.0761524349655;5639.154126880837;5773.797917072882;5781.277340332458;5822.155787410887;5943.702814859326;5949.405059494189;5950.613210141327;5957.49361304294;5969.522438204846;5631.155326701028;5671.291088613923;5676.120201368794;5790.884182316246;5816.069428891357 02:47:23 INFO - PROCESS | 14512 | |1;ext.html;584.5177728374092;608.0028752845333;633.562841639269;653.0106888064583;660.606938871372;34348.313033739345;44023.559764402344;44952.77523612377;45171.54828451719;45190.32214516785;45789.7710511447;46339.768301158445;46371.30443043357;46380.3042954356;46419.303710444285;8400.117987611304;8790.208881200675;8939.106089391042;8941.776455588597;8944.329175311845;8238.052623948233;10349.120324772404;10596.470176491182;10598.682039538788;10851.891481085206;10652.840207396895;10702.090322322612;10702.41136737479;10717.571297148144;10723.946380268128;10606.734831629232;10668.679939601825;10684.412357320345;10684.412357320345;10684.946575267113;10594.894051059468;10655.200859935536;10661.466926653637;10664.200184986157;10672.733181670443;42335;42730.78634606807;42732.359014614805;42768.3584746229;42802.78598607018;3588.7308451866215;3592.084018575247;3650.3064417760543;3808.5239345081864;3938.468306778577;30000.249993750112;30680.386392272252;30855.38289234225;31359.216019599466;31654.36691266162;3851.6726078283377;3997.520297564282;3997.600239976008;4010.939835902464;4052.1895620875944;330498.3475082633;333278.99999999756;333518;333973;334939;38082.42876356857;59984;60433;60455.69772151111;60489;38612.227755444736;40999.54002759844;41001.79499102486;41027;41030;16635.085070321005;16771.2452939618;16774.161291935354;16782.496525104267;16790.412335568195;12514.81227781584;12857.292848893214;13491.662708432172;13549.932250338883;13604.387802548908;9177.495237761987;9453.621855125855;9571.138597526116;9582.28132890022;9603.951980240054;3604.891853244407;3654.835532401048;3665.651763082503;3708.554973403209;3718.9628103719156;977.379364103785;1018.8522664213648;1098.4684240167899;1102.4432661506048;1106.9557217711201;33761.662383376344;33838.83080584631;33892;33956.490652640234;34404.82797585996;1112.1603189591967;1117.6535274065066;1134.9602763903224;1198.688341031338;1255.5103509631251;16279.430219942245;16909.23908424124;16984.660306793794;17089.23098460572;17166;534861.6513834812;537067;542720;542926;543568;57980;58023.419765802646;58028.419715803146;58039;58139.70930145322;1281.1864466064117;1294.779887419141;1368.322680273271;1393.5470971934162;1427.0367501936153;31625.36749265048;34068.65931340655;34154.82922585371;34170.8291458551;34313.48529772006;51984;52538.474615253355;52719;52720;52753;423436;426766;427017;427557;430604;29915.803367865043;30275.697243028168;30297.545536816524;30299;30458.543121853632;49226.26160607665;49857.75071124621;49933.500664992884;50051;50737.74631126821;41807.58192418037;41969.37045944252;42162.57837421587;42651;43599;41893;42095.7895210522;42214.57785422107;43454.78272608743;43865;41796.3730544036;42504.78747606242;42916;43536.782316089484;43663;34851.47722784211;36650.63349366579;37157.628423716495;37311;37942.8102859495;29095.854520727262;29197;29329.853350733963;29370.55944160882;29398.55902161512 02:47:23 INFO - PROCESS | 14512 | |2;jquery.html;384.5308723357503;430.5500751714458;438.4059599243026;440.24625964591473;449.2699363534257;16661.333546658134;20216.494587635316;20925.37223883282;20944.16223351066;20969.895150524266;20022.69965950512;20083.698744518806;20093.397198084043;20127.798722012776;20345.694814577793;5545.029619816536;5598.076317407633;5698.059820129673;5719.77120915165;5728.62763920346;5670.461306175906;5749.856253593652;5753.798617048405;5758.769649214027;5764.16419619157;5515.09001014832;5670.432956704317;5704.286964129484;5707.65754054756;5709.600327977043;5486.588505862076;5670.064439367499;5699.601027928046;5700.458456446651;5710.486056254937;5141.640085194038;5162.741862906877;5165.948340516585;5166.43169251382;5173.146430838907;23437.179698710635;23736.881315593484;23806.285811425685;24036.879815600983;24096.27711168668;2122.161746110278;2428.3322086426197;2810.297425643589;2961.141269031978;3003.1140813460083;13796.862031379758;14360.712785744332;14479.78280325796;14511.1293322401;14801.555953321418;1825.8448031917171;1849.9815001849943;1961.3132705872938;1991.8804871707744;1992.9302474413325;85771.57114214389;87342.12657873466;87535;87970.56014719949;90222.54888725515;11784.882151178379;11795.587154449724;11804.822927656092;11908.642740717793;12229.93885030569;17021.744673829904;17046.48860534186;17050.74423883643;17061;17077.82922170787;8758.86861697075;8858.424202426822;8887.200151986352;8976.640934362684;9023.774405639911;8246.257836794717;8423.620937057847;8437.367197460215;8472.237498625153;8625.78435539104;5116.232565115188;5171.4311425743135;5174.818881339135;5210.166373380241;5263.578833714952;2058.2316783925594;2110.2825039486343;2168.5554461335387;2194.7805219478246;2196.2313190383557;921.9907800922039;967.3083745122271;985.556499575194;1032.442481060234;1035.5857656937285;19951.301704440564;20616.58766824685;20741.792582073987;20764.480887977923;20926.16295348169;1018.4093225928943;1031.9071283584362;1040.5005597313332;1060.2843080920347;1087.782443511301;10584.417857017937;11557.537698492135;11647.88352116485;11756.823647645293;11790.587329443428;488696;500922;507047;507613;509054;91205.54397228104;96544;97155;98140.50929745306;99220;1038.2420832792104;1051.4637534857277;1073.2487258918632;1085.4409978860892;1088.2273585754044;18325.717199796418;18741.90629046846;18791.90604046971;18839.492840572995;18973.43079707611;45083.54916450925;45113.548864510936;45142.548574513836;45552;46118.7694061541;62890.37109628845;63015.6849215751;63322.05016924842;63657.68171159115;64493.67753161204;9186.173244408035;9218.764811239265;9334.579943902405;9382.10869967352;9386;10414.531346089292;14062.296885155905;14093.295335233403;14312.499062532761;14832.7775083376;12512.124151309321;12558.497660093493;12585.559505417266;12622.179558328678;12942.870571294166;11288.604898828502;11485.655430337103;12249.755004900031;12896.677583060498;12898.80651790205;12398.442070106687;12591.559295424617;12598.748025039631;12706.174098683925;12737.55418560346;8943.284537237136;9084.22784063362;9249.30630202751;9400.15398614128;9404.059594040815;12218.572349967708;12237.571684990982;12463.252204867737;12696.74606507883;12769.10616256853 02:47:23 INFO - PROCESS | 14512 | |3;mootools.html;1364.8908087353013;1518.5216656753123;1527.6005105296747;1705.1303835044123;1823.115788842412;7668.578228197447;8484.745457636272;8830.24942879856;8838.072002439747;8948.686795962143;8690.08754080822;8761.956190219056;8762.474251544912;8768.912310876889;8779.824403511942;2511.121107612335;2539.2889990802514;2543.224316583441;2545.6563363945816;2546.936326591841;2477.913273035444;2532.025170309435;2542.1102614085016;2546.0961358717573;2549.528337257613;2327.56939966106;2331.708536432946;2394;2394.293683363412;2401.2076014915037;2339.5554844579474;2339.8479098858606;2367.3134790910617;2415.1546958564536;2419.2984034629935;2254.977450225493;2272.3864556569633;2288.3249441414655;2299.1608063057033;2300.735415427214;8686.522241276727;8710.782230444227;8870.334724895594;8873.201411872898;8892.421992570462;5435.809746658848;5535;5550.056490396642;5552.7223638817895;5568.3596386415675;3434.587849458056;3437.724982001434;3515.8417871195857;3521.2429327694413;3611.494390785292;1115.252780636975;1115.6931843743037;1133.1105082510273;1133.7392399748105;1163.9825402618967;12288.262704237684;12291.631251062483;12333.753324933541;12359.876401235962;12394.31831249272;4429.379886815848;4688.203005489075;4766.142094423037;4789.353437285991;4791.808327666924;9625.278104142217;9637.855432168522;9662.71011869645;9694.22446204302;9728.805423891483;5401.297831281908;5411.56707463402;5420.810271640474;5438.374586922476;5442.12925931849;4299.398084268205;4478.507364189936;4514.616257618073;5107.668001579886;5109.846704598868;3987.1228329767987;4004.819783109767;4036.475258216472;4085.7344272622186;4091.8158682859344;1149.8792626774068;1170.3329102411544;1184.4492311075392;1192.5945178639304;1235.3452670084869;751.1031827997363;1035.5805898611075;1037.9792404151874;1049.9475026248656;1051.6634676903318;6062.090686397076;6132.141500189977;6227.159333489921;6277.2153480814895;6309.842253943596;994.1947022911465;1010.7523656704008;1016.7508960304773;1023.3961962442195;1036.9118624916816;3890.2219556088894;4166.604172603658;4207.6423504002505;4290.764007979528;4302.698811083257;10266.281360304856;10457.84313235302;10609.628662996758;10635.46822658864;10648.733781655366;10521.52653130611;10530.36817790935;10531.684049478528;10534.104601108991;10584.947075264728;8027.07688615805;8153.470024448392;8161.143079976636;8165.836683266421;8170.509769413736;5957;6125.540584456095;6134.294556126102;6220.253569571681;6277.058441233851;9720.222382209548;9909.900900991186;9942.602295908082;9989.200863931013;10103.7474063149;9110.498922559324;9419.387739796892;9865.112139907444;10014.949925250326;10283.33158344735;7255.709771609288;7396.852062958818;7409.333160015624;7772.494787838772;7873.173316801883;8498.70254541088;8549.957250213709;8621.267192288475;8654.350923680875;8663.306935445024;7775.105862825621;7839;7862.567558784322;7904.407169462198;8064.758057258292;7363.852722945619;7589;7633;7740.806479837824;7875.330596899099;7249.420046396381;7362.116546014512;7362.77911662651;7373.741919033023;7376.336129748348;5201.92197117036;5238.947610523846;5271.077561426811;5311.070562651597;5463.644863083887;5118.334616499831;5266.34170728659;5292.153255479105;5399.4060653327315;5590.133529302964 02:47:23 INFO - PROCESS | 14512 | |4;prototype.html;345.3076581454184;358.3442300589921;361.0666427285467;362.8403502458918;363.4058314655539;5420.24116623673;5435.1847222916585;5465.529388838092;5478.45215478452;5520.392756796754;5087.923681144785;5236.633435659505;5238.8690282742955;5314.990151871142;5378.838634840961;4234.322508398657;4237.322028475444;4240.469941257343;4268.167707297078;4271.209826182167;4257.638100761439;4264.936025959613;4288.228118938589;4294.291441912081;4295.763732994684;4124.381342798574;4211.599898009684;4216;4222.788860556975;4223.1975924574235;4190.53904070552;4191.365367506675;4198.8110535026;4207.305794543881;4212.936805947913;3738.55137383513;3764.7929363884973;3765.491658626105;3767.566729826078;3771.6605505504363;5159.896802063975;5177.948220517785;5179.482051794828;5226.294450249244;5302.125149350352;4800.567948884583;4806.903861922777;4821.445533763627;4824.324594556765;4836.492168322346;5532.834014979557;5545.944540554583;5560.36055853578;5560.944390556124;5573.442655734394;3981.163955569334;4068.877933661995;4078.3474644057105;4125.195586860564;4166.354215096634;5727.742251598688;5751.712414379264;5758.107493338539;5787.479126878559;5803.303603567599;4211.810468528924;4212.789360531961;4216.325387937915;4261.850835220753;4273.615374616299;4150.91698166041;4324.913501729948;4328.156009578102;4337.652987760972;4382.583654552876;4838.483988326121;4847.442544107403;4858.708477491362;4867.61059115277;4869.659123861366;5645.503941455518;5647.435256474402;5649.6327738696855;5665.405132461115;5675.971620141955;1438.719449707297;1450.8476609956015;1460.7443697352921;1465.8094447721728;1468.8531146885225;1002.2032484175098;1012.9240306977006;1033.3902997231519;1035.316690983962;1036.76154484469;5290;5306.310179676618;5311.7344132793205;5324.201369794562;5338.306020217425;5490.313710786152;5550.222968784374;5553.278073850454;5553.555715542828;5561.499465048165;5150.630709873501;5219.947800521946;5247.501487358695;5294.97352513235;5306.97346513265;2911.7670586353042;2915.8833646653898;2930.750886174699;2933.3839893622153;2950.451013218035;5785.971070144707;5792.884142317214;5794.696193356461;5852.912206316909;5855.970720146372;5409.83770486886;5580.720963951786;5611.77323039254;5625.409332020161;5647.322321321386;5772.6536407815665;5774.393688662714;5786.267857232062;5786.768529258867;5834.045594725814;5302.522772950453;5447.210154527492;5616.550675945996;5649.68926709035;5653.943460565341;5456.618036737549;5479.753411096431;5499.670019798825;5511.090670039399;5512.972435137799;5859.20900678403;5868.882622347443;5886.411358864079;5901.852453688693;5960.731767070579;4046.5346485153405;4068.389741538793;4177.707560470738;4208.873733787868;4209.705320627527;5524.696141712245;5556.38879723222;5576.5817563683695;5587.525060369751;5590.707809797963;5495.450454954473;5621.747021383966;5629.324481062299;5653.943460565341;5664.886702266014;5417.349918009706;5590.496855283044;5621.409751975983;5624.915626265692;5628.268325117709;5573.27547418833;5589.720513974366;5601.327840659147;5602.411746766694;5602.691851948182;5636;5659.943400566106;5683.573731970201;5695.401982791747;5700.486956173964;5297.007190937262;5563.7774489019985;5585.218069470358;5594.188842617717;5594.636348637326 02:47:23 INFO - PROCESS | 14512 | |5;yui.html;760.5474742528197;769.4459988808056;833.1210572845647;868.7610907000578;872.4634349874827;14896.627584310398;14958.326875290611;15057.247137643102;15106.848931510694;15262.313195906183;14723.926380368082;14774.926125369386;14824.851751482482;14897.627559311022;15061.397544098223;723.3381455967783;856.575994882534;870.8606622940331;872.5419154943642;872.9694460693877;744.9366803821682;848.2874385516166;875.5140896802272;881.7663319220412;883.9292856571491;923.2429407885537;926.420986883198;926.4904302633558;927;927.23966347595;759.8670232709254;912.1243606138115;917.6467060181844;918.2791508665699;919.0992827029515;577.4600748300353;654.5189285874878;671.0169601533777;671.778313156662;675.061664286642;14853;14883.553493395215;14888.404463821435;14913.552593422215;14915.328810203458;13095.672608184776;13387.866121338759;13753.862461375358;13914;13918.721625567534;11499.950134636432;11613.129015323884;11772.23480473775;11865.762684746256;11892.702682432922;4309.741415515079;4328;4332.415123958257;4333.71830830995;4413.7793110344355;63978.36021639724;65055.3494465054;65149.674251628916;65301.67349163271;66140.6692966537;10810;10855.402952837512;10997;11050.281731687415;11054.502547385388;19430.833019223533;19556.608867822848;19621.50946226356;20358.18567257293;20431.38705838827;7969.362451003905;8133.146019667968;8176.836463270702;8200.630971606173;8207.835843283101;4215.515215750167;4312.978435107867;4318;4335.631471324909;4579.656525760582;3428.211511352403;3464.6015708193377;3535.045537704805;3542.5926018507685;3542.964570354315;634.7207228819304;640.3244576971247;642.5823214910346;643.0771842406162;662.8044726805507;613.5858295650418;665.3147258323837;671.8602689425834;684.852756657321;692.2592825676578;9140.6800761973;9394.61469815494;9407.576659050359;9609.663661771805;9726.367786094022;679.5288201044782;686.1713533433444;688.652230623542;711.0827033127312;711.2720294005592;4326.718763280377;4389.385486031958;4483.529229430928;4506.1663592235545;4543.886402839889;56639.43360566424;77111.8433223502;92726;96061.5196924011;96269.51865240629;82771.5861420689;83630;83727.90680233043;85068.4705494141;89195;71762.64118679373;73718;73879.63060184772;75509.6224518874;77738.61130694424;8555.57222138903;8804.691835785718;9067.36528443029;9162.58768355439;9180;34572;37830.62169378271;41951.58048419477;45276.320855187856;50257.49742502528;64138;64554.354456454836;65071.67464162649;65796.67101664461;67144.66427668025;11020.118390528898;11258.493367798304;11270.492827822603;11351.37567433799;11880.940595296968;12702.936485317514;12714.872851271739;12859.16415432994;13135.277559734306;13262.403191856196;11477.36874471912;11907.642770716893;11959.581414650445;11993.880061199625;12633.620991370273;11516.94241528787;12822.871771282167;12979.545715900276;13407.597772066854;13626.046176767532;13900.235487048309;14342.282885855875;14350.928245358706;14679.41282348694;14712.04371715835;10342.586296548054;10943.28868623537;11074.501647425725;11124.888751112385;11811.114166437723;10585;10723.517441714985;10944.56221751153;10969.670909872717;11031.22781405294 02:47:23 INFO - PROCESS | 14512 | __end_tp_report 02:47:23 INFO - PROCESS | 14512 | __start_cc_report 02:47:23 INFO - PROCESS | 14512 | _x_x_mozilla_cycle_collect,1028 02:47:23 INFO - PROCESS | 14512 | __end_cc_report 02:47:23 INFO - PROCESS | 14512 | __startTimestamp1482835643053__endTimestamp 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | ------- Summary: start ------- 02:47:23 INFO - PROCESS | 14512 | Number of tests: 6 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#0] dojo.html Cycles:165 Average:5604.76 Median:5780.42 stddev:624.71 (10.8%) stddev-sans-first:598.02 02:47:23 INFO - PROCESS | 14512 | Values: 3222.3 3253.0 3257.8 3293.7 3295.6 5575.2 5623.5 5658.7 5672.1 5690.7 5624.1 5694.5 5694.5 5710.0 5720.5 5149.1 5176.8 5190.1 5206.2 5251.0 5025.5 5040.3 5245.9 5254.7 5292.9 5059.5 5079.8 5081.1 5157.8 5167.2 5139.9 5173.5 5244.8 5248.1 5267.9 4907.1 5021.5 5129.4 5147.6 5211.3 5510.2 5513.8 5517.5 5542.3 5582.2 5942.4 6040.6 6064.8 6071.3 6073.4 5900.1 5934.9 6108.4 6123.1 6130.3 5646.9 5689.3 5696.4 5707.3 5736.1 6220.4 6229.8 6229.9 6236.7 6238.2 5741.3 5778.1 5920.1 5932.7 5933.9 5905.9 5998.1 6030.4 6059.9 6101.3 6039.4 6041.9 6042.3 6044.3 6049.0 5862.1 6010.4 6059.5 6061.2 6064.6 4616.3 4635.6 4638.8 4663.6 4665.9 4182.7 4183.2 4190.0 4205.6 4208.7 5763.0 5766.6 5770.6 5775.6 5778.4 5912.8 5964.3 5981.9 6009.5 6032.0 5773.0 5780.4 5783.8 5800.1 5816.2 5163.9 5241.7 5246.3 5250.8 5251.4 6120.0 6143.7 6213.9 6324.6 6332.9 6016.4 6043.5 6054.7 6077.6 6082.1 6285.9 6310.3 6311.4 6315.9 6318.9 5730.4 5740.8 5923.2 5944.6 5960.3 5935.0 5973.5 5985.8 5987.0 6054.4 5856.9 5862.4 5864.8 5865.1 5868.4 5760.5 5812.4 5818.8 5819.2 5828.7 5599.1 5639.2 5773.8 5781.3 5822.2 5943.7 5949.4 5950.6 5957.5 5969.5 5631.2 5671.3 5676.1 5790.9 5816.1 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#1] ext.html Cycles:180 Average:59302.97 Median:37626.91 stddev:117137.57 (311.3%) stddev-sans-first:117383.21 02:47:23 INFO - PROCESS | 14512 | Values: 584.5 608.0 633.6 653.0 660.6 34348.3 44023.6 44952.8 45171.5 45190.3 45789.8 46339.8 46371.3 46380.3 46419.3 8400.1 8790.2 8939.1 8941.8 8944.3 8238.1 10349.1 10596.5 10598.7 10851.9 10652.8 10702.1 10702.4 10717.6 10723.9 10606.7 10668.7 10684.4 10684.4 10684.9 10594.9 10655.2 10661.5 10664.2 10672.7 42335.0 42730.8 42732.4 42768.4 42802.8 3588.7 3592.1 3650.3 3808.5 3938.5 30000.2 30680.4 30855.4 31359.2 31654.4 3851.7 3997.5 3997.6 4010.9 4052.2 330498.3 333279.0 333518.0 333973.0 334939.0 38082.4 59984.0 60433.0 60455.7 60489.0 38612.2 40999.5 41001.8 41027.0 41030.0 16635.1 16771.2 16774.2 16782.5 16790.4 12514.8 12857.3 13491.7 13549.9 13604.4 9177.5 9453.6 9571.1 9582.3 9604.0 3604.9 3654.8 3665.7 3708.6 3719.0 977.4 1018.9 1098.5 1102.4 1107.0 33761.7 33838.8 33892.0 33956.5 34404.8 1112.2 1117.7 1135.0 1198.7 1255.5 16279.4 16909.2 16984.7 17089.2 17166.0 534861.7 537067.0 542720.0 542926.0 543568.0 57980.0 58023.4 58028.4 58039.0 58139.7 1281.2 1294.8 1368.3 1393.5 1427.0 31625.4 34068.7 34154.8 34170.8 34313.5 51984.0 52538.5 52719.0 52720.0 52753.0 423436.0 426766.0 427017.0 427557.0 430604.0 29915.8 30275.7 30297.5 30299.0 30458.5 49226.3 49857.8 49933.5 50051.0 50737.7 41807.6 41969.4 42162.6 42651.0 43599.0 41893.0 42095.8 42214.6 43454.8 43865.0 41796.4 42504.8 42916.0 43536.8 43663.0 34851.5 36650.6 37157.6 37311.0 37942.8 29095.9 29197.0 29329.9 29370.6 29398.6 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#2] jquery.html Cycles:180 Average:30456.62 Median:23921.58 stddev:83011.80 (347.0%) stddev-sans-first:83213.96 02:47:23 INFO - PROCESS | 14512 | Values: 384.5 430.6 438.4 440.2 449.3 16661.3 20216.5 20925.4 20944.2 20969.9 20022.7 20083.7 20093.4 20127.8 20345.7 5545.0 5598.1 5698.1 5719.8 5728.6 5670.5 5749.9 5753.8 5758.8 5764.2 5515.1 5670.4 5704.3 5707.7 5709.6 5486.6 5670.1 5699.6 5700.5 5710.5 5141.6 5162.7 5165.9 5166.4 5173.1 23437.2 23736.9 23806.3 24036.9 24096.3 2122.2 2428.3 2810.3 2961.1 3003.1 13796.9 14360.7 14479.8 14511.1 14801.6 1825.8 1850.0 1961.3 1991.9 1992.9 85771.6 87342.1 87535.0 87970.6 90222.5 11784.9 11795.6 11804.8 11908.6 12229.9 17021.7 17046.5 17050.7 17061.0 17077.8 8758.9 8858.4 8887.2 8976.6 9023.8 8246.3 8423.6 8437.4 8472.2 8625.8 5116.2 5171.4 5174.8 5210.2 5263.6 2058.2 2110.3 2168.6 2194.8 2196.2 922.0 967.3 985.6 1032.4 1035.6 19951.3 20616.6 20741.8 20764.5 20926.2 1018.4 1031.9 1040.5 1060.3 1087.8 10584.4 11557.5 11647.9 11756.8 11790.6 488696.0 500922.0 507047.0 507613.0 509054.0 91205.5 96544.0 97155.0 98140.5 99220.0 1038.2 1051.5 1073.2 1085.4 1088.2 18325.7 18741.9 18791.9 18839.5 18973.4 45083.5 45113.5 45142.5 45552.0 46118.8 62890.4 63015.7 63322.1 63657.7 64493.7 9186.2 9218.8 9334.6 9382.1 9386.0 10414.5 14062.3 14093.3 14312.5 14832.8 12512.1 12558.5 12585.6 12622.2 12942.9 11288.6 11485.7 12249.8 12896.7 12898.8 12398.4 12591.6 12598.7 12706.2 12737.6 8943.3 9084.2 9249.3 9400.2 9404.1 12218.6 12237.6 12463.3 12696.7 12769.1 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#3] mootools.html Cycles:180 Average:5806.79 Median:5114.09 stddev:3198.02 (62.5%) stddev-sans-first:3189.57 02:47:23 INFO - PROCESS | 14512 | Values: 1364.9 1518.5 1527.6 1705.1 1823.1 7668.6 8484.7 8830.2 8838.1 8948.7 8690.1 8762.0 8762.5 8768.9 8779.8 2511.1 2539.3 2543.2 2545.7 2546.9 2477.9 2532.0 2542.1 2546.1 2549.5 2327.6 2331.7 2394.0 2394.3 2401.2 2339.6 2339.8 2367.3 2415.2 2419.3 2255.0 2272.4 2288.3 2299.2 2300.7 8686.5 8710.8 8870.3 8873.2 8892.4 5435.8 5535.0 5550.1 5552.7 5568.4 3434.6 3437.7 3515.8 3521.2 3611.5 1115.3 1115.7 1133.1 1133.7 1164.0 12288.3 12291.6 12333.8 12359.9 12394.3 4429.4 4688.2 4766.1 4789.4 4791.8 9625.3 9637.9 9662.7 9694.2 9728.8 5401.3 5411.6 5420.8 5438.4 5442.1 4299.4 4478.5 4514.6 5107.7 5109.8 3987.1 4004.8 4036.5 4085.7 4091.8 1149.9 1170.3 1184.4 1192.6 1235.3 751.1 1035.6 1038.0 1049.9 1051.7 6062.1 6132.1 6227.2 6277.2 6309.8 994.2 1010.8 1016.8 1023.4 1036.9 3890.2 4166.6 4207.6 4290.8 4302.7 10266.3 10457.8 10609.6 10635.5 10648.7 10521.5 10530.4 10531.7 10534.1 10584.9 8027.1 8153.5 8161.1 8165.8 8170.5 5957.0 6125.5 6134.3 6220.3 6277.1 9720.2 9909.9 9942.6 9989.2 10103.7 9110.5 9419.4 9865.1 10014.9 10283.3 7255.7 7396.9 7409.3 7772.5 7873.2 8498.7 8550.0 8621.3 8654.4 8663.3 7775.1 7839.0 7862.6 7904.4 8064.8 7363.9 7589.0 7633.0 7740.8 7875.3 7249.4 7362.1 7362.8 7373.7 7376.3 5201.9 5238.9 5271.1 5311.1 5463.6 5118.3 5266.3 5292.2 5399.4 5590.1 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#4] prototype.html Cycles:180 Average:4709.95 Median:5306.64 stddev:1347.66 (25.4%) stddev-sans-first:1311.02 02:47:23 INFO - PROCESS | 14512 | Values: 345.3 358.3 361.1 362.8 363.4 5420.2 5435.2 5465.5 5478.5 5520.4 5087.9 5236.6 5238.9 5315.0 5378.8 4234.3 4237.3 4240.5 4268.2 4271.2 4257.6 4264.9 4288.2 4294.3 4295.8 4124.4 4211.6 4216.0 4222.8 4223.2 4190.5 4191.4 4198.8 4207.3 4212.9 3738.6 3764.8 3765.5 3767.6 3771.7 5159.9 5177.9 5179.5 5226.3 5302.1 4800.6 4806.9 4821.4 4824.3 4836.5 5532.8 5545.9 5560.4 5560.9 5573.4 3981.2 4068.9 4078.3 4125.2 4166.4 5727.7 5751.7 5758.1 5787.5 5803.3 4211.8 4212.8 4216.3 4261.9 4273.6 4150.9 4324.9 4328.2 4337.7 4382.6 4838.5 4847.4 4858.7 4867.6 4869.7 5645.5 5647.4 5649.6 5665.4 5676.0 1438.7 1450.8 1460.7 1465.8 1468.9 1002.2 1012.9 1033.4 1035.3 1036.8 5290.0 5306.3 5311.7 5324.2 5338.3 5490.3 5550.2 5553.3 5553.6 5561.5 5150.6 5219.9 5247.5 5295.0 5307.0 2911.8 2915.9 2930.8 2933.4 2950.5 5786.0 5792.9 5794.7 5852.9 5856.0 5409.8 5580.7 5611.8 5625.4 5647.3 5772.7 5774.4 5786.3 5786.8 5834.0 5302.5 5447.2 5616.6 5649.7 5653.9 5456.6 5479.8 5499.7 5511.1 5513.0 5859.2 5868.9 5886.4 5901.9 5960.7 4046.5 4068.4 4177.7 4208.9 4209.7 5524.7 5556.4 5576.6 5587.5 5590.7 5495.5 5621.7 5629.3 5653.9 5664.9 5417.3 5590.5 5621.4 5624.9 5628.3 5573.3 5589.7 5601.3 5602.4 5602.7 5636.0 5659.9 5683.6 5695.4 5700.5 5297.0 5563.8 5585.2 5594.2 5594.6 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - PROCESS | 14512 | [#5] yui.html Cycles:180 Average:18117.18 Median:24891.24 stddev:24436.80 (98.2%) stddev-sans-first:24470.59 02:47:23 INFO - PROCESS | 14512 | Values: 760.5 769.4 833.1 868.8 872.5 14896.6 14958.3 15057.2 15106.8 15262.3 14723.9 14774.9 14824.9 14897.6 15061.4 723.3 856.6 870.9 872.5 873.0 744.9 848.3 875.5 881.8 883.9 923.2 926.4 926.5 927.0 927.2 759.9 912.1 917.6 918.3 919.1 577.5 654.5 671.0 671.8 675.1 14853.0 14883.6 14888.4 14913.6 14915.3 13095.7 13387.9 13753.9 13914.0 13918.7 11500.0 11613.1 11772.2 11865.8 11892.7 4309.7 4328.0 4332.4 4333.7 4413.8 63978.4 65055.3 65149.7 65301.7 66140.7 10810.0 10855.4 10997.0 11050.3 11054.5 19430.8 19556.6 19621.5 20358.2 20431.4 7969.4 8133.1 8176.8 8200.6 8207.8 4215.5 4313.0 4318.0 4335.6 4579.7 3428.2 3464.6 3535.0 3542.6 3543.0 634.7 640.3 642.6 643.1 662.8 613.6 665.3 671.9 684.9 692.3 9140.7 9394.6 9407.6 9609.7 9726.4 679.5 686.2 688.7 711.1 711.3 4326.7 4389.4 4483.5 4506.2 4543.9 56639.4 77111.8 92726.0 96061.5 96269.5 82771.6 83630.0 83727.9 85068.5 89195.0 71762.6 73718.0 73879.6 75509.6 77738.6 8555.6 8804.7 9067.4 9162.6 9180.0 34572.0 37830.6 41951.6 45276.3 50257.5 64138.0 64554.4 65071.7 65796.7 67144.7 11020.1 11258.5 11270.5 11351.4 11880.9 12702.9 12714.9 12859.2 13135.3 13262.4 11477.4 11907.6 11959.6 11993.9 12633.6 11516.9 12822.9 12979.5 13407.6 13626.0 13900.2 14342.3 14350.9 14679.4 14712.0 10342.6 10943.3 11074.5 11124.9 11811.1 10585.0 10723.5 10944.6 10969.7 11031.2 02:47:23 INFO - PROCESS | 14512 | -------- Summary: end -------- 02:47:23 INFO - PROCESS | 14512 | 02:47:23 INFO - TEST-INFO | 14512: exit 0 02:47:23 INFO - TEST-OK | dromaeo_css | took 1115905ms 02:47:23 INFO - TEST-START | kraken 02:47:23 INFO - operating with platform_type : linux_ 02:47:23 INFO - Initialising browser for kraken test... 02:47:23 INFO - TEST-INFO | started process 14830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBItqe/profile http://localhost:58448/getInfo.html) 02:47:28 INFO - PROCESS | 14830 | __metrics Screen width/height:1600/1200 02:47:28 INFO - PROCESS | 14830 | colorDepth:24 02:47:28 INFO - PROCESS | 14830 | Browser inner width/height: 1024/697 02:47:28 INFO - PROCESS | 14830 | __metrics 02:47:28 INFO - PROCESS | 14830 | 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" 02:47:28 INFO - PROCESS | 14830 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:29 INFO - PROCESS | 14830 | console.error: PushService: 02:47:29 INFO - PROCESS | 14830 | stateChangeProcessEnqueue: Error transitioning state 02:47:29 INFO - PROCESS | 14830 | UnknownError 02:47:29 INFO - TEST-INFO | 14830: exit 0 02:47:29 INFO - Browser initialized. 02:47:29 INFO - Running cycle 1/1 for kraken test... 02:47:29 INFO - TEST-INFO | started process 14926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBItqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:41 INFO - PROCESS | 14926 | RSS: Main: 144359424 02:47:41 INFO - PROCESS | 14926 | 02:47:44 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58448/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:44 INFO - PROCESS | 14926 | RSS: Main: 186408960 02:47:44 INFO - PROCESS | 14926 | 02:47:47 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58448/tests/kraken/driver.html?testName=audio-dft) 02:47:48 INFO - PROCESS | 14926 | RSS: Main: 175820800 02:47:48 INFO - PROCESS | 14926 | 02:47:50 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58448/tests/kraken/driver.html?testName=audio-fft) 02:47:51 INFO - PROCESS | 14926 | RSS: Main: 266149888 02:47:51 INFO - PROCESS | 14926 | 02:47:53 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58448/tests/kraken/driver.html?testName=audio-oscillator) 02:47:54 INFO - PROCESS | 14926 | RSS: Main: 172879872 02:47:54 INFO - PROCESS | 14926 | 02:47:56 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:56 INFO - PROCESS | 14926 | RSS: Main: 175058944 02:47:56 INFO - PROCESS | 14926 | 02:47:59 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58448/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:00 INFO - PROCESS | 14926 | RSS: Main: 213979136 02:48:00 INFO - PROCESS | 14926 | 02:48:03 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58448/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:04 INFO - PROCESS | 14926 | RSS: Main: 213037056 02:48:04 INFO - PROCESS | 14926 | 02:48:06 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58448/tests/kraken/driver.html?testName=json-parse-financial) 02:48:07 INFO - PROCESS | 14926 | RSS: Main: 211013632 02:48:07 INFO - PROCESS | 14926 | 02:48:08 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:09 INFO - PROCESS | 14926 | RSS: Main: 173387776 02:48:09 INFO - PROCESS | 14926 | 02:48:11 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:11 INFO - PROCESS | 14926 | RSS: Main: 181035008 02:48:11 INFO - PROCESS | 14926 | 02:48:13 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:14 INFO - PROCESS | 14926 | RSS: Main: 190001152 02:48:14 INFO - PROCESS | 14926 | 02:48:17 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:17 INFO - PROCESS | 14926 | RSS: Main: 198291456 02:48:17 INFO - PROCESS | 14926 | 02:48:20 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:21 INFO - PROCESS | 14926 | RSS: Main: 195039232 02:48:21 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | Cycle 1(1): loaded http://localhost:58448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58448/tests/kraken/driver.html?testName=ai-astar) 02:48:22 INFO - PROCESS | 14926 | RSS: Main: 246145024 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | __start_tp_report 02:48:22 INFO - PROCESS | 14926 | _x_x_mozilla_page_load 02:48:22 INFO - PROCESS | 14926 | _x_x_mozilla_page_load_details 02:48:22 INFO - PROCESS | 14926 | |i|pagename|runs| 02:48:22 INFO - PROCESS | 14926 | |0;ai-astar;103;112;112;112;112;112;111;110;111;110 02:48:22 INFO - PROCESS | 14926 | |1;audio-beat-detection;140;117;120;152;120;118;117;117;148;120 02:48:22 INFO - PROCESS | 14926 | |2;audio-dft;162;160;162;160;160;161;161;161;161;160 02:48:22 INFO - PROCESS | 14926 | |3;audio-fft;77;76;75;108;76;76;76;76;97;75 02:48:22 INFO - PROCESS | 14926 | |4;audio-oscillator;82;81;114;82;82;82;98;82;81;107 02:48:22 INFO - PROCESS | 14926 | |5;imaging-gaussian-blur;118;116;116;117;117;117;117;117;117;117 02:48:22 INFO - PROCESS | 14926 | |6;imaging-darkroom;146;146;145;146;147;147;146;146;145;145 02:48:22 INFO - PROCESS | 14926 | |7;imaging-desaturate;84;85;85;85;84;85;85;86;84;85 02:48:22 INFO - PROCESS | 14926 | |8;json-parse-financial;50;49;50;50;50;49;50;49;49;50 02:48:22 INFO - PROCESS | 14926 | |9;json-stringify-tinderbox;57;58;58;58;59;58;59;62;58;59 02:48:22 INFO - PROCESS | 14926 | |10;stanford-crypto-aes;76;75;74;74;75;74;74;73;73;73 02:48:22 INFO - PROCESS | 14926 | |11;stanford-crypto-ccm;122;125;121;135;120;119;128;127;157;128 02:48:22 INFO - PROCESS | 14926 | |12;stanford-crypto-pbkdf2;160;159;158;158;162;159;162;155;157;159 02:48:22 INFO - PROCESS | 14926 | |13;stanford-crypto-sha256-iterative;64;63;63;67;63;63;64;62;63;62 02:48:22 INFO - PROCESS | 14926 | __end_tp_report 02:48:22 INFO - PROCESS | 14926 | __start_cc_report 02:48:22 INFO - PROCESS | 14926 | _x_x_mozilla_cycle_collect,1618 02:48:22 INFO - PROCESS | 14926 | __end_cc_report 02:48:22 INFO - PROCESS | 14926 | __startTimestamp1482835702910__endTimestamp 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | ------- Summary: start ------- 02:48:22 INFO - PROCESS | 14926 | Number of tests: 14 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 02:48:22 INFO - PROCESS | 14926 | Values: 103.0 112.0 112.0 112.0 112.0 112.0 111.0 110.0 111.0 110.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:120.00 stddev:14.00 (11.7%) stddev-sans-first:14.02 02:48:22 INFO - PROCESS | 14926 | Values: 140.0 117.0 120.0 152.0 120.0 118.0 117.0 117.0 148.0 120.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:48:22 INFO - PROCESS | 14926 | Values: 162.0 160.0 162.0 160.0 160.0 161.0 161.0 161.0 161.0 160.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.54 (15.2%) stddev-sans-first:12.13 02:48:22 INFO - PROCESS | 14926 | Values: 77.0 76.0 75.0 108.0 76.0 76.0 76.0 76.0 97.0 75.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:12.49 (15.2%) stddev-sans-first:12.98 02:48:22 INFO - PROCESS | 14926 | Values: 82.0 81.0 114.0 82.0 82.0 82.0 98.0 82.0 81.0 107.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:48:22 INFO - PROCESS | 14926 | Values: 118.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:48:22 INFO - PROCESS | 14926 | Values: 146.0 146.0 145.0 146.0 147.0 147.0 146.0 146.0 145.0 145.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:48:22 INFO - PROCESS | 14926 | Values: 84.0 85.0 85.0 85.0 84.0 85.0 85.0 86.0 84.0 85.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 02:48:22 INFO - PROCESS | 14926 | Values: 50.0 49.0 50.0 50.0 50.0 49.0 50.0 49.0 49.0 50.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:1.35 (2.3%) stddev-sans-first:1.30 02:48:22 INFO - PROCESS | 14926 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 59.0 62.0 58.0 59.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:0.78 02:48:22 INFO - PROCESS | 14926 | Values: 76.0 75.0 74.0 74.0 75.0 74.0 74.0 73.0 73.0 73.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:127.50 stddev:11.20 (8.8%) stddev-sans-first:11.66 02:48:22 INFO - PROCESS | 14926 | Values: 122.0 125.0 121.0 135.0 120.0 119.0 128.0 127.0 157.0 128.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.13 (1.3%) stddev-sans-first:2.22 02:48:22 INFO - PROCESS | 14926 | Values: 160.0 159.0 158.0 158.0 162.0 159.0 162.0 155.0 157.0 159.0 02:48:22 INFO - PROCESS | 14926 | 02:48:22 INFO - PROCESS | 14926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.50 02:48:22 INFO - PROCESS | 14926 | Values: 64.0 63.0 63.0 67.0 63.0 63.0 64.0 62.0 63.0 62.0 02:48:22 INFO - PROCESS | 14926 | -------- Summary: end -------- 02:48:22 INFO - PROCESS | 14926 | 02:48:23 INFO - TEST-INFO | 14926: exit 0 02:48:24 INFO - TEST-OK | kraken | took 60201ms 02:48:24 INFO - SUITE-END | took 1176s 02:48:24 INFO - Completed test suite (00:19:36) 02:48:24 INFO - javascript benchmark 02:48:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.3072039511508, 3253.0240927721684, 3257.771955963082, 3293.736501079914, 3295.6045274567055, 5575.219469274305, 5623.4938855503, 5658.745356458959, 5672.12082127271, 5690.743916523756, 5624.100143976964, 5694.4590263924865, 5694.487496125348, 5710.0, 5720.513756330706, 5149.0731668299695, 5176.7929282828645, 5190.091733946544, 5206.167013277876, 5250.973745131269, 5025.522575355335, 5040.344755181821, 5245.921311180336, 5254.658447200939, 5292.947070529303, 5059.49405059493, 5079.822206222783, 5081.085404627165, 5157.8452646420665, 5167.199084141964, 5139.946311006235, 5173.534381905628, 5244.842654720364, 5248.0553500369915, 5267.947320526784, 4907.092187945206, 5021.49785021495, 5129.358830146231, 5147.562457191143, 5211.270422140903, 5510.228568000483, 5513.751881165357, 5517.503424691797, 5542.307211598551, 5582.190582365534, 5942.435468630516, 6040.637561746309, 6064.818055458343, 6071.271447426293, 6073.423024812636, 5900.144479050557, 5934.851628709273, 6108.358622344679, 6123.112148738453, 6130.264368275835, 5646.858828529279, 5689.260396148474, 5696.401877802854, 5707.286589176353, 5736.053551164095, 6220.440160385497, 6229.750809967551, 6229.909765790969, 6236.688165591702, 6238.220222472191, 5741.282339707536, 5778.104393818965, 5920.141579470953, 5932.7330270137945, 5933.881322373615, 5905.852353691193, 5998.100284957204, 6030.427109424598, 6059.939400606026, 6101.328853826076, 6039.4262545058145, 6041.909371359433, 6042.335343112254, 6044.304904935901, 6049.001914684116, 5862.12068189775, 6010.429009244115, 6059.454649081604, 6061.151438798572, 6064.575479716465, 4616.330632058332, 4635.582797548237, 4638.768061596907, 4663.580277775017, 4665.883352916137, 4182.665386769051, 4183.163367326547, 4189.958100419018, 4205.558416366299, 4208.747475151439, 5763.0, 5766.5675074368755, 5770.567207459373, 5775.595708300379, 5778.36437991829, 5912.76348946046, 5964.343922168558, 5981.880362392728, 6009.549283803644, 6032.0, 5773.047447171254, 5780.421957804186, 5783.797567085132, 5800.100984347433, 5816.185733997244, 5163.870903227449, 5241.68549887008, 5246.291750613695, 5250.816221432232, 5251.396089449686, 6120.0, 6143.665407145435, 6213.9067913982235, 6324.620522768649, 6332.873342533124, 6016.368281330398, 6043.516518678583, 6054.7275372607455, 6077.635341879324, 6082.118092876596, 6285.874282514415, 6310.337414571404, 6311.368863113652, 6315.905261421174, 6318.873622527615, 5730.398308177748, 5740.770369185186, 5923.170756094237, 5944.613600115978, 5960.314563825215, 5935.0, 5973.522118230618, 5985.760569577168, 5986.970065149646, 6054.39456054391, 5856.882862342814, 5862.443067908542, 5864.824055278348, 5865.120231965068, 5868.354481007171, 5760.539156867524, 5812.360640329645, 5818.76724930998, 5819.15622234782, 5828.679422631626, 5599.0761524349655, 5639.154126880837, 5773.797917072882, 5781.277340332458, 5822.155787410887, 5943.702814859326, 5949.405059494189, 5950.613210141327, 5957.49361304294, 5969.522438204846, 5631.155326701028, 5671.291088613923, 5676.120201368794, 5790.884182316246, 5816.069428891357], "value": 5563.359916072162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5177728374092, 608.0028752845333, 633.562841639269, 653.0106888064583, 660.606938871372, 34348.313033739345, 44023.559764402344, 44952.77523612377, 45171.54828451719, 45190.32214516785, 45789.7710511447, 46339.768301158445, 46371.30443043357, 46380.3042954356, 46419.303710444285, 8400.117987611304, 8790.208881200675, 8939.106089391042, 8941.776455588597, 8944.329175311845, 8238.052623948233, 10349.120324772404, 10596.470176491182, 10598.682039538788, 10851.891481085206, 10652.840207396895, 10702.090322322612, 10702.41136737479, 10717.571297148144, 10723.946380268128, 10606.734831629232, 10668.679939601825, 10684.412357320345, 10684.412357320345, 10684.946575267113, 10594.894051059468, 10655.200859935536, 10661.466926653637, 10664.200184986157, 10672.733181670443, 42335.0, 42730.78634606807, 42732.359014614805, 42768.3584746229, 42802.78598607018, 3588.7308451866215, 3592.084018575247, 3650.3064417760543, 3808.5239345081864, 3938.468306778577, 30000.249993750112, 30680.386392272252, 30855.38289234225, 31359.216019599466, 31654.36691266162, 3851.6726078283377, 3997.520297564282, 3997.600239976008, 4010.939835902464, 4052.1895620875944, 330498.3475082633, 333278.99999999756, 333518.0, 333973.0, 334939.0, 38082.42876356857, 59984.0, 60433.0, 60455.69772151111, 60489.0, 38612.227755444736, 40999.54002759844, 41001.79499102486, 41027.0, 41030.0, 16635.085070321005, 16771.2452939618, 16774.161291935354, 16782.496525104267, 16790.412335568195, 12514.81227781584, 12857.292848893214, 13491.662708432172, 13549.932250338883, 13604.387802548908, 9177.495237761987, 9453.621855125855, 9571.138597526116, 9582.28132890022, 9603.951980240054, 3604.891853244407, 3654.835532401048, 3665.651763082503, 3708.554973403209, 3718.9628103719156, 977.379364103785, 1018.8522664213648, 1098.4684240167899, 1102.4432661506048, 1106.9557217711201, 33761.662383376344, 33838.83080584631, 33892.0, 33956.490652640234, 34404.82797585996, 1112.1603189591967, 1117.6535274065066, 1134.9602763903224, 1198.688341031338, 1255.5103509631251, 16279.430219942245, 16909.23908424124, 16984.660306793794, 17089.23098460572, 17166.0, 534861.6513834812, 537067.0, 542720.0, 542926.0, 543568.0, 57980.0, 58023.419765802646, 58028.419715803146, 58039.0, 58139.70930145322, 1281.1864466064117, 1294.779887419141, 1368.322680273271, 1393.5470971934162, 1427.0367501936153, 31625.36749265048, 34068.65931340655, 34154.82922585371, 34170.8291458551, 34313.48529772006, 51984.0, 52538.474615253355, 52719.0, 52720.0, 52753.0, 423436.0, 426766.0, 427017.0, 427557.0, 430604.0, 29915.803367865043, 30275.697243028168, 30297.545536816524, 30299.0, 30458.543121853632, 49226.26160607665, 49857.75071124621, 49933.500664992884, 50051.0, 50737.74631126821, 41807.58192418037, 41969.37045944252, 42162.57837421587, 42651.0, 43599.0, 41893.0, 42095.7895210522, 42214.57785422107, 43454.78272608743, 43865.0, 41796.3730544036, 42504.78747606242, 42916.0, 43536.782316089484, 43663.0, 34851.47722784211, 36650.63349366579, 37157.628423716495, 37311.0, 37942.8102859495, 29095.854520727262, 29197.0, 29329.853350733963, 29370.55944160882, 29398.55902161512], "value": 19753.410496633518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5308723357503, 430.5500751714458, 438.4059599243026, 440.24625964591473, 449.2699363534257, 16661.333546658134, 20216.494587635316, 20925.37223883282, 20944.16223351066, 20969.895150524266, 20022.69965950512, 20083.698744518806, 20093.397198084043, 20127.798722012776, 20345.694814577793, 5545.029619816536, 5598.076317407633, 5698.059820129673, 5719.77120915165, 5728.62763920346, 5670.461306175906, 5749.856253593652, 5753.798617048405, 5758.769649214027, 5764.16419619157, 5515.09001014832, 5670.432956704317, 5704.286964129484, 5707.65754054756, 5709.600327977043, 5486.588505862076, 5670.064439367499, 5699.601027928046, 5700.458456446651, 5710.486056254937, 5141.640085194038, 5162.741862906877, 5165.948340516585, 5166.43169251382, 5173.146430838907, 23437.179698710635, 23736.881315593484, 23806.285811425685, 24036.879815600983, 24096.27711168668, 2122.161746110278, 2428.3322086426197, 2810.297425643589, 2961.141269031978, 3003.1140813460083, 13796.862031379758, 14360.712785744332, 14479.78280325796, 14511.1293322401, 14801.555953321418, 1825.8448031917171, 1849.9815001849943, 1961.3132705872938, 1991.8804871707744, 1992.9302474413325, 85771.57114214389, 87342.12657873466, 87535.0, 87970.56014719949, 90222.54888725515, 11784.882151178379, 11795.587154449724, 11804.822927656092, 11908.642740717793, 12229.93885030569, 17021.744673829904, 17046.48860534186, 17050.74423883643, 17061.0, 17077.82922170787, 8758.86861697075, 8858.424202426822, 8887.200151986352, 8976.640934362684, 9023.774405639911, 8246.257836794717, 8423.620937057847, 8437.367197460215, 8472.237498625153, 8625.78435539104, 5116.232565115188, 5171.4311425743135, 5174.818881339135, 5210.166373380241, 5263.578833714952, 2058.2316783925594, 2110.2825039486343, 2168.5554461335387, 2194.7805219478246, 2196.2313190383557, 921.9907800922039, 967.3083745122271, 985.556499575194, 1032.442481060234, 1035.5857656937285, 19951.301704440564, 20616.58766824685, 20741.792582073987, 20764.480887977923, 20926.16295348169, 1018.4093225928943, 1031.9071283584362, 1040.5005597313332, 1060.2843080920347, 1087.782443511301, 10584.417857017937, 11557.537698492135, 11647.88352116485, 11756.823647645293, 11790.587329443428, 488696.0, 500922.0, 507047.0, 507613.0, 509054.0, 91205.54397228104, 96544.0, 97155.0, 98140.50929745306, 99220.0, 1038.2420832792104, 1051.4637534857277, 1073.2487258918632, 1085.4409978860892, 1088.2273585754044, 18325.717199796418, 18741.90629046846, 18791.90604046971, 18839.492840572995, 18973.43079707611, 45083.54916450925, 45113.548864510936, 45142.548574513836, 45552.0, 46118.7694061541, 62890.37109628845, 63015.6849215751, 63322.05016924842, 63657.68171159115, 64493.67753161204, 9186.173244408035, 9218.764811239265, 9334.579943902405, 9382.10869967352, 9386.0, 10414.531346089292, 14062.296885155905, 14093.295335233403, 14312.499062532761, 14832.7775083376, 12512.124151309321, 12558.497660093493, 12585.559505417266, 12622.179558328678, 12942.870571294166, 11288.604898828502, 11485.655430337103, 12249.755004900031, 12896.677583060498, 12898.80651790205, 12398.442070106687, 12591.559295424617, 12598.748025039631, 12706.174098683925, 12737.55418560346, 8943.284537237136, 9084.22784063362, 9249.30630202751, 9400.15398614128, 9404.059594040815, 12218.572349967708, 12237.571684990982, 12463.252204867737, 12696.74606507883, 12769.10616256853], "value": 9790.679994677872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8908087353013, 1518.5216656753123, 1527.6005105296747, 1705.1303835044123, 1823.115788842412, 7668.578228197447, 8484.745457636272, 8830.24942879856, 8838.072002439747, 8948.686795962143, 8690.08754080822, 8761.956190219056, 8762.474251544912, 8768.912310876889, 8779.824403511942, 2511.121107612335, 2539.2889990802514, 2543.224316583441, 2545.6563363945816, 2546.936326591841, 2477.913273035444, 2532.025170309435, 2542.1102614085016, 2546.0961358717573, 2549.528337257613, 2327.56939966106, 2331.708536432946, 2394.0, 2394.293683363412, 2401.2076014915037, 2339.5554844579474, 2339.8479098858606, 2367.3134790910617, 2415.1546958564536, 2419.2984034629935, 2254.977450225493, 2272.3864556569633, 2288.3249441414655, 2299.1608063057033, 2300.735415427214, 8686.522241276727, 8710.782230444227, 8870.334724895594, 8873.201411872898, 8892.421992570462, 5435.809746658848, 5535.0, 5550.056490396642, 5552.7223638817895, 5568.3596386415675, 3434.587849458056, 3437.724982001434, 3515.8417871195857, 3521.2429327694413, 3611.494390785292, 1115.252780636975, 1115.6931843743037, 1133.1105082510273, 1133.7392399748105, 1163.9825402618967, 12288.262704237684, 12291.631251062483, 12333.753324933541, 12359.876401235962, 12394.31831249272, 4429.379886815848, 4688.203005489075, 4766.142094423037, 4789.353437285991, 4791.808327666924, 9625.278104142217, 9637.855432168522, 9662.71011869645, 9694.22446204302, 9728.805423891483, 5401.297831281908, 5411.56707463402, 5420.810271640474, 5438.374586922476, 5442.12925931849, 4299.398084268205, 4478.507364189936, 4514.616257618073, 5107.668001579886, 5109.846704598868, 3987.1228329767987, 4004.819783109767, 4036.475258216472, 4085.7344272622186, 4091.8158682859344, 1149.8792626774068, 1170.3329102411544, 1184.4492311075392, 1192.5945178639304, 1235.3452670084869, 751.1031827997363, 1035.5805898611075, 1037.9792404151874, 1049.9475026248656, 1051.6634676903318, 6062.090686397076, 6132.141500189977, 6227.159333489921, 6277.2153480814895, 6309.842253943596, 994.1947022911465, 1010.7523656704008, 1016.7508960304773, 1023.3961962442195, 1036.9118624916816, 3890.2219556088894, 4166.604172603658, 4207.6423504002505, 4290.764007979528, 4302.698811083257, 10266.281360304856, 10457.84313235302, 10609.628662996758, 10635.46822658864, 10648.733781655366, 10521.52653130611, 10530.36817790935, 10531.684049478528, 10534.104601108991, 10584.947075264728, 8027.07688615805, 8153.470024448392, 8161.143079976636, 8165.836683266421, 8170.509769413736, 5957.0, 6125.540584456095, 6134.294556126102, 6220.253569571681, 6277.058441233851, 9720.222382209548, 9909.900900991186, 9942.602295908082, 9989.200863931013, 10103.7474063149, 9110.498922559324, 9419.387739796892, 9865.112139907444, 10014.949925250326, 10283.33158344735, 7255.709771609288, 7396.852062958818, 7409.333160015624, 7772.494787838772, 7873.173316801883, 8498.70254541088, 8549.957250213709, 8621.267192288475, 8654.350923680875, 8663.306935445024, 7775.105862825621, 7839.0, 7862.567558784322, 7904.407169462198, 8064.758057258292, 7363.852722945619, 7589.0, 7633.0, 7740.806479837824, 7875.330596899099, 7249.420046396381, 7362.116546014512, 7362.77911662651, 7373.741919033023, 7376.336129748348, 5201.92197117036, 5238.947610523846, 5271.077561426811, 5311.070562651597, 5463.644863083887, 5118.334616499831, 5266.34170728659, 5292.153255479105, 5399.4060653327315, 5590.133529302964], "value": 4691.089944340724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3076581454184, 358.3442300589921, 361.0666427285467, 362.8403502458918, 363.4058314655539, 5420.24116623673, 5435.1847222916585, 5465.529388838092, 5478.45215478452, 5520.392756796754, 5087.923681144785, 5236.633435659505, 5238.8690282742955, 5314.990151871142, 5378.838634840961, 4234.322508398657, 4237.322028475444, 4240.469941257343, 4268.167707297078, 4271.209826182167, 4257.638100761439, 4264.936025959613, 4288.228118938589, 4294.291441912081, 4295.763732994684, 4124.381342798574, 4211.599898009684, 4216.0, 4222.788860556975, 4223.1975924574235, 4190.53904070552, 4191.365367506675, 4198.8110535026, 4207.305794543881, 4212.936805947913, 3738.55137383513, 3764.7929363884973, 3765.491658626105, 3767.566729826078, 3771.6605505504363, 5159.896802063975, 5177.948220517785, 5179.482051794828, 5226.294450249244, 5302.125149350352, 4800.567948884583, 4806.903861922777, 4821.445533763627, 4824.324594556765, 4836.492168322346, 5532.834014979557, 5545.944540554583, 5560.36055853578, 5560.944390556124, 5573.442655734394, 3981.163955569334, 4068.877933661995, 4078.3474644057105, 4125.195586860564, 4166.354215096634, 5727.742251598688, 5751.712414379264, 5758.107493338539, 5787.479126878559, 5803.303603567599, 4211.810468528924, 4212.789360531961, 4216.325387937915, 4261.850835220753, 4273.615374616299, 4150.91698166041, 4324.913501729948, 4328.156009578102, 4337.652987760972, 4382.583654552876, 4838.483988326121, 4847.442544107403, 4858.708477491362, 4867.61059115277, 4869.659123861366, 5645.503941455518, 5647.435256474402, 5649.6327738696855, 5665.405132461115, 5675.971620141955, 1438.719449707297, 1450.8476609956015, 1460.7443697352921, 1465.8094447721728, 1468.8531146885225, 1002.2032484175098, 1012.9240306977006, 1033.3902997231519, 1035.316690983962, 1036.76154484469, 5290.0, 5306.310179676618, 5311.7344132793205, 5324.201369794562, 5338.306020217425, 5490.313710786152, 5550.222968784374, 5553.278073850454, 5553.555715542828, 5561.499465048165, 5150.630709873501, 5219.947800521946, 5247.501487358695, 5294.97352513235, 5306.97346513265, 2911.7670586353042, 2915.8833646653898, 2930.750886174699, 2933.3839893622153, 2950.451013218035, 5785.971070144707, 5792.884142317214, 5794.696193356461, 5852.912206316909, 5855.970720146372, 5409.83770486886, 5580.720963951786, 5611.77323039254, 5625.409332020161, 5647.322321321386, 5772.6536407815665, 5774.393688662714, 5786.267857232062, 5786.768529258867, 5834.045594725814, 5302.522772950453, 5447.210154527492, 5616.550675945996, 5649.68926709035, 5653.943460565341, 5456.618036737549, 5479.753411096431, 5499.670019798825, 5511.090670039399, 5512.972435137799, 5859.20900678403, 5868.882622347443, 5886.411358864079, 5901.852453688693, 5960.731767070579, 4046.5346485153405, 4068.389741538793, 4177.707560470738, 4208.873733787868, 4209.705320627527, 5524.696141712245, 5556.38879723222, 5576.5817563683695, 5587.525060369751, 5590.707809797963, 5495.450454954473, 5621.747021383966, 5629.324481062299, 5653.943460565341, 5664.886702266014, 5417.349918009706, 5590.496855283044, 5621.409751975983, 5624.915626265692, 5628.268325117709, 5573.27547418833, 5589.720513974366, 5601.327840659147, 5602.411746766694, 5602.691851948182, 5636.0, 5659.943400566106, 5683.573731970201, 5695.401982791747, 5700.486956173964, 5297.007190937262, 5563.7774489019985, 5585.218069470358, 5594.188842617717, 5594.636348637326], "value": 4290.286355532891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5474742528197, 769.4459988808056, 833.1210572845647, 868.7610907000578, 872.4634349874827, 14896.627584310398, 14958.326875290611, 15057.247137643102, 15106.848931510694, 15262.313195906183, 14723.926380368082, 14774.926125369386, 14824.851751482482, 14897.627559311022, 15061.397544098223, 723.3381455967783, 856.575994882534, 870.8606622940331, 872.5419154943642, 872.9694460693877, 744.9366803821682, 848.2874385516166, 875.5140896802272, 881.7663319220412, 883.9292856571491, 923.2429407885537, 926.420986883198, 926.4904302633558, 927.0, 927.23966347595, 759.8670232709254, 912.1243606138115, 917.6467060181844, 918.2791508665699, 919.0992827029515, 577.4600748300353, 654.5189285874878, 671.0169601533777, 671.778313156662, 675.061664286642, 14853.0, 14883.553493395215, 14888.404463821435, 14913.552593422215, 14915.328810203458, 13095.672608184776, 13387.866121338759, 13753.862461375358, 13914.0, 13918.721625567534, 11499.950134636432, 11613.129015323884, 11772.23480473775, 11865.762684746256, 11892.702682432922, 4309.741415515079, 4328.0, 4332.415123958257, 4333.71830830995, 4413.7793110344355, 63978.36021639724, 65055.3494465054, 65149.674251628916, 65301.67349163271, 66140.6692966537, 10810.0, 10855.402952837512, 10997.0, 11050.281731687415, 11054.502547385388, 19430.833019223533, 19556.608867822848, 19621.50946226356, 20358.18567257293, 20431.38705838827, 7969.362451003905, 8133.146019667968, 8176.836463270702, 8200.630971606173, 8207.835843283101, 4215.515215750167, 4312.978435107867, 4318.0, 4335.631471324909, 4579.656525760582, 3428.211511352403, 3464.6015708193377, 3535.045537704805, 3542.5926018507685, 3542.964570354315, 634.7207228819304, 640.3244576971247, 642.5823214910346, 643.0771842406162, 662.8044726805507, 613.5858295650418, 665.3147258323837, 671.8602689425834, 684.852756657321, 692.2592825676578, 9140.6800761973, 9394.61469815494, 9407.576659050359, 9609.663661771805, 9726.367786094022, 679.5288201044782, 686.1713533433444, 688.652230623542, 711.0827033127312, 711.2720294005592, 4326.718763280377, 4389.385486031958, 4483.529229430928, 4506.1663592235545, 4543.886402839889, 56639.43360566424, 77111.8433223502, 92726.0, 96061.5196924011, 96269.51865240629, 82771.5861420689, 83630.0, 83727.90680233043, 85068.4705494141, 89195.0, 71762.64118679373, 73718.0, 73879.63060184772, 75509.6224518874, 77738.61130694424, 8555.57222138903, 8804.691835785718, 9067.36528443029, 9162.58768355439, 9180.0, 34572.0, 37830.62169378271, 41951.58048419477, 45276.320855187856, 50257.49742502528, 64138.0, 64554.354456454836, 65071.67464162649, 65796.67101664461, 67144.66427668025, 11020.118390528898, 11258.493367798304, 11270.492827822603, 11351.37567433799, 11880.940595296968, 12702.936485317514, 12714.872851271739, 12859.16415432994, 13135.277559734306, 13262.403191856196, 11477.36874471912, 11907.642770716893, 11959.581414650445, 11993.880061199625, 12633.620991370273, 11516.94241528787, 12822.871771282167, 12979.545715900276, 13407.597772066854, 13626.046176767532, 13900.235487048309, 14342.282885855875, 14350.928245358706, 14679.41282348694, 14712.04371715835, 10342.586296548054, 10943.28868623537, 11074.501647425725, 11124.888751112385, 11811.114166437723, 10585.0, 10723.517441714985, 10944.56221751153, 10969.670909872717, 11031.22781405294], "value": 7222.095637481386, "unit": "score"}], "name": "dromaeo_css", "value": 7340.231985613687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 110.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 120.0, 152.0, 120.0, 118.0, 117.0, 117.0, 148.0, 120.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 108.0, 76.0, 76.0, 76.0, 76.0, 97.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 114.0, 82.0, 82.0, 82.0, 98.0, 82.0, 81.0, 107.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 86.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 50.0, 49.0, 50.0, 49.0, 49.0, 50.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 62.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 74.0, 75.0, 74.0, 74.0, 73.0, 73.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 121.0, 135.0, 120.0, 119.0, 128.0, 127.0, 157.0, 128.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 158.0, 162.0, 159.0, 162.0, 155.0, 157.0, 159.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 67.0, 63.0, 63.0, 64.0, 62.0, 63.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1448.9, "alertThreshold": 2.0}]} 02:48:24 INFO - Return code: 0 02:48:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:24 INFO - # TBPL SUCCESS # 02:48:24 INFO - Running post-action listener: _resource_record_post_action 02:48:24 INFO - [mozharness: 2016-12-27 10:48:24.195331Z] Finished run-tests step (success) 02:48:24 INFO - Running post-run listener: _resource_record_post_run 02:48:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365879296; Read time: 8; Write time: 231948 02:48:24 INFO - TinderboxPrint: CPU usage
13.0% 02:48:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:48:24 INFO - TinderboxPrint: I/O write bytes / time
365,879,296 / 231,948 02:48:24 INFO - TinderboxPrint: CPU idle
8,276.0 (87.0%) 02:48:24 INFO - TinderboxPrint: CPU user
1,193.8 (12.5%) 02:48:24 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118706176; Read time: 0; Write time: 82540 02:48:24 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 246632448; Read time: 0; Write time: 149408 02:48:24 INFO - Running post-run listener: _upload_blobber_files 02:48:24 INFO - Blob upload gear active. 02:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:24 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 02:48:24 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'] 02:48:24 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 02:48:25 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:28 INFO - (blobuploader) - INFO - Done attempting. 02:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:29 INFO - (blobuploader) - INFO - Done attempting. 02:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:29 INFO - (blobuploader) - INFO - Done attempting. 02:48:29 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:29 INFO - Return code: 0 02:48:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edadbed27ce030181e0e808326b43ebb48cc2dd492e1723d7eb93cd4cb4294208bb4e9598e9aa11a0d149764c3cac6c0a5586e5d6b6afb2f0906d0fde918880a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771fd27a2d0f300c818e0db673176b27340bfcc19d96ff40657acd1c2f27ec1d009bfe9ea381a16c00e43fa3b4d0a61c519fff958b4fbfa33cd97d506fdd0e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7969cc036fd259861d6752ce987d7ba083168e24ff8c41996ad8f4bb48ab2dbec9e88e3fea6ed6965033de528ef9dec3dfc543ed5906b409be8945c9fe569c2f"} 02:48:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:29 INFO - Contents: 02:48:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edadbed27ce030181e0e808326b43ebb48cc2dd492e1723d7eb93cd4cb4294208bb4e9598e9aa11a0d149764c3cac6c0a5586e5d6b6afb2f0906d0fde918880a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771fd27a2d0f300c818e0db673176b27340bfcc19d96ff40657acd1c2f27ec1d009bfe9ea381a16c00e43fa3b4d0a61c519fff958b4fbfa33cd97d506fdd0e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7969cc036fd259861d6752ce987d7ba083168e24ff8c41996ad8f4bb48ab2dbec9e88e3fea6ed6965033de528ef9dec3dfc543ed5906b409be8945c9fe569c2f"} 02:48:29 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:29 INFO - Copying logs to upload dir... 02:48:29 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.163478 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-27 02:48:26.207644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:26.211525) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 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/edadbed27ce030181e0e808326b43ebb48cc2dd492e1723d7eb93cd4cb4294208bb4e9598e9aa11a0d149764c3cac6c0a5586e5d6b6afb2f0906d0fde918880a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771fd27a2d0f300c818e0db673176b27340bfcc19d96ff40657acd1c2f27ec1d009bfe9ea381a16c00e43fa3b4d0a61c519fff958b4fbfa33cd97d506fdd0e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7969cc036fd259861d6752ce987d7ba083168e24ff8c41996ad8f4bb48ab2dbec9e88e3fea6ed6965033de528ef9dec3dfc543ed5906b409be8945c9fe569c2f"} build_url:https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011572 build_url: 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/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/edadbed27ce030181e0e808326b43ebb48cc2dd492e1723d7eb93cd4cb4294208bb4e9598e9aa11a0d149764c3cac6c0a5586e5d6b6afb2f0906d0fde918880a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/771fd27a2d0f300c818e0db673176b27340bfcc19d96ff40657acd1c2f27ec1d009bfe9ea381a16c00e43fa3b4d0a61c519fff958b4fbfa33cd97d506fdd0e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7969cc036fd259861d6752ce987d7ba083168e24ff8c41996ad8f4bb48ab2dbec9e88e3fea6ed6965033de528ef9dec3dfc543ed5906b409be8945c9fe569c2f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:26.240599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:26.240927) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482834313.780790-500286718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:26.327850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 02:48:26.328595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 02:48:26.329275) ========= ========= Total master_lag: 0.18 =========