builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1477470764.8 results: success (0) buildid: 20161025223006 builduid: 1b4a56f6391743afadf1e71e5c19499c revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:44.799696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:44.800266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:44.800610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:44.815796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:44.816225) ========= 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=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 01:32:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2016-10-26 01:32:45 (40.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.423338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:45.253804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:45.254166) ========= 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=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:45.304578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:45.304979) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 01:32:45,334 truncating revision to first 12 chars 2016-10-26 01:32:45,334 Setting DEBUG logging. 2016-10-26 01:32:45,334 attempt 1/10 2016-10-26 01:32:45,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 01:32:45,757 unpacking tar archive at: mozilla-central-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=0.726719 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:46.056745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:46.057370) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:46.058114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:46.058724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 01:32:46.071198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 01:32:46.071519) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:46 INFO - MultiFileLogger online at 20161026 01:32:46 in /builds/slave/test 01:32:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:32:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:46 INFO - {'append_to_log': False, 01:32:46 INFO - 'base_work_dir': '/builds/slave/test', 01:32:46 INFO - 'blob_upload_branch': 'Firefox', 01:32:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:46 INFO - 'branch': 'Firefox', 01:32:46 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:46 INFO - 'config_files': ('talos/linux_config.py',), 01:32:46 INFO - 'default_actions': ('clobber', 01:32:46 INFO - 'read-buildbot-config', 01:32:46 INFO - 'download-and-extract', 01:32:46 INFO - 'populate-webroot', 01:32:46 INFO - 'create-virtualenv', 01:32:46 INFO - 'install', 01:32:46 INFO - 'run-tests'), 01:32:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:46 INFO - 'download_minidump_stackwalk': True, 01:32:46 INFO - 'download_symbols': 'ondemand', 01:32:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:46 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:46 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:46 INFO - 'installer_path': 'installer.exe', 01:32:46 INFO - 'log_level': 'info', 01:32:46 INFO - 'log_name': 'talos', 01:32:46 INFO - 'log_to_console': True, 01:32:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:46 INFO - 'opt_config_files': (), 01:32:46 INFO - 'pip_index': False, 01:32:46 INFO - 'sps_profile': False, 01:32:46 INFO - 'sps_profile_interval': 0, 01:32:46 INFO - 'suite': 'dromaeojs', 01:32:46 INFO - 'system_bits': '32', 01:32:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:46 INFO - 'title': 'talos-linux64-ix-024', 01:32:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:46 INFO - 'use_talos_json': True, 01:32:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:46 INFO - 'work_dir': 'build'} 01:32:46 INFO - [mozharness: 2016-10-26 08:32:46.202143Z] Running clobber step. 01:32:46 INFO - Running pre-action listener: _resource_record_pre_action 01:32:46 INFO - Running main action method: clobber 01:32:46 INFO - rmtree: /builds/slave/test/build 01:32:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:47 INFO - Running post-action listener: _resource_record_post_action 01:32:47 INFO - [mozharness: 2016-10-26 08:32:47.178796Z] Finished clobber step (success) 01:32:47 INFO - [mozharness: 2016-10-26 08:32:47.178897Z] Running read-buildbot-config step. 01:32:47 INFO - Running pre-action listener: _resource_record_pre_action 01:32:47 INFO - Running main action method: read_buildbot_config 01:32:47 INFO - Using buildbot properties: 01:32:47 INFO - { 01:32:47 INFO - "project": "", 01:32:47 INFO - "product": "firefox", 01:32:47 INFO - "script_repo_revision": "production", 01:32:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:32:47 INFO - "repository": "", 01:32:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:32:47 INFO - "buildid": "20161025223006", 01:32:47 INFO - "pgo_build": "True", 01:32:47 INFO - "basedir": "/builds/slave/test", 01:32:47 INFO - "buildnumber": 35, 01:32:47 INFO - "slavename": "talos-linux64-ix-024", 01:32:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:32:47 INFO - "platform": "ubuntu64_hw", 01:32:47 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:32:47 INFO - "branch": "mozilla-central", 01:32:47 INFO - "repo_path": "mozilla-central", 01:32:47 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 01:32:47 INFO - "stage_platform": "linux64-pgo", 01:32:47 INFO - "builduid": "1b4a56f6391743afadf1e71e5c19499c", 01:32:47 INFO - "slavebuilddir": "test" 01:32:47 INFO - } 01:32:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:32:47 INFO - Running post-action listener: _resource_record_post_action 01:32:47 INFO - [mozharness: 2016-10-26 08:32:47.181289Z] Finished read-buildbot-config step (success) 01:32:47 INFO - [mozharness: 2016-10-26 08:32:47.181376Z] Running download-and-extract step. 01:32:47 INFO - Running pre-action listener: _resource_record_pre_action 01:32:47 INFO - Running main action method: download_and_extract 01:32:47 INFO - mkdir: /builds/slave/test/build/tests 01:32: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')]} 01:32:47 INFO - trying https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:32:47 INFO - Downloading https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:32:47 INFO - Downloaded 1361 bytes. 01:32:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:32:47 INFO - Using the following test package requirements: 01:32:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:32:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'jsshell-linux-x86_64.zip'], 01:32:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:32:48 INFO - Http code: 200 01:32:48 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 01:32:48 INFO - x-amz-cf-id: paoZmGkhLVuG_ZWrPTl7oPYikeVRYxWldzfLWW3hKyRO2Sz-OjUNbA== 01:32:48 INFO - x-amz-version-id: .X5XfFy6PUp.AsmRCui8aS7P55KCG5zQ 01:32:48 INFO - Expected file size: 22051151 01:32:48 INFO - Obtained file size: 22051151 01:32:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:32:53 INFO - Http code: 200 01:32:53 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 01:32:53 INFO - x-amz-cf-id: zht54-4NkKX8psTbogqxQmLrx6TC-GBnsQ5KWhTWW1fbmZaMAcCKCQ== 01:32:53 INFO - x-amz-version-id: .X5XfFy6PUp.AsmRCui8aS7P55KCG5zQ 01:32:53 INFO - Expected file size: 22051151 01:32:53 INFO - Obtained file size: 22051151 01:32:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:32:57 INFO - Fetch https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:32:58 INFO - Http code: 200 01:32:58 INFO - via: 1.1 3d3d633d266d05d90a4eea7a6a59b514.cloudfront.net (CloudFront) 01:32:58 INFO - x-amz-cf-id: 3-ag6a3UK09t7F5JBi1GLhWWxFWbR7ONuGvPi2JWZiNlUnDLVnK4kA== 01:32:58 INFO - x-amz-version-id: EUxD_lQ0TQi8oj0PiEYdvVXKNFnUTIHh 01:32:59 INFO - Expected file size: 14409028 01:32:59 INFO - Obtained file size: 14409028 01:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:59 INFO - trying https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:32:59 INFO - Downloading https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:33:02 INFO - Downloaded 59454728 bytes. 01:33:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:33:02 INFO - mkdir: /builds/slave/test/properties 01:33:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:33:02 INFO - Writing to file /builds/slave/test/properties/build_url 01:33:02 INFO - Contents: 01:33:02 INFO - build_url:https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:33:03 INFO - Running post-action listener: _resource_record_post_action 01:33:03 INFO - Running post-action listener: set_extra_try_arguments 01:33:03 INFO - [mozharness: 2016-10-26 08:33:03.022841Z] Finished download-and-extract step (success) 01:33:03 INFO - [mozharness: 2016-10-26 08:33:03.023067Z] Running populate-webroot step. 01:33:03 INFO - Running pre-action listener: _resource_record_pre_action 01:33:03 INFO - Running main action method: populate_webroot 01:33:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:03 INFO - '--tppagecycles', 01:33:03 INFO - '7'], 01:33:03 INFO - 'tests': ['tsvgm']}}, 01:33:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:33:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:33:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:33:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['damp', 'tps']}, 01:33:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'tests': ['damp', 'tps']}, 01:33:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['dromaeo_dom']}, 01:33:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['basic_compositor_video']}, 01:33:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:33:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'other-e10s': {'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['a11yr', 01:33:03 INFO - 'ts_paint', 01:33:03 INFO - 'tpaint', 01:33:03 INFO - 'sessionrestore', 01:33:03 INFO - 'sessionrestore_no_auto_restore', 01:33:03 INFO - 'tabpaint']}, 01:33:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['tsvgx', 01:33:03 INFO - 'tsvgr_opacity', 01:33:03 INFO - 'tart', 01:33:03 INFO - 'tscrollx', 01:33:03 INFO - 'cart']}, 01:33:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:33:03 INFO - 'tsvgr_opacity', 01:33:03 INFO - 'tart', 01:33:03 INFO - 'tscrollx', 01:33:03 INFO - 'cart']}, 01:33:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'talos_options': ['--disable-e10s'], 01:33:03 INFO - 'tests': ['tp5o']}, 01:33:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'tests': ['tp5o']}, 01:33:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'talos_options': ['--disable-e10s', 01:33:03 INFO - '--xperf_path', 01:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:03 INFO - 'tests': ['tp5n']}, 01:33:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:03 INFO - 'talos_options': ['--xperf_path', 01:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:03 INFO - 'tests': ['tp5n']}}, 01:33:03 INFO - 'talos.zip': {'path': '', 01:33:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:03 INFO - Running post-action listener: _resource_record_post_action 01:33:03 INFO - [mozharness: 2016-10-26 08:33:03.042980Z] Finished populate-webroot step (success) 01:33:03 INFO - [mozharness: 2016-10-26 08:33:03.043068Z] Running create-virtualenv step. 01:33:03 INFO - Running pre-action listener: _resource_record_pre_action 01:33:03 INFO - Running main action method: create_virtualenv 01:33:03 INFO - Creating virtualenv /builds/slave/test/build/venv 01:33:03 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 01:33:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:33:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:03 INFO - Using real prefix '/usr' 01:33:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:33:03 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:05 INFO - Installing pip.................done. 01:33:05 INFO - Return code: 0 01:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:33:05 INFO - Reading from file tmpfile_stdout 01:33:05 INFO - Output received: 01:33:05 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) 01:33:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:05 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:05 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 01:33:05 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 01:33:05 INFO - Using env: {'DISPLAY': ':0', 01:33:05 INFO - 'HOME': '/home/cltbld', 01:33:05 INFO - 'LANG': 'en_US.UTF-8', 01:33:05 INFO - 'LANGUAGE': 'en_US:en', 01:33:05 INFO - 'LOGNAME': 'cltbld', 01:33:05 INFO - 'MAIL': '/var/mail/cltbld', 01:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:05 INFO - 'MOZ_NO_REMOTE': '1', 01:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:05 INFO - 'NO_EM_RESTART': '1', 01:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:05 INFO - 'PWD': '/builds/slave/test', 01:33:05 INFO - 'SHELL': '/bin/bash', 01:33:05 INFO - 'SHLVL': '1', 01:33:05 INFO - 'TERM': 'linux', 01:33:05 INFO - 'TMOUT': '86400', 01:33:05 INFO - 'USER': 'cltbld', 01:33:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:05 INFO - '_': '/tools/buildbot/bin/python'} 01:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:06 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 01:33:06 INFO - Cleaning up... 01:33:06 INFO - Return code: 0 01:33:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:06 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:06 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 01:33:06 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 01:33:06 INFO - Using env: {'DISPLAY': ':0', 01:33:06 INFO - 'HOME': '/home/cltbld', 01:33:06 INFO - 'LANG': 'en_US.UTF-8', 01:33:06 INFO - 'LANGUAGE': 'en_US:en', 01:33:06 INFO - 'LOGNAME': 'cltbld', 01:33:06 INFO - 'MAIL': '/var/mail/cltbld', 01:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:06 INFO - 'MOZ_NO_REMOTE': '1', 01:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:06 INFO - 'NO_EM_RESTART': '1', 01:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:06 INFO - 'PWD': '/builds/slave/test', 01:33:06 INFO - 'SHELL': '/bin/bash', 01:33:06 INFO - 'SHLVL': '1', 01:33:06 INFO - 'TERM': 'linux', 01:33:06 INFO - 'TMOUT': '86400', 01:33:06 INFO - 'USER': 'cltbld', 01:33:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:06 INFO - '_': '/tools/buildbot/bin/python'} 01:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:06 INFO - Downloading/unpacking psutil>=3.1.1 01:33:06 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 01:33:06 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 01:33:06 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 01:33:06 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 01:33:06 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 01:33:06 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 01:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:08 INFO - Installing collected packages: psutil 01:33:08 INFO - Running setup.py install for psutil 01:33:08 INFO - building 'psutil._psutil_linux' extension 01:33:08 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 01:33:08 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 01:33:08 INFO - building 'psutil._psutil_posix' extension 01:33:08 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 01:33:08 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 01:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:08 INFO - Successfully installed psutil 01:33:08 INFO - Cleaning up... 01:33:08 INFO - Return code: 0 01:33:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:08 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:08 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 01:33:08 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 01:33:08 INFO - Using env: {'DISPLAY': ':0', 01:33:08 INFO - 'HOME': '/home/cltbld', 01:33:08 INFO - 'LANG': 'en_US.UTF-8', 01:33:08 INFO - 'LANGUAGE': 'en_US:en', 01:33:08 INFO - 'LOGNAME': 'cltbld', 01:33:08 INFO - 'MAIL': '/var/mail/cltbld', 01:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:08 INFO - 'MOZ_NO_REMOTE': '1', 01:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:08 INFO - 'NO_EM_RESTART': '1', 01:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:08 INFO - 'PWD': '/builds/slave/test', 01:33:08 INFO - 'SHELL': '/bin/bash', 01:33:08 INFO - 'SHLVL': '1', 01:33:08 INFO - 'TERM': 'linux', 01:33:08 INFO - 'TMOUT': '86400', 01:33:08 INFO - 'USER': 'cltbld', 01:33:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:08 INFO - '_': '/tools/buildbot/bin/python'} 01:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:33:11 INFO - Installing collected packages: mozsystemmonitor 01:33:11 INFO - Running setup.py install for mozsystemmonitor 01:33:11 INFO - Successfully installed mozsystemmonitor 01:33:11 INFO - Cleaning up... 01:33:11 INFO - Return code: 0 01:33:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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', '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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:33: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 jsonschema==2.5.1 01:33:11 INFO - Using env: {'DISPLAY': ':0', 01:33:11 INFO - 'HOME': '/home/cltbld', 01:33:11 INFO - 'LANG': 'en_US.UTF-8', 01:33:11 INFO - 'LANGUAGE': 'en_US:en', 01:33:11 INFO - 'LOGNAME': 'cltbld', 01:33:11 INFO - 'MAIL': '/var/mail/cltbld', 01:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:11 INFO - 'MOZ_NO_REMOTE': '1', 01:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:11 INFO - 'NO_EM_RESTART': '1', 01:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:11 INFO - 'PWD': '/builds/slave/test', 01:33:11 INFO - 'SHELL': '/bin/bash', 01:33:11 INFO - 'SHLVL': '1', 01:33:11 INFO - 'TERM': 'linux', 01:33:11 INFO - 'TMOUT': '86400', 01:33:11 INFO - 'USER': 'cltbld', 01:33:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:11 INFO - '_': '/tools/buildbot/bin/python'} 01:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:11 INFO - Downloading/unpacking jsonschema==2.5.1 01:33:11 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 01:33:11 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 01:33:11 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 01:33:11 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 01:33:11 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 01:33:11 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 01:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33:13 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 01:33:13 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 01:33:13 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 01:33:13 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 01:33:13 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 01:33:13 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 01:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:13 INFO - warning: no files found matching '*.txt' 01:33:13 INFO - no previously-included directories found matching 'build' 01:33:13 INFO - no previously-included directories found matching 'dist' 01:33:13 INFO - no previously-included directories found matching '.git*' 01:33:13 INFO - Installing collected packages: jsonschema, functools32 01:33:13 INFO - Running setup.py install for functools32 01:33:13 INFO - warning: no files found matching '*.txt' 01:33:13 INFO - no previously-included directories found matching 'build' 01:33:13 INFO - no previously-included directories found matching 'dist' 01:33:13 INFO - no previously-included directories found matching '.git*' 01:33:13 INFO - Successfully installed jsonschema functools32 01:33:13 INFO - Cleaning up... 01:33:13 INFO - Return code: 0 01:33:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:13 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:13 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 01:33:13 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 01:33:13 INFO - Using env: {'DISPLAY': ':0', 01:33:13 INFO - 'HOME': '/home/cltbld', 01:33:13 INFO - 'LANG': 'en_US.UTF-8', 01:33:13 INFO - 'LANGUAGE': 'en_US:en', 01:33:13 INFO - 'LOGNAME': 'cltbld', 01:33:13 INFO - 'MAIL': '/var/mail/cltbld', 01:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:13 INFO - 'MOZ_NO_REMOTE': '1', 01:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:13 INFO - 'NO_EM_RESTART': '1', 01:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:13 INFO - 'PWD': '/builds/slave/test', 01:33:13 INFO - 'SHELL': '/bin/bash', 01:33:13 INFO - 'SHLVL': '1', 01:33:13 INFO - 'TERM': 'linux', 01:33:13 INFO - 'TMOUT': '86400', 01:33:13 INFO - 'USER': 'cltbld', 01:33:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:13 INFO - '_': '/tools/buildbot/bin/python'} 01:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:33:14 INFO - Cleaning up... 01:33:14 INFO - Return code: 0 01:33:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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', '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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:33: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 blobuploader==1.2.4 01:33:14 INFO - Using env: {'DISPLAY': ':0', 01:33:14 INFO - 'HOME': '/home/cltbld', 01:33:14 INFO - 'LANG': 'en_US.UTF-8', 01:33:14 INFO - 'LANGUAGE': 'en_US:en', 01:33:14 INFO - 'LOGNAME': 'cltbld', 01:33:14 INFO - 'MAIL': '/var/mail/cltbld', 01:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:14 INFO - 'MOZ_NO_REMOTE': '1', 01:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:14 INFO - 'NO_EM_RESTART': '1', 01:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:14 INFO - 'PWD': '/builds/slave/test', 01:33:14 INFO - 'SHELL': '/bin/bash', 01:33:14 INFO - 'SHLVL': '1', 01:33:14 INFO - 'TERM': 'linux', 01:33:14 INFO - 'TMOUT': '86400', 01:33:14 INFO - 'USER': 'cltbld', 01:33:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:14 INFO - '_': '/tools/buildbot/bin/python'} 01:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:14 INFO - Downloading/unpacking blobuploader==1.2.4 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33:16 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:33:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:16 INFO - Downloading docopt-0.6.1.tar.gz 01:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:17 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:17 INFO - Running setup.py install for blobuploader 01:33:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:33:17 INFO - Running setup.py install for requests 01:33:17 INFO - Running setup.py install for docopt 01:33:17 INFO - Successfully installed blobuploader requests docopt 01:33:17 INFO - Cleaning up... 01:33:17 INFO - Return code: 0 01:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:17 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:17 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 01:33:17 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 01:33:17 INFO - Using env: {'DISPLAY': ':0', 01:33:17 INFO - 'HOME': '/home/cltbld', 01:33:17 INFO - 'LANG': 'en_US.UTF-8', 01:33:17 INFO - 'LANGUAGE': 'en_US:en', 01:33:17 INFO - 'LOGNAME': 'cltbld', 01:33:17 INFO - 'MAIL': '/var/mail/cltbld', 01:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:17 INFO - 'MOZ_NO_REMOTE': '1', 01:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:17 INFO - 'NO_EM_RESTART': '1', 01:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:17 INFO - 'PWD': '/builds/slave/test', 01:33:17 INFO - 'SHELL': '/bin/bash', 01:33:17 INFO - 'SHLVL': '1', 01:33:17 INFO - 'TERM': 'linux', 01:33:17 INFO - 'TMOUT': '86400', 01:33:17 INFO - 'USER': 'cltbld', 01:33:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:17 INFO - '_': '/tools/buildbot/bin/python'} 01:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:17 INFO - Running setup.py (path:/tmp/pip-6kNtUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:17 INFO - Running setup.py (path:/tmp/pip-Xp4E8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:18 INFO - Running setup.py (path:/tmp/pip-JKKReZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:18 INFO - Running setup.py (path:/tmp/pip-t72B_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:18 INFO - Running setup.py (path:/tmp/pip-sfAfsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:18 INFO - Running setup.py (path:/tmp/pip-IyssS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:18 INFO - Running setup.py (path:/tmp/pip-FtYf36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:18 INFO - Running setup.py (path:/tmp/pip-hBR8Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:18 INFO - Running setup.py (path:/tmp/pip-u9W_CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:18 INFO - Running setup.py (path:/tmp/pip-9nWFAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:18 INFO - Running setup.py (path:/tmp/pip-oPSqWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:18 INFO - Running setup.py (path:/tmp/pip-Hz1irE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:18 INFO - Running setup.py (path:/tmp/pip-f38Jd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:18 INFO - Running setup.py (path:/tmp/pip-ZGHkxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:18 INFO - Running setup.py (path:/tmp/pip-cfTgNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:18 INFO - Running setup.py (path:/tmp/pip-V1Vnuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:19 INFO - Running setup.py (path:/tmp/pip-8FpkBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:19 INFO - Running setup.py install for manifestparser 01:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Running setup.py install for mozcrash 01:33:19 INFO - Running setup.py install for mozdebug 01:33:19 INFO - Running setup.py install for mozdevice 01:33:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Running setup.py install for mozfile 01:33:19 INFO - Running setup.py install for mozhttpd 01:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Running setup.py install for mozinfo 01:33:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Running setup.py install for mozInstall 01:33:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:33:19 INFO - Running setup.py install for mozleak 01:33:20 INFO - Running setup.py install for mozlog 01:33:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Running setup.py install for moznetwork 01:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Running setup.py install for mozprocess 01:33:20 INFO - Running setup.py install for mozprofile 01:33:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Running setup.py install for mozrunner 01:33:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Running setup.py install for mozscreenshot 01:33:20 INFO - Running setup.py install for moztest 01:33:20 INFO - Running setup.py install for mozversion 01:33:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:33:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:20 INFO - Cleaning up... 01:33:20 INFO - Return code: 0 01:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:20 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:20 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 01:33:20 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 01:33:20 INFO - Using env: {'DISPLAY': ':0', 01:33:20 INFO - 'HOME': '/home/cltbld', 01:33:20 INFO - 'LANG': 'en_US.UTF-8', 01:33:20 INFO - 'LANGUAGE': 'en_US:en', 01:33:20 INFO - 'LOGNAME': 'cltbld', 01:33:20 INFO - 'MAIL': '/var/mail/cltbld', 01:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:20 INFO - 'MOZ_NO_REMOTE': '1', 01:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:20 INFO - 'NO_EM_RESTART': '1', 01:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:20 INFO - 'PWD': '/builds/slave/test', 01:33:20 INFO - 'SHELL': '/bin/bash', 01:33:20 INFO - 'SHLVL': '1', 01:33:20 INFO - 'TERM': 'linux', 01:33:20 INFO - 'TMOUT': '86400', 01:33:20 INFO - 'USER': 'cltbld', 01:33:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:20 INFO - '_': '/tools/buildbot/bin/python'} 01:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:21 INFO - Running setup.py (path:/tmp/pip-dLMif2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:21 INFO - Running setup.py (path:/tmp/pip-Ouc8nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:21 INFO - Running setup.py (path:/tmp/pip-g8hyhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:21 INFO - Running setup.py (path:/tmp/pip-In0Xv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:21 INFO - Running setup.py (path:/tmp/pip-fH87hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:21 INFO - Running setup.py (path:/tmp/pip-myBDHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:21 INFO - Running setup.py (path:/tmp/pip-eS9Vm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:21 INFO - Running setup.py (path:/tmp/pip-ll63n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:21 INFO - Running setup.py (path:/tmp/pip-CyXlld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:21 INFO - Running setup.py (path:/tmp/pip-nCqxV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:21 INFO - Running setup.py (path:/tmp/pip-wO4mvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:21 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)) 01:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:21 INFO - Running setup.py (path:/tmp/pip-m_VxOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:22 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)) 01:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:22 INFO - Running setup.py (path:/tmp/pip-_qJFqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:22 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)) 01:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:22 INFO - Running setup.py (path:/tmp/pip-Zh0WNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:22 INFO - Running setup.py (path:/tmp/pip-TwTOfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:22 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)) 01:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:22 INFO - Running setup.py (path:/tmp/pip-8vr3iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:22 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)) 01:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:22 INFO - Running setup.py (path:/tmp/pip-3HQCO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:22 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)) 01:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:22 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)) 01:33:22 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)) 01:33:22 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)) 01:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33:24 INFO - Downloading blessings-1.6.tar.gz 01:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:24 INFO - Installing collected packages: blessings 01:33:24 INFO - Running setup.py install for blessings 01:33:24 INFO - Successfully installed blessings 01:33:24 INFO - Cleaning up... 01:33:24 INFO - Return code: 0 01:33:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:24 INFO - Reading from file tmpfile_stdout 01:33:24 INFO - Current package versions: 01:33:24 INFO - argparse == 1.2.1 01:33:24 INFO - blessings == 1.6 01:33:24 INFO - blobuploader == 1.2.4 01:33:24 INFO - docopt == 0.6.1 01:33:24 INFO - functools32 == 3.2.3-2 01:33:24 INFO - jsonschema == 2.5.1 01:33:24 INFO - manifestparser == 1.1 01:33:24 INFO - mozInstall == 1.12 01:33:24 INFO - mozcrash == 0.17 01:33:24 INFO - mozdebug == 0.1 01:33:24 INFO - mozdevice == 0.48 01:33:24 INFO - mozfile == 1.2 01:33:24 INFO - mozhttpd == 0.7 01:33:24 INFO - mozinfo == 0.9 01:33:24 INFO - mozleak == 0.1 01:33:24 INFO - mozlog == 3.4 01:33:24 INFO - moznetwork == 0.27 01:33:24 INFO - mozprocess == 0.23 01:33:24 INFO - mozprofile == 0.28 01:33:24 INFO - mozrunner == 6.12 01:33:24 INFO - mozscreenshot == 0.1 01:33:24 INFO - mozsystemmonitor == 0.3 01:33:24 INFO - moztest == 0.7 01:33:24 INFO - mozversion == 1.4 01:33:24 INFO - psutil == 3.1.1 01:33:24 INFO - requests == 1.2.3 01:33:24 INFO - wsgiref == 0.1.2 01:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:24 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 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:24 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 01:33:24 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 01:33:24 INFO - Using env: {'DISPLAY': ':0', 01:33:24 INFO - 'HOME': '/home/cltbld', 01:33:24 INFO - 'LANG': 'en_US.UTF-8', 01:33:24 INFO - 'LANGUAGE': 'en_US:en', 01:33:24 INFO - 'LOGNAME': 'cltbld', 01:33:24 INFO - 'MAIL': '/var/mail/cltbld', 01:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:24 INFO - 'MOZ_NO_REMOTE': '1', 01:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:24 INFO - 'NO_EM_RESTART': '1', 01:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:24 INFO - 'PWD': '/builds/slave/test', 01:33:24 INFO - 'SHELL': '/bin/bash', 01:33:24 INFO - 'SHLVL': '1', 01:33:24 INFO - 'TERM': 'linux', 01:33:24 INFO - 'TMOUT': '86400', 01:33:24 INFO - 'USER': 'cltbld', 01:33:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:24 INFO - '_': '/tools/buildbot/bin/python'} 01:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 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)) 01:33:24 INFO - Cleaning up... 01:33:24 INFO - Return code: 0 01:33:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6328f48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c267b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, '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': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', '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 01:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:33:25 INFO - Using env: {'DISPLAY': ':0', 01:33:25 INFO - 'HOME': '/home/cltbld', 01:33:25 INFO - 'LANG': 'en_US.UTF-8', 01:33:25 INFO - 'LANGUAGE': 'en_US:en', 01:33:25 INFO - 'LOGNAME': 'cltbld', 01:33:25 INFO - 'MAIL': '/var/mail/cltbld', 01:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:25 INFO - 'MOZ_NO_REMOTE': '1', 01:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:25 INFO - 'NO_EM_RESTART': '1', 01:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:25 INFO - 'PWD': '/builds/slave/test', 01:33:25 INFO - 'SHELL': '/bin/bash', 01:33:25 INFO - 'SHLVL': '1', 01:33:25 INFO - 'TERM': 'linux', 01:33:25 INFO - 'TMOUT': '86400', 01:33:25 INFO - 'USER': 'cltbld', 01:33:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:25 INFO - '_': '/tools/buildbot/bin/python'} 01:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:25 INFO - Cleaning up... 01:33:25 INFO - Return code: 0 01:33:25 INFO - Running post-action listener: _resource_record_post_action 01:33:25 INFO - Running post-action listener: _start_resource_monitoring 01:33:25 INFO - Starting resource monitoring. 01:33:25 INFO - [mozharness: 2016-10-26 08:33:25.273701Z] Finished create-virtualenv step (success) 01:33:25 INFO - [mozharness: 2016-10-26 08:33:25.274171Z] Running install step. 01:33:25 INFO - Running pre-action listener: _resource_record_pre_action 01:33:25 INFO - Running main action method: install 01:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:25 INFO - Reading from file tmpfile_stdout 01:33:25 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:25 INFO - Reading from file tmpfile_stdout 01:33:25 INFO - Output received: 01:33:25 INFO - Usage: mozinstall [options] installer 01:33:25 INFO - Options: 01:33:25 INFO - -h, --help show this help message and exit 01:33:25 INFO - -d DEST, --destination=DEST 01:33:25 INFO - Directory to install application into. [default: 01:33:25 INFO - "/builds/slave/test"] 01:33:25 INFO - --app=APP Application being installed. [default: firefox] 01:33:25 INFO - mkdir: /builds/slave/test/build/application 01:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:33:43 INFO - Reading from file tmpfile_stdout 01:33:43 INFO - Output received: 01:33:43 INFO - /builds/slave/test/build/application/firefox/firefox 01:33:43 INFO - Running post-action listener: _resource_record_post_action 01:33:43 INFO - [mozharness: 2016-10-26 08:33:43.037049Z] Finished install step (success) 01:33:43 INFO - [mozharness: 2016-10-26 08:33:43.037297Z] Running run-tests step. 01:33:43 INFO - Running pre-action listener: _resource_record_pre_action 01:33:43 INFO - Running main action method: run_tests 01:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:43 INFO - Python 2.7.3 01:33:43 INFO - Return code: 0 01:33:43 INFO - grabbing minidump binary from tooltool 01:33:43 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')]} 01:33:43 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 0x2cb5790>, '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 0x2cb6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:43 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 01:33:43 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 01:33:43 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 01:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:43 INFO - Return code: 0 01:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 01:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 01:33:43 INFO - Using env: {'DISPLAY': ':0', 01:33:43 INFO - 'HOME': '/home/cltbld', 01:33:43 INFO - 'LANG': 'en_US.UTF-8', 01:33:43 INFO - 'LANGUAGE': 'en_US:en', 01:33:43 INFO - 'LOGNAME': 'cltbld', 01:33:43 INFO - 'MAIL': '/var/mail/cltbld', 01:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:43 INFO - 'MOZ_NO_REMOTE': '1', 01:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:43 INFO - 'NO_EM_RESTART': '1', 01:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:43 INFO - 'PWD': '/builds/slave/test', 01:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:43 INFO - 'SHELL': '/bin/bash', 01:33:43 INFO - 'SHLVL': '1', 01:33:43 INFO - 'TERM': 'linux', 01:33:43 INFO - 'TMOUT': '86400', 01:33:43 INFO - 'USER': 'cltbld', 01:33:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636', 01:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:43 INFO - '_': '/tools/buildbot/bin/python'} 01:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 01:33:43 INFO - mozversion application_buildid: 20161025223006 01:33:43 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 01:33:43 INFO - mozversion application_display_name: Nightly 01:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:43 INFO - mozversion application_name: Firefox 01:33:43 INFO - mozversion application_remotingname: firefox 01:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:33:43 INFO - mozversion application_vendor: Mozilla 01:33:43 INFO - mozversion application_version: 52.0a1 01:33:43 INFO - mozversion platform_buildid: 20161025223006 01:33:43 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 01:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:33:43 INFO - mozversion platform_version: 52.0a1 01:33:43 INFO - using testdate: 1477470823 01:33:43 INFO - actual date: 1477470823 01:33:43 INFO - starting webserver on 'localhost:50612' 01:33:43 INFO - SUITE-START | Running 2 tests 01:33:43 INFO - TEST-START | dromaeo_css 01:33:43 INFO - operating with platform_type : linux_ 01:33:43 INFO - Initialising browser for dromaeo_css test... 01:33:43 INFO - TEST-INFO | started process 15727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIlhJXS/profile http://localhost:50612/getInfo.html) 01:33:47 INFO - PROCESS | 15727 | __metrics Screen width/height:1600/1200 01:33:47 INFO - PROCESS | 15727 | colorDepth:24 01:33:47 INFO - PROCESS | 15727 | Browser inner width/height: 1024/697 01:33:47 INFO - PROCESS | 15727 | __metrics 01:33:48 INFO - PROCESS | 15727 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:33:48 INFO - PROCESS | 15727 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:48 INFO - PROCESS | 15727 | console.error: PushService: 01:33:48 INFO - PROCESS | 15727 | stateChangeProcessEnqueue: Error transitioning state 01:33:48 INFO - PROCESS | 15727 | UnknownError 01:33:49 INFO - TEST-INFO | 15727: exit 0 01:33:49 INFO - Browser initialized. 01:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:49 INFO - TEST-INFO | started process 15810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIlhJXS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:01 INFO - PROCESS | 15810 | RSS: Main: 172158976 01:34:01 INFO - PROCESS | 15810 | 01:34:53 INFO - PROCESS | 15810 | 1477470893082 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] 01:37:03 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50612/tests/dromaeo/cssquery-ext.html) 01:37:05 INFO - PROCESS | 15810 | RSS: Main: 274702336 01:37:05 INFO - PROCESS | 15810 | 01:40:08 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-ext.html (next: http://localhost:50612/tests/dromaeo/cssquery-jquery.html) 01:40:08 INFO - PROCESS | 15810 | RSS: Main: 282148864 01:40:08 INFO - PROCESS | 15810 | 01:43:10 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50612/tests/dromaeo/cssquery-mootools.html) 01:43:11 INFO - PROCESS | 15810 | RSS: Main: 279228416 01:43:11 INFO - PROCESS | 15810 | 01:46:13 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50612/tests/dromaeo/cssquery-prototype.html) 01:46:13 INFO - PROCESS | 15810 | RSS: Main: 244588544 01:46:13 INFO - PROCESS | 15810 | 01:49:16 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50612/tests/dromaeo/cssquery-yui.html) 01:49:17 INFO - PROCESS | 15810 | RSS: Main: 214036480 01:49:17 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | Cycle 1(1): loaded http://localhost:50612/tests/dromaeo/cssquery-yui.html (next: http://localhost:50612/tests/dromaeo/cssquery-dojo.html) 01:52:20 INFO - PROCESS | 15810 | RSS: Main: 310046720 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | __start_tp_report 01:52:20 INFO - PROCESS | 15810 | _x_x_mozilla_page_load 01:52:20 INFO - PROCESS | 15810 | _x_x_mozilla_page_load_details 01:52:20 INFO - PROCESS | 15810 | |i|pagename|runs| 01:52:20 INFO - PROCESS | 15810 | |0;dojo.html;3066.3713938642572;3087.675794041624;3117.890873819417;3135.6394014688303;3137.3882092991876;5266.657667251636;5346.732663366835;5349.5452886504645;5408.621396502242;5458.263134476844;5410.08028635132;5452.945470545294;5487.42382049885;5506.862328441791;5540.833774986757;4879.243717223818;4889.486603906592;4931.284963680264;4974.353334066566;4977.55202031817;4995.550400463958;5087.79648814047;5104.8979020419565;5111.1566591512355;5136.306598609177;4848.442429120661;4967.081089998362;4975.477574854624;5016.573591244731;5094.7197904115255;4870.805167793284;4928.1129396708575;4933.383327084114;4936.210206367;4938.037082768861;4867.245576935581;4885.43817460993;4891.1685013547785;4892.437369702494;4894.216925291937;5425.484578964992;5429.945700542983;5446.373667028302;5530.391656917735;5530.723463826833;5773.162891380726;5779.566532510079;5781.595288329819;5782.768689252425;5788.18965344852;5703;5782.421757824226;5791.652500849962;5833.737481813286;5849.824505264849;5390.272313237702;5410.756515956791;5413.593980451482;5417.972910135424;5475.397706252309;5870.941290587125;5916.349201587822;5922.378150294243;5922.585419020714;5930.169776231331;5543.501084902378;5672.290963629546;5676.205331253628;5676.460736230051;5681.176229446707;5652.152177173457;5734.827955161351;5743.483086522149;5744.798932037442;5770.740316685676;5735.082386818089;5840.123981402823;5843.912341314884;5846.269216347957;5850.063989761617;5796.246487956539;5796.797112101141;5797;5798.710064496759;5862.765489380462;4410.051838854662;4439.889002774957;4453;4461.442319710036;4463.04044630406;3905.1213476967455;3933.1543718100747;3949.763014219156;3950.3876899080688;3987.043109653662;5431.158170483582;5472.042392581362;5475.151351540518;5476.151196564539;5547.445255474501;5835.124731290341;5844.532437404998;5848.444397782204;5850.736716847752;5866.823995280149;5337.733113344318;5372.221027950925;5379.515843574097;5404.4891162364265;5481.945180548223;5040.697558146523;5054.317667114892;5076.289319495274;5124.052050370693;5130.846074617767;5995;6001.909971350433;6023.27720673522;6026.035834266497;6035.849103772353;5698.088305871041;5745.971270143623;5858.2677165354335;5866.6186697864505;5869.530437564899;5918.585699001201;5944.286685597756;5961.105834124916;5962.97018514922;6013.128096426081;5680.488756011813;5680.943190568207;5686.4029276926985;5693.060644993695;5693.430656934273;5678.14827775837;5730.169125476866;5768.134779783066;5793.565482588907;5796;5597.468240517144;5691.288588926384;5694.658320500617;5705.971470142623;5808.419158084158;5649.971750141223;5727.570432217683;5735.655860648374;5739.110437882135;5740.368559458373;5528.530074943675;5657.858553536194;5683.5737319700365;5684.062129748545;5685.20407142992;5603.355614104267;5677.489025987681;5683.204351390891;5711.771529138788;5743.0811070228565;5538.47384498472;5591.916121258103;5595.63628364155;5598.86002849932;5666.320041595035 01:52:20 INFO - PROCESS | 15810 | |1;ext.html;545.4026270702453;586.870888404551;605.7365046204901;627.1909237084162;648.4812150279776;31311.217219569495;41711.79144104279;41821;42003;42046;43552;43984.560154398445;44040.119197616106;44044.33933491;44110.55889441105;8146.633401496917;8560.743177704664;8699.782505437352;8704.30365570756;8708.129187081273;8101.311388531982;8271.421000529965;8274.627641756135;10444.895551044468;10715.678529644123;10761.300515466508;10828.945855270713;10857.565697372096;10937.671869843918;10952.616658416957;10398.740031499236;10448.32085914413;10449.895501045045;10453.581856725721;10458.79082418355;10884.673459796219;10940.945295273552;10947.288426252268;10964.342139471657;10969.067629251524;42055.57944420578;42270.36594451086;42362;42377.57622423798;42392.57607423948;3491.9301613967577;3497.842597083137;3531.3996620574308;3623.4202527595457;3918.216356728637;31647.367052659047;31791.523127153112;31851.362972740415;32078.51882221745;32299;4176.91646167078;4263.680223983214;4304.096139810612;4317.201317756194;4453.109378124355;322300;324927;325175;326310;327203;56706;57167.71416142976;57490.425095748506;57534.13698794522;57549.4245057544;59308.40691593029;60270;60391;60514.78970420655;60708;11425.542978280942;11442.37066961325;11458.08335333188;11459.828102578467;11462.656120316404;9136.725898223063;9749.756256093513;9783.0706082922;9789.853152202722;9792.755181120529;14797.408103675732;16316.428924987806;16760.413385531447;16846.91576542134;17349.56626084358;5624.3250809903075;6281.246250449975;6328.46208072319;6369.8726025480155;6403.64779937108;836.2766207230702;887.8135591525722;890.4034297021011;897.4301318662697;950.5009869818263;30792;31450.842745786125;31827.20431989219;32178.19554511156;32555;1049.538203190609;1072.6889202131451;1073.9892601074046;1139.6922830835795;1167.1479819731644;16243;16790.328386864632;16844.915775421043;16938.49184524466;17052.57368565771;473960;476153.1000969852;476552;477415;479097;49499.752501237264;50327.496725033016;52755;54086;56655.71672141613;1115.4980258883536;1125.8930401611833;1129.3336931210624;1144.1761931409371;1264.4942023190613;29962.981133759185;32225.51661725123;32364;32505.02484925456;32916.83541582277;50523;50884;51016.48983510266;51046;51078.23382649189;413831;415756;416977;568811;569378;27370;27417.86291068532;27760.86119569389;28058;28118.859405702842;46280.53719462762;46565.3015204779;46776;46777.76611116923;48145;39201.6079839198;39324.803375982934;40305.79847100746;40578.39132413075;42003.57996419997;36333.45499817558;38574.42138367983;38696.22607547777;41294.1741165181;42719.5728042728;40166.397504036875;41104.38343424791;41215;41539.7923010383;41589.37615935703;34259.31481370309;34351.48472772961;35598;36220.81889590535;38076;25606.615900761877;25632.87183564145;25678.229653110437;25706.35734106662;26045.348866277738 01:52:20 INFO - PROCESS | 15810 | |2;jquery.html;350.17184358990994;370.9591944886064;389.45281878960054;394.5364197068444;406.721395843847;13873.445062197512;18565.907170464146;19684.70472942907;20175.596488070267;20362.287319943767;15621.453249136282;16497.17514124295;16738.66522669546;17283.481495555152;17387.217575209113;5542.473465020827;5761.68310742911;5790.10253410722;5794.362620111784;5796.159556864252;5478.233047373351;5635.5773317001185;5651.943480565204;5732.283464566929;5733.627314224583;5646.74589643465;5658.971705141489;5664.0371136906615;5665.830025099253;5673.23411339468;5413.621046526745;5584.46947539983;5643.661380317174;5645.661260324353;5651.124075768242;5028.32117664118;5049.671771334852;5058.848234552969;5059.494050594948;5099.643024988252;21764.564708705737;22036.449088772908;22175.66736498954;22198.667019994715;22265;2340.0756701103137;2419.8427102238475;2420.4674971506242;2869.426114777053;2956.7486763625116;13534.390952407166;13931.373088211054;14179.574612761633;14758;14868;1874.381454120137;1941.8737782044122;1956.8434525237947;1956.8630195886294;1979.9406017819344;78340.21659783386;80786.19213807845;81804;83487.7476837854;85045.57477212636;9745.463999479955;9799.853002204973;10138;10161.796764064677;10415.270931034755;14113.929430352782;14130.505432310025;14131.78802317966;14142;14145.646358841112;6418.518611104092;6653.434458071021;6662.067310576524;6795.72817087311;6808.863822723617;6018.15745795589;6052.455279024909;6225.8132256032395;6245.937540624626;6263.96868015657;5916.26046744157;5935.614185077956;6012;6047.334793172748;6065.393460653988;1864.4686264414577;1898.2596787252983;1908.80911908808;1946.7274581558593;1957.9510512237307;906.6418764587951;915.6108653822232;952.6570434643661;984.1732944326657;1019.6940917724653;18359.449216523524;20196.59606807885;20219.898900505697;20226.595468090556;20286.898565507374;964.8566448758244;969.9806003880024;981.1562056631292;1000.6197644894893;1020.974475638115;10480.318779279323;11071.280366776295;11236.887631123747;11324.547018119347;11326.886731132583;437456;443279;451536;451960;458040;53025.469745302056;53402.46597534053;87742;89997;90711;951.9809603807885;981.1120935553336;1004.2217281606813;1004.2618675273668;1009.5709323537467;15557.377704891678;16060.759088613446;16084.839151608334;16267.918660406622;16459.341626335292;37997.430038549996;39937.80031099826;40084.79957600193;42553.787231063645;44586;51784;52831.47168528265;58551.70724146522;59271.40728592659;59717.10424343551;7989.560574168477;8007.399445041528;8033.477823941425;8101.87847182281;8262.586870656563;9195.356325057182;11836.171467997157;12148.635540933787;12707.682307942376;12798.552050678181;10650.680479585624;11038.834417483584;11099;11150.776984460428;11164.153140949005;10819.621313253998;10848.132149427869;10858.34849909008;10903;11501.079913606723;10559.947200263949;10994.175436842428;11336.433178341214;11347.773044539228;11515.136364772508;7969.521828690297;8148.5518296494265;8339.874901876598;8340.87488687658;8568.57157142153;9277.747504086861;11131.67913221799;11258.887411125785;11515.539378425105;11669.708257293636 01:52:20 INFO - PROCESS | 15810 | |3;mootools.html;1333.3466302331615;1400.649837540615;1460.715160543694;1596.5275525731538;1755.5962128710396;7774.067111946567;8450.915490845098;8806.77983050424;8823.205911467974;9050;8869.512176830272;8953.507557084358;8962.507062111597;8962.865557016634;8963.417377870433;2314.1090680088205;2345.155743932183;2348.377679914824;2352.8588284702887;2353.082297903819;2280.1563421534056;2309.2494939144763;2353.1293421434093;2353.705786776653;2360.5396947595227;2256.2216035467736;2291.049214575957;2310.1567927706433;2313.467902382453;2318.455163036685;2256.4133325335365;2257.4356410897276;2271.6819645249598;2272.36373815332;2274.078998005802;2246.180144247338;2267.2971378872603;2270.386995511219;2271.818254539633;2277.544491101786;8209.753707388787;8736.8689469658;8806.119388061206;8807.691730789391;8815.426997245158;5128.640995130342;5267.631265811357;5287.4448182941005;5293.788248470057;5294.073537131025;3389.068006298263;3417.4019546579248;3507.368673638744;3510.1224693826543;3574.088607405121;1075.3279200499687;1121.5738019552518;1122.5453691254972;1127.937963412012;1170.280277629252;12099.637010889688;12353.938230308791;12428.316442595653;12560.429946256718;12580;4179.811908464066;4475.731456112644;4509.413776209072;4577.061702351077;4597.95402045982;9472;9509.762255943657;9510.524473776284;9516.809663806824;9517.143457088756;5091.592672586185;5092.159793634083;5095.643304968691;5097.770600322994;5098.668586541863;4242.915141697149;4373.75944323059;4521.412216411911;4620.075984803053;4674.95325046752;3701.9444708329397;3749.8687545935763;3786.072412259014;3820.2359528093934;3849.826757795906;1165.4988355007258;1167.229628445222;1167.486306025346;1187.4537712652104;1187.4597058338436;781.3592853859781;819.663937785505;896.9641214351353;901.4681338010605;903.1916434790957;5432.6468779529205;5659;5715.199872017921;5807.303123625192;6021.939780602138;888.5290795878195;950.7337945375306;1011.5498603121688;1012.7822518158631;1015.4059874973076;3939.1333906540517;3957.1294315250598;3975.1056012397557;3975.7813320267082;4084.203580301872;10721.30311529748;11176.776464470666;11248.718782030352;11303.660890173307;11313.094952403788;10692.19808514349;10721.571137154426;11239.213255072067;11244.325340479598;11254.381009044417;8213.234154656777;8376.329893608498;8405.243528082501;8409;8414.957925210458;5669.206311116364;5726.9713651431475;5792.652440853562;5857.677827719516;5931.813637272477;9988.101070903653;10130.240231982778;10139.64511242103;10199.949000254952;10267.435291058764;9396.57715402795;9787.755306117404;9806.21550275962;10052.849207262043;10056.34633748804;7076.2923707628825;7226.349628533457;7248.311410416002;7687.500312479671;7754.6898124074405;8222.259996600334;8493;8497.490150590984;8509.531975741145;8511.914880851113;7444.739434119996;7653.311201991847;7705.1909549496495;7737.883931741141;7838.412119090977;7437.479376443597;7508.887366689395;7511.624418779148;7530.962345188239;7549.811254718456;6858.279880612663;6968.198657154492;6971.79084627462;6975.755848545276;6977.092977912839;4859.538343857328;5028.84913452597;5086.6439349246675;5121;5291.9206211906085;5041.873953151201;5119.385673719177;5125.820596279113;5247.134222853339;5354.170103633943 01:52:20 INFO - PROCESS | 15810 | |4;prototype.html;309.7011384014427;313.7411635400794;320.911749268951;322.37459328901946;323.16623112370087;5129.6409251352425;5264.92102618461;5265.341832270966;5291.3650361956525;5315.946840531594;5079.764903442483;5199.766010529525;5216.374035115782;5223.451537588556;5225.86935326617;4100.815463304159;4103.630673239408;4103.850921741917;4115.156392939441;4120.587941205886;3982.761034337949;4062.431259623655;4113.958860411388;4138.3999320098565;4142.420061191436;4027.81874815634;4051.837926482952;4060.4112403701447;4062.6749860011278;4066.4916885389325;4015.4579131817413;4029.37544680575;4032.556418793945;4037.777922214277;4043.9191216175805;3554.893353199408;3558.6619271169457;3560.626134255918;3566.9108272293142;3575.3921833288405;5024.346834911438;5055;5105.693658380509;5116.513931176532;5128.743562821844;4560.703554268962;4567.9086418271445;4584.724916504987;4595.816167353302;4608.884777880547;5441.483059109379;5443.755031023614;5452.40023597404;5457.372402173761;5459.344878614592;3789.810509474515;3848.2303539291975;3857.40210267409;3866.7099967502268;3875.9806200969097;5602.579806514527;5628.54971602275;5642.294713160855;5659.236003139565;5660.3490598581275;3913.8043097844993;3948.565657777642;3949.605039496085;3951;3952.6837852972267;3866.980665096713;3985.8206380712936;4010.358342665218;4013.7391069580385;4021.2962731521866;4571.314302854532;4577.8397756078375;4585.541445855454;4586.2661974083985;4615.822965143867;5472.480114389126;5524.281843360337;5534.090738695144;5536;5544.584156188302;1319.4392383237087;1343.4827591377195;1348.7167694784205;1359.5445525748985;1367.1796921846812;914.7164379042518;922.935394522377;938.8826396700413;941.7833898203452;944.7354740672623;5228.424873263938;5237.5548078413;5241.868953276123;5251.894962100737;5276.762545685453;5523.558115350762;5576.553875689935;5580.748866301026;5588.608797384144;5591.440855914376;5021.648484606116;5220.399654039834;5239.449857764956;5249.396319423316;5253.658512196772;2595.987020064925;2606.8175227734255;2612.137994461823;2616.306678730138;2618.437036037223;4940.814204590944;4947.25791131326;4990.8253211137435;4998.375203099613;5003;4759.928601070987;4938.901221975612;4946.975265123723;4964.478729733398;5037.874053148701;4997.550220480101;4999.175136102503;5007.4241462231585;5027.095122877917;5047.763297992015;4910.232316366034;4919.548733123665;4934.358533390637;4937.506249375034;4941.407031156285;4625.468071171724;4900.975495122501;4921.532454416824;4921.827736029221;4948.8762780930765;4884.7069175849565;4989.476105008922;5045.915128247444;5065.632279284646;5079.898402032012;3584.928301434009;3595.8921232363073;3609.6931760800626;3613.4218525035867;3630.9273814523035;4926.901461970812;4951.628627852853;4958.851234462972;5293.523582877559;5716.171155182558;5568.860778480571;5578.191162281528;5591.27313449249;5593.748281327432;5595.608307418442;5480.3971563127225;5481.561475081904;5512.118061110203;5552.944470555242;5594.468525490072;5233.241180028951;5475.479829416199;5505.678637127141;5532.529734972572;5542.473465020817;5561.972190139185;5563.109902415756;5578.944210557843;5585.989043944096;5588.133839254922;5223.21651752225;5457.7271136443815;5467.343918729778;5468.261784659179;5498.367687715964 01:52:20 INFO - PROCESS | 15810 | |5;yui.html;718.4109030594914;723.6020188896109;756.096464724654;786.504502163637;818.7011740714639;13429.328533573318;13991.720165596682;14115;14290.428382864673;15129;12476.376181190926;12685.112042157052;12694.682632934182;12708.872911270884;12726.490940362375;795.6896810244009;809.7854068671777;810.6838333050115;812.155358427235;812.3744716568239;660.474922436664;681.4684546054061;785.4030936488282;794.7655441644699;805.64551597297;839.1524560194217;839.9454035487704;840.5629072882098;841.0202114536557;841.3731769831484;839.047680882197;839.7270886961701;840.3865178419787;840.7141571865565;841.4824882697159;502.046112386465;516.1019825503635;589.4576989169974;597.5458651424948;605.8848818724429;12578.74842503154;12633.368331583384;12645.304508252042;12647.873521264853;12651.683707907285;12724.300163491005;12859.485620575166;13293.268870212134;13557.59327220185;13621;11547.76904461906;11710.765784684343;11787.705307367298;11792.29246245228;11930.821037684442;4120.361343991656;4200.1179752252065;4202.453681021448;4211.957880421218;4252.808623611914;58891.41108588945;60933.39066609321;61149;61163.38836611666;64366.35633643697;10537.473126343652;10822.40476773785;10847.620333288298;11295.54817807295;11342.20604557673;19601.1179496923;19846.70229946552;19887.801121988596;19899.204031838854;19910.701339479918;7622.656980435783;7753.418493613001;7811.882821757678;8001.719939802196;8014.318782903402;4070.1452694933805;4296.763677997677;4380.4305440292555;4383.627391671744;4530.207213737583;3206.8556914938886;3289.950650740193;3290.588676415448;3291.440455122587;3292;605.588200023988;610.3012051201349;616.1251023546574;623.4264476681464;632.244467860911;618.7741474361826;626.5269721360344;635.4439865118022;663.810813918031;675.7432175773175;8372.246497815104;8398.622062007224;8462.61918213682;8586.356023298153;8851.46891186518;559.0579872914153;598.7874304621884;619.2105066040834;660.7555204574338;686.0772261308632;3860.9227815443533;3938.8424463021156;4031.737937034083;4045.211183819186;4106.384042393605;81937.59031204807;84415.57792211;84736.57631711925;86634;86797;72828;72966.63516682382;73873.63063184649;75438.62280688561;77201;67316.66341668359;68088;68171.99999999901;69867.30132698608;71732.64133679298;7878.960605196938;7961.473844788751;7981.880271796043;8132.6746930122135;8319.83360332778;45807.770961146314;46413.3038004437;47017.2947405796;47377.52622473731;49217.2617410732;54111.188332174264;59869.40130598638;59958.40041599528;60288.39711602828;61475;10632.154019128713;10842.256385715253;11305.15211359135;11334.773304534028;11767.176297659424;11695.12286578493;11975.28148311104;11989.880101198876;12054.216475929037;12256.080793940311;10900.781984360427;10996.615118470816;11372.829407559058;11387.943060284646;11506;11210.719732006764;11293.830592540955;11375.829362559403;11847.585334513251;12275.079369047178;10497.580096796042;10796.17025725799;10855.372743229154;10914.945425272823;10977.506012229629;9024.899373770168;9172.312076594415;9252.95373523128;9432.905670943202;9549.28380371461;8514.70198543048;8593.226609605166;8812.823743524965;8949.507777072324;9037.457752534869 01:52:20 INFO - PROCESS | 15810 | __end_tp_report 01:52:20 INFO - PROCESS | 15810 | __start_cc_report 01:52:20 INFO - PROCESS | 15810 | _x_x_mozilla_cycle_collect,1323 01:52:20 INFO - PROCESS | 15810 | __end_cc_report 01:52:20 INFO - PROCESS | 15810 | __startTimestamp1477471940404__endTimestamp 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | ------- Summary: start ------- 01:52:20 INFO - PROCESS | 15810 | Number of tests: 6 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#0] dojo.html Cycles:165 Average:5391.67 Median:5603.36 stddev:608.90 (10.9%) stddev-sans-first:582.80 01:52:20 INFO - PROCESS | 15810 | Values: 3066.4 3087.7 3117.9 3135.6 3137.4 5266.7 5346.7 5349.5 5408.6 5458.3 5410.1 5452.9 5487.4 5506.9 5540.8 4879.2 4889.5 4931.3 4974.4 4977.6 4995.6 5087.8 5104.9 5111.2 5136.3 4848.4 4967.1 4975.5 5016.6 5094.7 4870.8 4928.1 4933.4 4936.2 4938.0 4867.2 4885.4 4891.2 4892.4 4894.2 5425.5 5429.9 5446.4 5530.4 5530.7 5773.2 5779.6 5781.6 5782.8 5788.2 5703.0 5782.4 5791.7 5833.7 5849.8 5390.3 5410.8 5413.6 5418.0 5475.4 5870.9 5916.3 5922.4 5922.6 5930.2 5543.5 5672.3 5676.2 5676.5 5681.2 5652.2 5734.8 5743.5 5744.8 5770.7 5735.1 5840.1 5843.9 5846.3 5850.1 5796.2 5796.8 5797.0 5798.7 5862.8 4410.1 4439.9 4453.0 4461.4 4463.0 3905.1 3933.2 3949.8 3950.4 3987.0 5431.2 5472.0 5475.2 5476.2 5547.4 5835.1 5844.5 5848.4 5850.7 5866.8 5337.7 5372.2 5379.5 5404.5 5481.9 5040.7 5054.3 5076.3 5124.1 5130.8 5995.0 6001.9 6023.3 6026.0 6035.8 5698.1 5746.0 5858.3 5866.6 5869.5 5918.6 5944.3 5961.1 5963.0 6013.1 5680.5 5680.9 5686.4 5693.1 5693.4 5678.1 5730.2 5768.1 5793.6 5796.0 5597.5 5691.3 5694.7 5706.0 5808.4 5650.0 5727.6 5735.7 5739.1 5740.4 5528.5 5657.9 5683.6 5684.1 5685.2 5603.4 5677.5 5683.2 5711.8 5743.1 5538.5 5591.9 5595.6 5598.9 5666.3 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#1] ext.html Cycles:180 Average:58353.57 Median:40841.39 stddev:115223.03 (282.1%) stddev-sans-first:115464.52 01:52:20 INFO - PROCESS | 15810 | Values: 545.4 586.9 605.7 627.2 648.5 31311.2 41711.8 41821.0 42003.0 42046.0 43552.0 43984.6 44040.1 44044.3 44110.6 8146.6 8560.7 8699.8 8704.3 8708.1 8101.3 8271.4 8274.6 10444.9 10715.7 10761.3 10828.9 10857.6 10937.7 10952.6 10398.7 10448.3 10449.9 10453.6 10458.8 10884.7 10940.9 10947.3 10964.3 10969.1 42055.6 42270.4 42362.0 42377.6 42392.6 3491.9 3497.8 3531.4 3623.4 3918.2 31647.4 31791.5 31851.4 32078.5 32299.0 4176.9 4263.7 4304.1 4317.2 4453.1 322300.0 324927.0 325175.0 326310.0 327203.0 56706.0 57167.7 57490.4 57534.1 57549.4 59308.4 60270.0 60391.0 60514.8 60708.0 11425.5 11442.4 11458.1 11459.8 11462.7 9136.7 9749.8 9783.1 9789.9 9792.8 14797.4 16316.4 16760.4 16846.9 17349.6 5624.3 6281.2 6328.5 6369.9 6403.6 836.3 887.8 890.4 897.4 950.5 30792.0 31450.8 31827.2 32178.2 32555.0 1049.5 1072.7 1074.0 1139.7 1167.1 16243.0 16790.3 16844.9 16938.5 17052.6 473960.0 476153.1 476552.0 477415.0 479097.0 49499.8 50327.5 52755.0 54086.0 56655.7 1115.5 1125.9 1129.3 1144.2 1264.5 29963.0 32225.5 32364.0 32505.0 32916.8 50523.0 50884.0 51016.5 51046.0 51078.2 413831.0 415756.0 416977.0 568811.0 569378.0 27370.0 27417.9 27760.9 28058.0 28118.9 46280.5 46565.3 46776.0 46777.8 48145.0 39201.6 39324.8 40305.8 40578.4 42003.6 36333.5 38574.4 38696.2 41294.2 42719.6 40166.4 41104.4 41215.0 41539.8 41589.4 34259.3 34351.5 35598.0 36220.8 38076.0 25606.6 25632.9 25678.2 25706.4 26045.3 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#2] jquery.html Cycles:180 Average:27058.09 Median:391.99 stddev:73952.51 (18865.7%) stddev-sans-first:74132.78 01:52:20 INFO - PROCESS | 15810 | Values: 350.2 371.0 389.5 394.5 406.7 13873.4 18565.9 19684.7 20175.6 20362.3 15621.5 16497.2 16738.7 17283.5 17387.2 5542.5 5761.7 5790.1 5794.4 5796.2 5478.2 5635.6 5651.9 5732.3 5733.6 5646.7 5659.0 5664.0 5665.8 5673.2 5413.6 5584.5 5643.7 5645.7 5651.1 5028.3 5049.7 5058.8 5059.5 5099.6 21764.6 22036.4 22175.7 22198.7 22265.0 2340.1 2419.8 2420.5 2869.4 2956.7 13534.4 13931.4 14179.6 14758.0 14868.0 1874.4 1941.9 1956.8 1956.9 1979.9 78340.2 80786.2 81804.0 83487.7 85045.6 9745.5 9799.9 10138.0 10161.8 10415.3 14113.9 14130.5 14131.8 14142.0 14145.6 6418.5 6653.4 6662.1 6795.7 6808.9 6018.2 6052.5 6225.8 6245.9 6264.0 5916.3 5935.6 6012.0 6047.3 6065.4 1864.5 1898.3 1908.8 1946.7 1958.0 906.6 915.6 952.7 984.2 1019.7 18359.4 20196.6 20219.9 20226.6 20286.9 964.9 970.0 981.2 1000.6 1021.0 10480.3 11071.3 11236.9 11324.5 11326.9 437456.0 443279.0 451536.0 451960.0 458040.0 53025.5 53402.5 87742.0 89997.0 90711.0 952.0 981.1 1004.2 1004.3 1009.6 15557.4 16060.8 16084.8 16267.9 16459.3 37997.4 39937.8 40084.8 42553.8 44586.0 51784.0 52831.5 58551.7 59271.4 59717.1 7989.6 8007.4 8033.5 8101.9 8262.6 9195.4 11836.2 12148.6 12707.7 12798.6 10650.7 11038.8 11099.0 11150.8 11164.2 10819.6 10848.1 10858.3 10903.0 11501.1 10559.9 10994.2 11336.4 11347.8 11515.1 7969.5 8148.6 8339.9 8340.9 8568.6 9277.7 11131.7 11258.9 11515.5 11669.7 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#3] mootools.html Cycles:180 Average:5724.40 Median:5035.36 stddev:3288.83 (65.3%) stddev-sans-first:3281.50 01:52:20 INFO - PROCESS | 15810 | Values: 1333.3 1400.6 1460.7 1596.5 1755.6 7774.1 8450.9 8806.8 8823.2 9050.0 8869.5 8953.5 8962.5 8962.9 8963.4 2314.1 2345.2 2348.4 2352.9 2353.1 2280.2 2309.2 2353.1 2353.7 2360.5 2256.2 2291.0 2310.2 2313.5 2318.5 2256.4 2257.4 2271.7 2272.4 2274.1 2246.2 2267.3 2270.4 2271.8 2277.5 8209.8 8736.9 8806.1 8807.7 8815.4 5128.6 5267.6 5287.4 5293.8 5294.1 3389.1 3417.4 3507.4 3510.1 3574.1 1075.3 1121.6 1122.5 1127.9 1170.3 12099.6 12353.9 12428.3 12560.4 12580.0 4179.8 4475.7 4509.4 4577.1 4598.0 9472.0 9509.8 9510.5 9516.8 9517.1 5091.6 5092.2 5095.6 5097.8 5098.7 4242.9 4373.8 4521.4 4620.1 4675.0 3701.9 3749.9 3786.1 3820.2 3849.8 1165.5 1167.2 1167.5 1187.5 1187.5 781.4 819.7 897.0 901.5 903.2 5432.6 5659.0 5715.2 5807.3 6021.9 888.5 950.7 1011.5 1012.8 1015.4 3939.1 3957.1 3975.1 3975.8 4084.2 10721.3 11176.8 11248.7 11303.7 11313.1 10692.2 10721.6 11239.2 11244.3 11254.4 8213.2 8376.3 8405.2 8409.0 8415.0 5669.2 5727.0 5792.7 5857.7 5931.8 9988.1 10130.2 10139.6 10199.9 10267.4 9396.6 9787.8 9806.2 10052.8 10056.3 7076.3 7226.3 7248.3 7687.5 7754.7 8222.3 8493.0 8497.5 8509.5 8511.9 7444.7 7653.3 7705.2 7737.9 7838.4 7437.5 7508.9 7511.6 7531.0 7549.8 6858.3 6968.2 6971.8 6975.8 6977.1 4859.5 5028.8 5086.6 5121.0 5291.9 5041.9 5119.4 5125.8 5247.1 5354.2 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#4] prototype.html Cycles:180 Average:4450.60 Median:4990.15 stddev:1304.64 (26.1%) stddev-sans-first:1270.73 01:52:20 INFO - PROCESS | 15810 | Values: 309.7 313.7 320.9 322.4 323.2 5129.6 5264.9 5265.3 5291.4 5315.9 5079.8 5199.8 5216.4 5223.5 5225.9 4100.8 4103.6 4103.9 4115.2 4120.6 3982.8 4062.4 4114.0 4138.4 4142.4 4027.8 4051.8 4060.4 4062.7 4066.5 4015.5 4029.4 4032.6 4037.8 4043.9 3554.9 3558.7 3560.6 3566.9 3575.4 5024.3 5055.0 5105.7 5116.5 5128.7 4560.7 4567.9 4584.7 4595.8 4608.9 5441.5 5443.8 5452.4 5457.4 5459.3 3789.8 3848.2 3857.4 3866.7 3876.0 5602.6 5628.5 5642.3 5659.2 5660.3 3913.8 3948.6 3949.6 3951.0 3952.7 3867.0 3985.8 4010.4 4013.7 4021.3 4571.3 4577.8 4585.5 4586.3 4615.8 5472.5 5524.3 5534.1 5536.0 5544.6 1319.4 1343.5 1348.7 1359.5 1367.2 914.7 922.9 938.9 941.8 944.7 5228.4 5237.6 5241.9 5251.9 5276.8 5523.6 5576.6 5580.7 5588.6 5591.4 5021.6 5220.4 5239.4 5249.4 5253.7 2596.0 2606.8 2612.1 2616.3 2618.4 4940.8 4947.3 4990.8 4998.4 5003.0 4759.9 4938.9 4947.0 4964.5 5037.9 4997.6 4999.2 5007.4 5027.1 5047.8 4910.2 4919.5 4934.4 4937.5 4941.4 4625.5 4901.0 4921.5 4921.8 4948.9 4884.7 4989.5 5045.9 5065.6 5079.9 3584.9 3595.9 3609.7 3613.4 3630.9 4926.9 4951.6 4958.9 5293.5 5716.2 5568.9 5578.2 5591.3 5593.7 5595.6 5480.4 5481.6 5512.1 5552.9 5594.5 5233.2 5475.5 5505.7 5532.5 5542.5 5562.0 5563.1 5578.9 5586.0 5588.1 5223.2 5457.7 5467.3 5468.3 5498.4 01:52:20 INFO - PROCESS | 15810 | 01:52:20 INFO - PROCESS | 15810 | [#5] yui.html Cycles:180 Average:17022.42 Median:593.50 stddev:23045.02 (3882.9%) stddev-sans-first:23077.15 01:52:20 INFO - PROCESS | 15810 | Values: 718.4 723.6 756.1 786.5 818.7 13429.3 13991.7 14115.0 14290.4 15129.0 12476.4 12685.1 12694.7 12708.9 12726.5 795.7 809.8 810.7 812.2 812.4 660.5 681.5 785.4 794.8 805.6 839.2 839.9 840.6 841.0 841.4 839.0 839.7 840.4 840.7 841.5 502.0 516.1 589.5 597.5 605.9 12578.7 12633.4 12645.3 12647.9 12651.7 12724.3 12859.5 13293.3 13557.6 13621.0 11547.8 11710.8 11787.7 11792.3 11930.8 4120.4 4200.1 4202.5 4212.0 4252.8 58891.4 60933.4 61149.0 61163.4 64366.4 10537.5 10822.4 10847.6 11295.5 11342.2 19601.1 19846.7 19887.8 19899.2 19910.7 7622.7 7753.4 7811.9 8001.7 8014.3 4070.1 4296.8 4380.4 4383.6 4530.2 3206.9 3290.0 3290.6 3291.4 3292.0 605.6 610.3 616.1 623.4 632.2 618.8 626.5 635.4 663.8 675.7 8372.2 8398.6 8462.6 8586.4 8851.5 559.1 598.8 619.2 660.8 686.1 3860.9 3938.8 4031.7 4045.2 4106.4 81937.6 84415.6 84736.6 86634.0 86797.0 72828.0 72966.6 73873.6 75438.6 77201.0 67316.7 68088.0 68172.0 69867.3 71732.6 7879.0 7961.5 7981.9 8132.7 8319.8 45807.8 46413.3 47017.3 47377.5 49217.3 54111.2 59869.4 59958.4 60288.4 61475.0 10632.2 10842.3 11305.2 11334.8 11767.2 11695.1 11975.3 11989.9 12054.2 12256.1 10900.8 10996.6 11372.8 11387.9 11506.0 11210.7 11293.8 11375.8 11847.6 12275.1 10497.6 10796.2 10855.4 10914.9 10977.5 9024.9 9172.3 9253.0 9432.9 9549.3 8514.7 8593.2 8812.8 8949.5 9037.5 01:52:20 INFO - PROCESS | 15810 | -------- Summary: end -------- 01:52:20 INFO - PROCESS | 15810 | 01:52:21 INFO - TEST-INFO | 15810: exit 0 01:52:21 INFO - TEST-OK | dromaeo_css | took 1118082ms 01:52:21 INFO - TEST-START | kraken 01:52:21 INFO - operating with platform_type : linux_ 01:52:21 INFO - Initialising browser for kraken test... 01:52:21 INFO - TEST-INFO | started process 16118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5JrtOw/profile http://localhost:50612/getInfo.html) 01:52:25 INFO - PROCESS | 16118 | __metrics Screen width/height:1600/1200 01:52:25 INFO - PROCESS | 16118 | colorDepth:24 01:52:25 INFO - PROCESS | 16118 | Browser inner width/height: 1024/697 01:52:25 INFO - PROCESS | 16118 | __metrics 01:52:26 INFO - PROCESS | 16118 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:52:26 INFO - PROCESS | 16118 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:52:26 INFO - PROCESS | 16118 | console.error: PushService: 01:52:26 INFO - PROCESS | 16118 | stateChangeProcessEnqueue: Error transitioning state 01:52:26 INFO - PROCESS | 16118 | UnknownError 01:52:27 INFO - TEST-INFO | 16118: exit 0 01:52:27 INFO - Browser initialized. 01:52:27 INFO - Running cycle 1/1 for kraken test... 01:52:27 INFO - TEST-INFO | started process 16201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5JrtOw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:39 INFO - PROCESS | 16201 | RSS: Main: 171532288 01:52:39 INFO - PROCESS | 16201 | 01:52:42 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50612/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:43 INFO - PROCESS | 16201 | RSS: Main: 228028416 01:52:43 INFO - PROCESS | 16201 | 01:52:45 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50612/tests/kraken/driver.html?testName=audio-dft) 01:52:46 INFO - PROCESS | 16201 | RSS: Main: 215683072 01:52:46 INFO - PROCESS | 16201 | 01:52:49 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50612/tests/kraken/driver.html?testName=audio-fft) 01:52:50 INFO - PROCESS | 16201 | RSS: Main: 297476096 01:52:50 INFO - PROCESS | 16201 | 01:52:52 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50612/tests/kraken/driver.html?testName=audio-oscillator) 01:52:52 INFO - PROCESS | 16201 | RSS: Main: 207777792 01:52:52 INFO - PROCESS | 16201 | 01:52:54 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:55 INFO - PROCESS | 16201 | RSS: Main: 211181568 01:52:55 INFO - PROCESS | 16201 | 01:52:58 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50612/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:59 INFO - PROCESS | 16201 | RSS: Main: 247537664 01:52:59 INFO - PROCESS | 16201 | 01:53:02 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50612/tests/kraken/driver.html?testName=imaging-desaturate) 01:53:02 INFO - PROCESS | 16201 | RSS: Main: 246390784 01:53:02 INFO - PROCESS | 16201 | 01:53:05 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50612/tests/kraken/driver.html?testName=json-parse-financial) 01:53:06 INFO - PROCESS | 16201 | RSS: Main: 245719040 01:53:06 INFO - PROCESS | 16201 | 01:53:07 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:53:08 INFO - PROCESS | 16201 | RSS: Main: 208203776 01:53:08 INFO - PROCESS | 16201 | 01:53:10 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:10 INFO - PROCESS | 16201 | RSS: Main: 215515136 01:53:10 INFO - PROCESS | 16201 | 01:53:12 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:13 INFO - PROCESS | 16201 | RSS: Main: 224972800 01:53:13 INFO - PROCESS | 16201 | 01:53:16 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:16 INFO - PROCESS | 16201 | RSS: Main: 226430976 01:53:16 INFO - PROCESS | 16201 | 01:53:19 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:20 INFO - PROCESS | 16201 | RSS: Main: 229502976 01:53:20 INFO - PROCESS | 16201 | 01:53:21 INFO - PROCESS | 16201 | Cycle 1(1): loaded http://localhost:50612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50612/tests/kraken/driver.html?testName=ai-astar) 01:53:22 INFO - PROCESS | 16201 | RSS: Main: 279539712 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | __start_tp_report 01:53:22 INFO - PROCESS | 16201 | _x_x_mozilla_page_load 01:53:22 INFO - PROCESS | 16201 | _x_x_mozilla_page_load_details 01:53:22 INFO - PROCESS | 16201 | |i|pagename|runs| 01:53:22 INFO - PROCESS | 16201 | |0;ai-astar;103;110;113;111;112;111;112;111;110;110 01:53:22 INFO - PROCESS | 16201 | |1;audio-beat-detection;150;122;123;156;123;124;127;121;150;122 01:53:22 INFO - PROCESS | 16201 | |2;audio-dft;160;160;161;159;163;163;163;161;161;161 01:53:22 INFO - PROCESS | 16201 | |3;audio-fft;76;75;76;114;76;77;76;75;98;75 01:53:22 INFO - PROCESS | 16201 | |4;audio-oscillator;82;81;131;84;84;83;103;82;81;124 01:53:22 INFO - PROCESS | 16201 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;116;117;118 01:53:22 INFO - PROCESS | 16201 | |6;imaging-darkroom;145;145;146;145;145;146;146;146;147;145 01:53:22 INFO - PROCESS | 16201 | |7;imaging-desaturate;84;85;85;84;84;84;84;84;84;84 01:53:22 INFO - PROCESS | 16201 | |8;json-parse-financial;53;53;53;53;54;55;55;55;54;54 01:53:22 INFO - PROCESS | 16201 | |9;json-stringify-tinderbox;61;61;62;62;62;62;62;62;62;61 01:53:22 INFO - PROCESS | 16201 | |10;stanford-crypto-aes;89;80;79;81;79;79;80;79;85;88 01:53:22 INFO - PROCESS | 16201 | |11;stanford-crypto-ccm;140;132;134;129;130;137;141;145;169;126 01:53:22 INFO - PROCESS | 16201 | |12;stanford-crypto-pbkdf2;167;167;169;169;168;169;166;170;167;169 01:53:22 INFO - PROCESS | 16201 | |13;stanford-crypto-sha256-iterative;65;66;67;66;65;66;65;65;65;65 01:53:22 INFO - PROCESS | 16201 | __end_tp_report 01:53:22 INFO - PROCESS | 16201 | __start_cc_report 01:53:22 INFO - PROCESS | 16201 | _x_x_mozilla_cycle_collect,1674 01:53:22 INFO - PROCESS | 16201 | __end_cc_report 01:53:22 INFO - PROCESS | 16201 | __startTimestamp1477472002060__endTimestamp 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | ------- Summary: start ------- 01:53:22 INFO - PROCESS | 16201 | Number of tests: 14 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.75 (2.5%) stddev-sans-first:1.05 01:53:22 INFO - PROCESS | 16201 | Values: 103.0 110.0 113.0 111.0 112.0 111.0 112.0 111.0 110.0 110.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:125.50 stddev:14.12 (11.3%) stddev-sans-first:13.36 01:53:22 INFO - PROCESS | 16201 | Values: 150.0 122.0 123.0 156.0 123.0 124.0 127.0 121.0 150.0 122.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.41 01:53:22 INFO - PROCESS | 16201 | Values: 160.0 160.0 161.0 159.0 163.0 163.0 163.0 161.0 161.0 161.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:13.31 (17.5%) stddev-sans-first:13.96 01:53:22 INFO - PROCESS | 16201 | Values: 76.0 75.0 76.0 114.0 76.0 77.0 76.0 75.0 98.0 75.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:82.00 stddev:19.13 (23.3%) stddev-sans-first:19.84 01:53:22 INFO - PROCESS | 16201 | Values: 82.0 81.0 131.0 84.0 84.0 83.0 103.0 82.0 81.0 124.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:53:22 INFO - PROCESS | 16201 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 01:53:22 INFO - PROCESS | 16201 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 147.0 145.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 01:53:22 INFO - PROCESS | 16201 | Values: 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 01:53:22 INFO - PROCESS | 16201 | Values: 53.0 53.0 53.0 53.0 54.0 55.0 55.0 55.0 54.0 54.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 01:53:22 INFO - PROCESS | 16201 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:3.93 (4.9%) stddev-sans-first:3.22 01:53:22 INFO - PROCESS | 16201 | Values: 89.0 80.0 79.0 81.0 79.0 79.0 80.0 79.0 85.0 88.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:138.50 stddev:12.31 (8.9%) stddev-sans-first:13.04 01:53:22 INFO - PROCESS | 16201 | Values: 140.0 132.0 134.0 129.0 130.0 137.0 141.0 145.0 169.0 126.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 01:53:22 INFO - PROCESS | 16201 | Values: 167.0 167.0 169.0 169.0 168.0 169.0 166.0 170.0 167.0 169.0 01:53:22 INFO - PROCESS | 16201 | 01:53:22 INFO - PROCESS | 16201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 01:53:22 INFO - PROCESS | 16201 | Values: 65.0 66.0 67.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 01:53:22 INFO - PROCESS | 16201 | -------- Summary: end -------- 01:53:22 INFO - PROCESS | 16201 | 01:53:23 INFO - TEST-INFO | 16201: exit 0 01:53:23 INFO - TEST-OK | kraken | took 61930ms 01:53:23 INFO - SUITE-END | took 1180s 01:53:23 INFO - Completed test suite (00:19:40) 01:53:23 INFO - javascript benchmark 01:53:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.3713938642572, 3087.675794041624, 3117.890873819417, 3135.6394014688303, 3137.3882092991876, 5266.657667251636, 5346.732663366835, 5349.5452886504645, 5408.621396502242, 5458.263134476844, 5410.08028635132, 5452.945470545294, 5487.42382049885, 5506.862328441791, 5540.833774986757, 4879.243717223818, 4889.486603906592, 4931.284963680264, 4974.353334066566, 4977.55202031817, 4995.550400463958, 5087.79648814047, 5104.8979020419565, 5111.1566591512355, 5136.306598609177, 4848.442429120661, 4967.081089998362, 4975.477574854624, 5016.573591244731, 5094.7197904115255, 4870.805167793284, 4928.1129396708575, 4933.383327084114, 4936.210206367, 4938.037082768861, 4867.245576935581, 4885.43817460993, 4891.1685013547785, 4892.437369702494, 4894.216925291937, 5425.484578964992, 5429.945700542983, 5446.373667028302, 5530.391656917735, 5530.723463826833, 5773.162891380726, 5779.566532510079, 5781.595288329819, 5782.768689252425, 5788.18965344852, 5703.0, 5782.421757824226, 5791.652500849962, 5833.737481813286, 5849.824505264849, 5390.272313237702, 5410.756515956791, 5413.593980451482, 5417.972910135424, 5475.397706252309, 5870.941290587125, 5916.349201587822, 5922.378150294243, 5922.585419020714, 5930.169776231331, 5543.501084902378, 5672.290963629546, 5676.205331253628, 5676.460736230051, 5681.176229446707, 5652.152177173457, 5734.827955161351, 5743.483086522149, 5744.798932037442, 5770.740316685676, 5735.082386818089, 5840.123981402823, 5843.912341314884, 5846.269216347957, 5850.063989761617, 5796.246487956539, 5796.797112101141, 5797.0, 5798.710064496759, 5862.765489380462, 4410.051838854662, 4439.889002774957, 4453.0, 4461.442319710036, 4463.04044630406, 3905.1213476967455, 3933.1543718100747, 3949.763014219156, 3950.3876899080688, 3987.043109653662, 5431.158170483582, 5472.042392581362, 5475.151351540518, 5476.151196564539, 5547.445255474501, 5835.124731290341, 5844.532437404998, 5848.444397782204, 5850.736716847752, 5866.823995280149, 5337.733113344318, 5372.221027950925, 5379.515843574097, 5404.4891162364265, 5481.945180548223, 5040.697558146523, 5054.317667114892, 5076.289319495274, 5124.052050370693, 5130.846074617767, 5995.0, 6001.909971350433, 6023.27720673522, 6026.035834266497, 6035.849103772353, 5698.088305871041, 5745.971270143623, 5858.2677165354335, 5866.6186697864505, 5869.530437564899, 5918.585699001201, 5944.286685597756, 5961.105834124916, 5962.97018514922, 6013.128096426081, 5680.488756011813, 5680.943190568207, 5686.4029276926985, 5693.060644993695, 5693.430656934273, 5678.14827775837, 5730.169125476866, 5768.134779783066, 5793.565482588907, 5796.0, 5597.468240517144, 5691.288588926384, 5694.658320500617, 5705.971470142623, 5808.419158084158, 5649.971750141223, 5727.570432217683, 5735.655860648374, 5739.110437882135, 5740.368559458373, 5528.530074943675, 5657.858553536194, 5683.5737319700365, 5684.062129748545, 5685.20407142992, 5603.355614104267, 5677.489025987681, 5683.204351390891, 5711.771529138788, 5743.0811070228565, 5538.47384498472, 5591.916121258103, 5595.63628364155, 5598.86002849932, 5666.320041595035], "value": 5350.27164127565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.4026270702453, 586.870888404551, 605.7365046204901, 627.1909237084162, 648.4812150279776, 31311.217219569495, 41711.79144104279, 41821.0, 42003.0, 42046.0, 43552.0, 43984.560154398445, 44040.119197616106, 44044.33933491, 44110.55889441105, 8146.633401496917, 8560.743177704664, 8699.782505437352, 8704.30365570756, 8708.129187081273, 8101.311388531982, 8271.421000529965, 8274.627641756135, 10444.895551044468, 10715.678529644123, 10761.300515466508, 10828.945855270713, 10857.565697372096, 10937.671869843918, 10952.616658416957, 10398.740031499236, 10448.32085914413, 10449.895501045045, 10453.581856725721, 10458.79082418355, 10884.673459796219, 10940.945295273552, 10947.288426252268, 10964.342139471657, 10969.067629251524, 42055.57944420578, 42270.36594451086, 42362.0, 42377.57622423798, 42392.57607423948, 3491.9301613967577, 3497.842597083137, 3531.3996620574308, 3623.4202527595457, 3918.216356728637, 31647.367052659047, 31791.523127153112, 31851.362972740415, 32078.51882221745, 32299.0, 4176.91646167078, 4263.680223983214, 4304.096139810612, 4317.201317756194, 4453.109378124355, 322300.0, 324927.0, 325175.0, 326310.0, 327203.0, 56706.0, 57167.71416142976, 57490.425095748506, 57534.13698794522, 57549.4245057544, 59308.40691593029, 60270.0, 60391.0, 60514.78970420655, 60708.0, 11425.542978280942, 11442.37066961325, 11458.08335333188, 11459.828102578467, 11462.656120316404, 9136.725898223063, 9749.756256093513, 9783.0706082922, 9789.853152202722, 9792.755181120529, 14797.408103675732, 16316.428924987806, 16760.413385531447, 16846.91576542134, 17349.56626084358, 5624.3250809903075, 6281.246250449975, 6328.46208072319, 6369.8726025480155, 6403.64779937108, 836.2766207230702, 887.8135591525722, 890.4034297021011, 897.4301318662697, 950.5009869818263, 30792.0, 31450.842745786125, 31827.20431989219, 32178.19554511156, 32555.0, 1049.538203190609, 1072.6889202131451, 1073.9892601074046, 1139.6922830835795, 1167.1479819731644, 16243.0, 16790.328386864632, 16844.915775421043, 16938.49184524466, 17052.57368565771, 473960.0, 476153.1000969852, 476552.0, 477415.0, 479097.0, 49499.752501237264, 50327.496725033016, 52755.0, 54086.0, 56655.71672141613, 1115.4980258883536, 1125.8930401611833, 1129.3336931210624, 1144.1761931409371, 1264.4942023190613, 29962.981133759185, 32225.51661725123, 32364.0, 32505.02484925456, 32916.83541582277, 50523.0, 50884.0, 51016.48983510266, 51046.0, 51078.23382649189, 413831.0, 415756.0, 416977.0, 568811.0, 569378.0, 27370.0, 27417.86291068532, 27760.86119569389, 28058.0, 28118.859405702842, 46280.53719462762, 46565.3015204779, 46776.0, 46777.76611116923, 48145.0, 39201.6079839198, 39324.803375982934, 40305.79847100746, 40578.39132413075, 42003.57996419997, 36333.45499817558, 38574.42138367983, 38696.22607547777, 41294.1741165181, 42719.5728042728, 40166.397504036875, 41104.38343424791, 41215.0, 41539.7923010383, 41589.37615935703, 34259.31481370309, 34351.48472772961, 35598.0, 36220.81889590535, 38076.0, 25606.615900761877, 25632.87183564145, 25678.229653110437, 25706.35734106662, 26045.348866277738], "value": 19451.08140542952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.17184358990994, 370.9591944886064, 389.45281878960054, 394.5364197068444, 406.721395843847, 13873.445062197512, 18565.907170464146, 19684.70472942907, 20175.596488070267, 20362.287319943767, 15621.453249136282, 16497.17514124295, 16738.66522669546, 17283.481495555152, 17387.217575209113, 5542.473465020827, 5761.68310742911, 5790.10253410722, 5794.362620111784, 5796.159556864252, 5478.233047373351, 5635.5773317001185, 5651.943480565204, 5732.283464566929, 5733.627314224583, 5646.74589643465, 5658.971705141489, 5664.0371136906615, 5665.830025099253, 5673.23411339468, 5413.621046526745, 5584.46947539983, 5643.661380317174, 5645.661260324353, 5651.124075768242, 5028.32117664118, 5049.671771334852, 5058.848234552969, 5059.494050594948, 5099.643024988252, 21764.564708705737, 22036.449088772908, 22175.66736498954, 22198.667019994715, 22265.0, 2340.0756701103137, 2419.8427102238475, 2420.4674971506242, 2869.426114777053, 2956.7486763625116, 13534.390952407166, 13931.373088211054, 14179.574612761633, 14758.0, 14868.0, 1874.381454120137, 1941.8737782044122, 1956.8434525237947, 1956.8630195886294, 1979.9406017819344, 78340.21659783386, 80786.19213807845, 81804.0, 83487.7476837854, 85045.57477212636, 9745.463999479955, 9799.853002204973, 10138.0, 10161.796764064677, 10415.270931034755, 14113.929430352782, 14130.505432310025, 14131.78802317966, 14142.0, 14145.646358841112, 6418.518611104092, 6653.434458071021, 6662.067310576524, 6795.72817087311, 6808.863822723617, 6018.15745795589, 6052.455279024909, 6225.8132256032395, 6245.937540624626, 6263.96868015657, 5916.26046744157, 5935.614185077956, 6012.0, 6047.334793172748, 6065.393460653988, 1864.4686264414577, 1898.2596787252983, 1908.80911908808, 1946.7274581558593, 1957.9510512237307, 906.6418764587951, 915.6108653822232, 952.6570434643661, 984.1732944326657, 1019.6940917724653, 18359.449216523524, 20196.59606807885, 20219.898900505697, 20226.595468090556, 20286.898565507374, 964.8566448758244, 969.9806003880024, 981.1562056631292, 1000.6197644894893, 1020.974475638115, 10480.318779279323, 11071.280366776295, 11236.887631123747, 11324.547018119347, 11326.886731132583, 437456.0, 443279.0, 451536.0, 451960.0, 458040.0, 53025.469745302056, 53402.46597534053, 87742.0, 89997.0, 90711.0, 951.9809603807885, 981.1120935553336, 1004.2217281606813, 1004.2618675273668, 1009.5709323537467, 15557.377704891678, 16060.759088613446, 16084.839151608334, 16267.918660406622, 16459.341626335292, 37997.430038549996, 39937.80031099826, 40084.79957600193, 42553.787231063645, 44586.0, 51784.0, 52831.47168528265, 58551.70724146522, 59271.40728592659, 59717.10424343551, 7989.560574168477, 8007.399445041528, 8033.477823941425, 8101.87847182281, 8262.586870656563, 9195.356325057182, 11836.171467997157, 12148.635540933787, 12707.682307942376, 12798.552050678181, 10650.680479585624, 11038.834417483584, 11099.0, 11150.776984460428, 11164.153140949005, 10819.621313253998, 10848.132149427869, 10858.34849909008, 10903.0, 11501.079913606723, 10559.947200263949, 10994.175436842428, 11336.433178341214, 11347.773044539228, 11515.136364772508, 7969.521828690297, 8148.5518296494265, 8339.874901876598, 8340.87488687658, 8568.57157142153, 9277.747504086861, 11131.67913221799, 11258.887411125785, 11515.539378425105, 11669.708257293636], "value": 8916.960717036776, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3466302331615, 1400.649837540615, 1460.715160543694, 1596.5275525731538, 1755.5962128710396, 7774.067111946567, 8450.915490845098, 8806.77983050424, 8823.205911467974, 9050.0, 8869.512176830272, 8953.507557084358, 8962.507062111597, 8962.865557016634, 8963.417377870433, 2314.1090680088205, 2345.155743932183, 2348.377679914824, 2352.8588284702887, 2353.082297903819, 2280.1563421534056, 2309.2494939144763, 2353.1293421434093, 2353.705786776653, 2360.5396947595227, 2256.2216035467736, 2291.049214575957, 2310.1567927706433, 2313.467902382453, 2318.455163036685, 2256.4133325335365, 2257.4356410897276, 2271.6819645249598, 2272.36373815332, 2274.078998005802, 2246.180144247338, 2267.2971378872603, 2270.386995511219, 2271.818254539633, 2277.544491101786, 8209.753707388787, 8736.8689469658, 8806.119388061206, 8807.691730789391, 8815.426997245158, 5128.640995130342, 5267.631265811357, 5287.4448182941005, 5293.788248470057, 5294.073537131025, 3389.068006298263, 3417.4019546579248, 3507.368673638744, 3510.1224693826543, 3574.088607405121, 1075.3279200499687, 1121.5738019552518, 1122.5453691254972, 1127.937963412012, 1170.280277629252, 12099.637010889688, 12353.938230308791, 12428.316442595653, 12560.429946256718, 12580.0, 4179.811908464066, 4475.731456112644, 4509.413776209072, 4577.061702351077, 4597.95402045982, 9472.0, 9509.762255943657, 9510.524473776284, 9516.809663806824, 9517.143457088756, 5091.592672586185, 5092.159793634083, 5095.643304968691, 5097.770600322994, 5098.668586541863, 4242.915141697149, 4373.75944323059, 4521.412216411911, 4620.075984803053, 4674.95325046752, 3701.9444708329397, 3749.8687545935763, 3786.072412259014, 3820.2359528093934, 3849.826757795906, 1165.4988355007258, 1167.229628445222, 1167.486306025346, 1187.4537712652104, 1187.4597058338436, 781.3592853859781, 819.663937785505, 896.9641214351353, 901.4681338010605, 903.1916434790957, 5432.6468779529205, 5659.0, 5715.199872017921, 5807.303123625192, 6021.939780602138, 888.5290795878195, 950.7337945375306, 1011.5498603121688, 1012.7822518158631, 1015.4059874973076, 3939.1333906540517, 3957.1294315250598, 3975.1056012397557, 3975.7813320267082, 4084.203580301872, 10721.30311529748, 11176.776464470666, 11248.718782030352, 11303.660890173307, 11313.094952403788, 10692.19808514349, 10721.571137154426, 11239.213255072067, 11244.325340479598, 11254.381009044417, 8213.234154656777, 8376.329893608498, 8405.243528082501, 8409.0, 8414.957925210458, 5669.206311116364, 5726.9713651431475, 5792.652440853562, 5857.677827719516, 5931.813637272477, 9988.101070903653, 10130.240231982778, 10139.64511242103, 10199.949000254952, 10267.435291058764, 9396.57715402795, 9787.755306117404, 9806.21550275962, 10052.849207262043, 10056.34633748804, 7076.2923707628825, 7226.349628533457, 7248.311410416002, 7687.500312479671, 7754.6898124074405, 8222.259996600334, 8493.0, 8497.490150590984, 8509.531975741145, 8511.914880851113, 7444.739434119996, 7653.311201991847, 7705.1909549496495, 7737.883931741141, 7838.412119090977, 7437.479376443597, 7508.887366689395, 7511.624418779148, 7530.962345188239, 7549.811254718456, 6858.279880612663, 6968.198657154492, 6971.79084627462, 6975.755848545276, 6977.092977912839, 4859.538343857328, 5028.84913452597, 5086.6439349246675, 5121.0, 5291.9206211906085, 5041.873953151201, 5119.385673719177, 5125.820596279113, 5247.134222853339, 5354.170103633943], "value": 4561.695997281908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7011384014427, 313.7411635400794, 320.911749268951, 322.37459328901946, 323.16623112370087, 5129.6409251352425, 5264.92102618461, 5265.341832270966, 5291.3650361956525, 5315.946840531594, 5079.764903442483, 5199.766010529525, 5216.374035115782, 5223.451537588556, 5225.86935326617, 4100.815463304159, 4103.630673239408, 4103.850921741917, 4115.156392939441, 4120.587941205886, 3982.761034337949, 4062.431259623655, 4113.958860411388, 4138.3999320098565, 4142.420061191436, 4027.81874815634, 4051.837926482952, 4060.4112403701447, 4062.6749860011278, 4066.4916885389325, 4015.4579131817413, 4029.37544680575, 4032.556418793945, 4037.777922214277, 4043.9191216175805, 3554.893353199408, 3558.6619271169457, 3560.626134255918, 3566.9108272293142, 3575.3921833288405, 5024.346834911438, 5055.0, 5105.693658380509, 5116.513931176532, 5128.743562821844, 4560.703554268962, 4567.9086418271445, 4584.724916504987, 4595.816167353302, 4608.884777880547, 5441.483059109379, 5443.755031023614, 5452.40023597404, 5457.372402173761, 5459.344878614592, 3789.810509474515, 3848.2303539291975, 3857.40210267409, 3866.7099967502268, 3875.9806200969097, 5602.579806514527, 5628.54971602275, 5642.294713160855, 5659.236003139565, 5660.3490598581275, 3913.8043097844993, 3948.565657777642, 3949.605039496085, 3951.0, 3952.6837852972267, 3866.980665096713, 3985.8206380712936, 4010.358342665218, 4013.7391069580385, 4021.2962731521866, 4571.314302854532, 4577.8397756078375, 4585.541445855454, 4586.2661974083985, 4615.822965143867, 5472.480114389126, 5524.281843360337, 5534.090738695144, 5536.0, 5544.584156188302, 1319.4392383237087, 1343.4827591377195, 1348.7167694784205, 1359.5445525748985, 1367.1796921846812, 914.7164379042518, 922.935394522377, 938.8826396700413, 941.7833898203452, 944.7354740672623, 5228.424873263938, 5237.5548078413, 5241.868953276123, 5251.894962100737, 5276.762545685453, 5523.558115350762, 5576.553875689935, 5580.748866301026, 5588.608797384144, 5591.440855914376, 5021.648484606116, 5220.399654039834, 5239.449857764956, 5249.396319423316, 5253.658512196772, 2595.987020064925, 2606.8175227734255, 2612.137994461823, 2616.306678730138, 2618.437036037223, 4940.814204590944, 4947.25791131326, 4990.8253211137435, 4998.375203099613, 5003.0, 4759.928601070987, 4938.901221975612, 4946.975265123723, 4964.478729733398, 5037.874053148701, 4997.550220480101, 4999.175136102503, 5007.4241462231585, 5027.095122877917, 5047.763297992015, 4910.232316366034, 4919.548733123665, 4934.358533390637, 4937.506249375034, 4941.407031156285, 4625.468071171724, 4900.975495122501, 4921.532454416824, 4921.827736029221, 4948.8762780930765, 4884.7069175849565, 4989.476105008922, 5045.915128247444, 5065.632279284646, 5079.898402032012, 3584.928301434009, 3595.8921232363073, 3609.6931760800626, 3613.4218525035867, 3630.9273814523035, 4926.901461970812, 4951.628627852853, 4958.851234462972, 5293.523582877559, 5716.171155182558, 5568.860778480571, 5578.191162281528, 5591.27313449249, 5593.748281327432, 5595.608307418442, 5480.3971563127225, 5481.561475081904, 5512.118061110203, 5552.944470555242, 5594.468525490072, 5233.241180028951, 5475.479829416199, 5505.678637127141, 5532.529734972572, 5542.473465020817, 5561.972190139185, 5563.109902415756, 5578.944210557843, 5585.989043944096, 5588.133839254922, 5223.21651752225, 5457.7271136443815, 5467.343918729778, 5468.261784659179, 5498.367687715964], "value": 4036.0611991233654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4109030594914, 723.6020188896109, 756.096464724654, 786.504502163637, 818.7011740714639, 13429.328533573318, 13991.720165596682, 14115.0, 14290.428382864673, 15129.0, 12476.376181190926, 12685.112042157052, 12694.682632934182, 12708.872911270884, 12726.490940362375, 795.6896810244009, 809.7854068671777, 810.6838333050115, 812.155358427235, 812.3744716568239, 660.474922436664, 681.4684546054061, 785.4030936488282, 794.7655441644699, 805.64551597297, 839.1524560194217, 839.9454035487704, 840.5629072882098, 841.0202114536557, 841.3731769831484, 839.047680882197, 839.7270886961701, 840.3865178419787, 840.7141571865565, 841.4824882697159, 502.046112386465, 516.1019825503635, 589.4576989169974, 597.5458651424948, 605.8848818724429, 12578.74842503154, 12633.368331583384, 12645.304508252042, 12647.873521264853, 12651.683707907285, 12724.300163491005, 12859.485620575166, 13293.268870212134, 13557.59327220185, 13621.0, 11547.76904461906, 11710.765784684343, 11787.705307367298, 11792.29246245228, 11930.821037684442, 4120.361343991656, 4200.1179752252065, 4202.453681021448, 4211.957880421218, 4252.808623611914, 58891.41108588945, 60933.39066609321, 61149.0, 61163.38836611666, 64366.35633643697, 10537.473126343652, 10822.40476773785, 10847.620333288298, 11295.54817807295, 11342.20604557673, 19601.1179496923, 19846.70229946552, 19887.801121988596, 19899.204031838854, 19910.701339479918, 7622.656980435783, 7753.418493613001, 7811.882821757678, 8001.719939802196, 8014.318782903402, 4070.1452694933805, 4296.763677997677, 4380.4305440292555, 4383.627391671744, 4530.207213737583, 3206.8556914938886, 3289.950650740193, 3290.588676415448, 3291.440455122587, 3292.0, 605.588200023988, 610.3012051201349, 616.1251023546574, 623.4264476681464, 632.244467860911, 618.7741474361826, 626.5269721360344, 635.4439865118022, 663.810813918031, 675.7432175773175, 8372.246497815104, 8398.622062007224, 8462.61918213682, 8586.356023298153, 8851.46891186518, 559.0579872914153, 598.7874304621884, 619.2105066040834, 660.7555204574338, 686.0772261308632, 3860.9227815443533, 3938.8424463021156, 4031.737937034083, 4045.211183819186, 4106.384042393605, 81937.59031204807, 84415.57792211, 84736.57631711925, 86634.0, 86797.0, 72828.0, 72966.63516682382, 73873.63063184649, 75438.62280688561, 77201.0, 67316.66341668359, 68088.0, 68171.99999999901, 69867.30132698608, 71732.64133679298, 7878.960605196938, 7961.473844788751, 7981.880271796043, 8132.6746930122135, 8319.83360332778, 45807.770961146314, 46413.3038004437, 47017.2947405796, 47377.52622473731, 49217.2617410732, 54111.188332174264, 59869.40130598638, 59958.40041599528, 60288.39711602828, 61475.0, 10632.154019128713, 10842.256385715253, 11305.15211359135, 11334.773304534028, 11767.176297659424, 11695.12286578493, 11975.28148311104, 11989.880101198876, 12054.216475929037, 12256.080793940311, 10900.781984360427, 10996.615118470816, 11372.829407559058, 11387.943060284646, 11506.0, 11210.719732006764, 11293.830592540955, 11375.829362559403, 11847.585334513251, 12275.079369047178, 10497.580096796042, 10796.17025725799, 10855.372743229154, 10914.945425272823, 10977.506012229629, 9024.899373770168, 9172.312076594415, 9252.95373523128, 9432.905670943202, 9549.28380371461, 8514.70198543048, 8593.226609605166, 8812.823743524965, 8949.507777072324, 9037.457752534869], "value": 6688.797871610243, "unit": "score"}], "name": "dromaeo_css", "value": 6966.303817605632, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 111.0, 112.0, 111.0, 112.0, 111.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 123.0, 156.0, 123.0, 124.0, 127.0, 121.0, 150.0, 122.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 163.0, 163.0, 163.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 114.0, 76.0, 77.0, 76.0, 75.0, 98.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 131.0, 84.0, 84.0, 83.0, 103.0, 82.0, 81.0, 124.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 79.0, 81.0, 79.0, 79.0, 80.0, 79.0, 85.0, 88.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 134.0, 129.0, 130.0, 137.0, 141.0, 145.0, 169.0, 126.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 169.0, 169.0, 168.0, 169.0, 166.0, 170.0, 167.0, 169.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1495.0, "alertThreshold": 2.0}]} 01:53:23 INFO - Return code: 0 01:53:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:53:23 INFO - # TBPL SUCCESS # 01:53:23 INFO - Running post-action listener: _resource_record_post_action 01:53:23 INFO - [mozharness: 2016-10-26 08:53:23.885548Z] Finished run-tests step (success) 01:53:23 INFO - Running post-run listener: _resource_record_post_run 01:53:23 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392171520; Read time: 20; Write time: 227104 01:53:23 INFO - TinderboxPrint: CPU usage
13.1% 01:53:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 01:53:23 INFO - TinderboxPrint: I/O write bytes / time
392,171,520 / 227,104 01:53:23 INFO - TinderboxPrint: CPU idle
8,305.0 (86.9%) 01:53:23 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 01:53:23 INFO - TinderboxPrint: Swap in / out
0 / 0 01:53:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103579648; Read time: 0; Write time: 69368 01:53:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288591872; Read time: 20; Write time: 157736 01:53:24 INFO - Running post-run listener: _upload_blobber_files 01:53:24 INFO - Blob upload gear active. 01:53:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:53: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 01:53: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:53: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:30 INFO - (blobuploader) - INFO - Done attempting. 01:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:31 INFO - (blobuploader) - INFO - Done attempting. 01:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:31 INFO - (blobuploader) - INFO - Done attempting. 01:53:31 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:31 INFO - Return code: 0 01:53:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4091cee83ddc0fc313594fab07ae932ba3172ca822ed7fcd2202a2669a2f5457eb46baba61fbe7cc974bab596f9e0bd1d8d54be3c3f7a2ef466df870d7609f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1482801c040eb2183da75570f16549fed5755e207b09c8dc517652a5d0217a900b1f1db8263076214ec7b19c49491f656c49d0e2cd16230e7752fe709ebdded1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20855b2cfee3eac80e47cad81fb13a3e58fe59da5b8a890371d52887a9cb5e9f9574bcce22372a7e280117da4ffefafc58cafbfdc21941942c1b8999c221eede"} 01:53:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:31 INFO - Contents: 01:53:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4091cee83ddc0fc313594fab07ae932ba3172ca822ed7fcd2202a2669a2f5457eb46baba61fbe7cc974bab596f9e0bd1d8d54be3c3f7a2ef466df870d7609f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1482801c040eb2183da75570f16549fed5755e207b09c8dc517652a5d0217a900b1f1db8263076214ec7b19c49491f656c49d0e2cd16230e7752fe709ebdded1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20855b2cfee3eac80e47cad81fb13a3e58fe59da5b8a890371d52887a9cb5e9f9574bcce22372a7e280117da4ffefafc58cafbfdc21941942c1b8999c221eede"} 01:53:31 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:31 INFO - Copying logs to upload dir... 01:53:31 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.848295 ========= master_lag: 0.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 01:53:32.570506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:53:32.577909) ========= 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=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4091cee83ddc0fc313594fab07ae932ba3172ca822ed7fcd2202a2669a2f5457eb46baba61fbe7cc974bab596f9e0bd1d8d54be3c3f7a2ef466df870d7609f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1482801c040eb2183da75570f16549fed5755e207b09c8dc517652a5d0217a900b1f1db8263076214ec7b19c49491f656c49d0e2cd16230e7752fe709ebdded1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20855b2cfee3eac80e47cad81fb13a3e58fe59da5b8a890371d52887a9cb5e9f9574bcce22372a7e280117da4ffefafc58cafbfdc21941942c1b8999c221eede"} build_url:https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010442 build_url: 'https://queue.taskcluster.net/v1/task/AJ7macTvRU6LQ73KeS5Srw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4091cee83ddc0fc313594fab07ae932ba3172ca822ed7fcd2202a2669a2f5457eb46baba61fbe7cc974bab596f9e0bd1d8d54be3c3f7a2ef466df870d7609f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1482801c040eb2183da75570f16549fed5755e207b09c8dc517652a5d0217a900b1f1db8263076214ec7b19c49491f656c49d0e2cd16230e7752fe709ebdded1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20855b2cfee3eac80e47cad81fb13a3e58fe59da5b8a890371d52887a9cb5e9f9574bcce22372a7e280117da4ffefafc58cafbfdc21941942c1b8999c221eede"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:53:32.608974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:53:32.609435) ========= 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=41a7e32711b8e08598a63237000001d6-1477470436.844181-1824253636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:53:32.659278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:53:32.662777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:53:32.663164) ========= ========= Total master_lag: 0.79 =========