builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1479744101.89 results: success (0) buildid: 20161121064510 builduid: d9f6c765ea43467db942f66ff8e0495b revision: 0534254e9a40b4bade2577c631fe4cfa0b5db41d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:41.886059) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:41.886507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:41.886815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:41.901676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:41.901983) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 08:01:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2016-11-21 08:01:42 (34.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:42.033066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:42.033336) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:42.084323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 08:01:42.084680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0534254e9a40b4bade2577c631fe4cfa0b5db41d --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 0534254e9a40b4bade2577c631fe4cfa0b5db41d --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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 08:01:42,931 truncating revision to first 12 chars 2016-11-21 08:01:42,931 Setting DEBUG logging. 2016-11-21 08:01:42,931 attempt 1/10 2016-11-21 08:01:42,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0534254e9a40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 08:01:43,916 unpacking tar archive at: mozilla-central-0534254e9a40/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300783 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 08:01:43.397858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:43.398274) ========= script_repo_revision: 0534254e9a40b4bade2577c631fe4cfa0b5db41d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:43.398701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:43.398958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 08:01:43.406330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-21 08:01:43.407141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:44 INFO - MultiFileLogger online at 20161121 08:01:44 in /builds/slave/test 08:01:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:01:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:44 INFO - {'append_to_log': False, 08:01:44 INFO - 'base_work_dir': '/builds/slave/test', 08:01:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:01:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:44 INFO - 'branch': 'Firefox-Non-PGO', 08:01:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:44 INFO - 'config_files': ('talos/linux_config.py',), 08:01:44 INFO - 'default_actions': ('clobber', 08:01:44 INFO - 'read-buildbot-config', 08:01:44 INFO - 'download-and-extract', 08:01:44 INFO - 'populate-webroot', 08:01:44 INFO - 'create-virtualenv', 08:01:44 INFO - 'install', 08:01:44 INFO - 'run-tests'), 08:01:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:44 INFO - 'download_minidump_stackwalk': True, 08:01:44 INFO - 'download_symbols': 'ondemand', 08:01:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:44 INFO - 'installer_path': 'installer.exe', 08:01:44 INFO - 'log_level': 'info', 08:01:44 INFO - 'log_name': 'talos', 08:01:44 INFO - 'log_to_console': True, 08:01:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:44 INFO - 'opt_config_files': (), 08:01:44 INFO - 'pip_index': False, 08:01:44 INFO - 'sps_profile': False, 08:01:44 INFO - 'sps_profile_interval': 0, 08:01:44 INFO - 'suite': 'dromaeojs', 08:01:44 INFO - 'system_bits': '32', 08:01:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:44 INFO - 'title': 'talos-linux64-ix-061', 08:01:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:44 INFO - 'use_talos_json': True, 08:01:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:44 INFO - 'work_dir': 'build'} 08:01:44 INFO - [mozharness: 2016-11-21 16:01:44.346421Z] Running clobber step. 08:01:44 INFO - Running pre-action listener: _resource_record_pre_action 08:01:44 INFO - Running main action method: clobber 08:01:44 INFO - rmtree: /builds/slave/test/build 08:01:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:45 INFO - Running post-action listener: _resource_record_post_action 08:01:45 INFO - [mozharness: 2016-11-21 16:01:45.331536Z] Finished clobber step (success) 08:01:45 INFO - [mozharness: 2016-11-21 16:01:45.331634Z] Running read-buildbot-config step. 08:01:45 INFO - Running pre-action listener: _resource_record_pre_action 08:01:45 INFO - Running main action method: read_buildbot_config 08:01:45 INFO - Using buildbot properties: 08:01:45 INFO - { 08:01:45 INFO - "project": "", 08:01:45 INFO - "product": "firefox", 08:01:45 INFO - "script_repo_revision": "production", 08:01:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:01:45 INFO - "repository": "", 08:01:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:01:45 INFO - "buildid": "20161121064510", 08:01:45 INFO - "pgo_build": "False", 08:01:45 INFO - "basedir": "/builds/slave/test", 08:01:45 INFO - "buildnumber": 827, 08:01:45 INFO - "slavename": "talos-linux64-ix-061", 08:01:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:01:45 INFO - "platform": "ubuntu64_hw", 08:01:45 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:01:45 INFO - "branch": "mozilla-central", 08:01:45 INFO - "repo_path": "mozilla-central", 08:01:45 INFO - "revision": "0534254e9a40b4bade2577c631fe4cfa0b5db41d", 08:01:45 INFO - "stage_platform": "linux64", 08:01:45 INFO - "builduid": "d9f6c765ea43467db942f66ff8e0495b", 08:01:45 INFO - "slavebuilddir": "test" 08:01:45 INFO - } 08:01:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:01:45 INFO - Running post-action listener: _resource_record_post_action 08:01:45 INFO - [mozharness: 2016-11-21 16:01:45.334075Z] Finished read-buildbot-config step (success) 08:01:45 INFO - [mozharness: 2016-11-21 16:01:45.334163Z] Running download-and-extract step. 08:01:45 INFO - Running pre-action listener: _resource_record_pre_action 08:01:45 INFO - Running main action method: download_and_extract 08:01:45 INFO - mkdir: /builds/slave/test/build/tests 08:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:45 INFO - trying https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:01:45 INFO - Downloading https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:01:45 INFO - Downloaded 1361 bytes. 08:01:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:01:45 INFO - Using the following test package requirements: 08:01:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'jsshell-linux-x86_64.zip'], 08:01:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:01:46 INFO - Http code: 200 08:01:46 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 08:01:46 INFO - x-amz-cf-id: Wer5KQ4Y7mfG-761tT3rmwPd4bjUmrbBP98sO8itSKTfOEr8HuZRng== 08:01:46 INFO - x-amz-version-id: WmVNf87RVk2P_XyWIKdIHQcBC0Ubn3hT 08:01:46 INFO - Expected file size: 20327536 08:01:46 INFO - Obtained file size: 20327536 08:01:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:01:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:01:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:01:50 INFO - Fetch https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:01:51 INFO - Http code: 200 08:01:51 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 08:01:51 INFO - x-amz-cf-id: 03nHgtPrOP08k0J9LbXAiUF0VXprEt277Icw4ucW7wOt-70cC8LyPg== 08:01:51 INFO - x-amz-version-id: WmVNf87RVk2P_XyWIKdIHQcBC0Ubn3hT 08:01:51 INFO - Expected file size: 20327536 08:01:51 INFO - Obtained file size: 20327536 08:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:01:56 INFO - Http code: 200 08:01:56 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:01:56 INFO - x-amz-cf-id: xZbSnt-BOrH5ZZyC4Qm3kNl7l9ou6HmrPScqaITte9s-2Z3CTgsP6A== 08:01:56 INFO - x-amz-version-id: ZJy3HR33pakaZ84XIrbPZJ_8BwhaHOaW 08:01:57 INFO - Expected file size: 14409392 08:01:57 INFO - Obtained file size: 14409392 08:01:57 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')]} 08:01:57 INFO - trying https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:01:57 INFO - Downloading https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:01:58 INFO - Downloaded 55380278 bytes. 08:01:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:01:58 INFO - mkdir: /builds/slave/test/properties 08:01:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:01:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:01:58 INFO - Contents: 08:01:58 INFO - build_url:https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:01:59 INFO - Running post-action listener: _resource_record_post_action 08:01:59 INFO - Running post-action listener: set_extra_try_arguments 08:01:59 INFO - [mozharness: 2016-11-21 16:01:59.115371Z] Finished download-and-extract step (success) 08:01:59 INFO - [mozharness: 2016-11-21 16:01:59.115597Z] Running populate-webroot step. 08:01:59 INFO - Running pre-action listener: _resource_record_pre_action 08:01:59 INFO - Running main action method: populate_webroot 08:01:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:59 INFO - '--tppagecycles', 08:01:59 INFO - '7'], 08:01:59 INFO - 'tests': ['tsvgm']}}, 08:01:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['damp', 'tps']}, 08:01:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'tests': ['damp', 'tps']}, 08:01:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['dromaeo_dom']}, 08:01:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['basic_compositor_video']}, 08:01:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:01:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['a11yr', 08:01:59 INFO - 'ts_paint', 08:01:59 INFO - 'tpaint', 08:01:59 INFO - 'sessionrestore', 08:01:59 INFO - 'sessionrestore_no_auto_restore', 08:01:59 INFO - 'tabpaint']}, 08:01:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['tsvgx', 08:01:59 INFO - 'tsvgr_opacity', 08:01:59 INFO - 'tart', 08:01:59 INFO - 'tscrollx', 08:01:59 INFO - 'cart']}, 08:01:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:59 INFO - 'tsvgr_opacity', 08:01:59 INFO - 'tart', 08:01:59 INFO - 'tscrollx', 08:01:59 INFO - 'cart']}, 08:01:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'talos_options': ['--disable-e10s'], 08:01:59 INFO - 'tests': ['tp5o']}, 08:01:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:01:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'talos_options': ['--disable-e10s', 08:01:59 INFO - '--xperf_path', 08:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:59 INFO - 'tests': ['tp5n']}, 08:01:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:01:59 INFO - 'talos_options': ['--xperf_path', 08:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:59 INFO - 'tests': ['tp5n']}}, 08:01:59 INFO - 'talos.zip': {'path': '', 08:01:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:59 INFO - Running post-action listener: _resource_record_post_action 08:01:59 INFO - [mozharness: 2016-11-21 16:01:59.134957Z] Finished populate-webroot step (success) 08:01:59 INFO - [mozharness: 2016-11-21 16:01:59.135045Z] Running create-virtualenv step. 08:01:59 INFO - Running pre-action listener: _resource_record_pre_action 08:01:59 INFO - Running main action method: create_virtualenv 08:01:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:59 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 08:01:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:59 INFO - Using real prefix '/usr' 08:01:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:01 INFO - Installing pip.................done. 08:02:01 INFO - Return code: 0 08:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:01 INFO - Reading from file tmpfile_stdout 08:02:01 INFO - Output received: 08:02:01 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) 08:02:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:01 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')]} 08:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:01 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')]} 08:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:01 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:01 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 08:02:01 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 08:02:01 INFO - Using env: {'DISPLAY': ':0', 08:02:01 INFO - 'HOME': '/home/cltbld', 08:02:01 INFO - 'LANG': 'en_US.UTF-8', 08:02:01 INFO - 'LANGUAGE': 'en_US:en', 08:02:01 INFO - 'LOGNAME': 'cltbld', 08:02:01 INFO - 'MAIL': '/var/mail/cltbld', 08:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:01 INFO - 'MOZ_NO_REMOTE': '1', 08:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:01 INFO - 'NO_EM_RESTART': '1', 08:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:01 INFO - 'PWD': '/builds/slave/test', 08:02:01 INFO - 'SHELL': '/bin/bash', 08:02:01 INFO - 'SHLVL': '1', 08:02:01 INFO - 'TERM': 'linux', 08:02:01 INFO - 'TMOUT': '86400', 08:02:01 INFO - 'USER': 'cltbld', 08:02:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:01 INFO - '_': '/tools/buildbot/bin/python'} 08:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:02 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 08:02:02 INFO - Cleaning up... 08:02:02 INFO - Return code: 0 08:02:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:02 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')]} 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 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')]} 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:02 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 08:02:02 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 08:02:02 INFO - Using env: {'DISPLAY': ':0', 08:02:02 INFO - 'HOME': '/home/cltbld', 08:02:02 INFO - 'LANG': 'en_US.UTF-8', 08:02:02 INFO - 'LANGUAGE': 'en_US:en', 08:02:02 INFO - 'LOGNAME': 'cltbld', 08:02:02 INFO - 'MAIL': '/var/mail/cltbld', 08:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:02 INFO - 'MOZ_NO_REMOTE': '1', 08:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:02 INFO - 'NO_EM_RESTART': '1', 08:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:02 INFO - 'PWD': '/builds/slave/test', 08:02:02 INFO - 'SHELL': '/bin/bash', 08:02:02 INFO - 'SHLVL': '1', 08:02:02 INFO - 'TERM': 'linux', 08:02:02 INFO - 'TMOUT': '86400', 08:02:02 INFO - 'USER': 'cltbld', 08:02:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:02 INFO - '_': '/tools/buildbot/bin/python'} 08:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:02 INFO - Downloading/unpacking psutil>=3.1.1 08:02:02 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 08:02:02 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 08:02:02 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 08:02:02 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 08:02:02 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 08:02:02 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 08:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:04 INFO - Installing collected packages: psutil 08:02:04 INFO - Running setup.py install for psutil 08:02:04 INFO - building 'psutil._psutil_linux' extension 08:02:04 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 08:02:04 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 08:02:04 INFO - building 'psutil._psutil_posix' extension 08:02:04 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 08:02:04 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 08:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:04 INFO - Successfully installed psutil 08:02:04 INFO - Cleaning up... 08:02:04 INFO - Return code: 0 08:02:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:04 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')]} 08:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:04 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')]} 08:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:04 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:04 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 08:02:04 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 08:02:04 INFO - Using env: {'DISPLAY': ':0', 08:02:04 INFO - 'HOME': '/home/cltbld', 08:02:04 INFO - 'LANG': 'en_US.UTF-8', 08:02:04 INFO - 'LANGUAGE': 'en_US:en', 08:02:04 INFO - 'LOGNAME': 'cltbld', 08:02:04 INFO - 'MAIL': '/var/mail/cltbld', 08:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:04 INFO - 'MOZ_NO_REMOTE': '1', 08:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:04 INFO - 'NO_EM_RESTART': '1', 08:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:04 INFO - 'PWD': '/builds/slave/test', 08:02:04 INFO - 'SHELL': '/bin/bash', 08:02:04 INFO - 'SHLVL': '1', 08:02:04 INFO - 'TERM': 'linux', 08:02:04 INFO - 'TMOUT': '86400', 08:02:04 INFO - 'USER': 'cltbld', 08:02:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:04 INFO - '_': '/tools/buildbot/bin/python'} 08:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:05 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 08:02:05 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 08:02:05 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 08:02:05 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 08:02:05 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 08:02:05 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 08:02:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:07 INFO - Installing collected packages: mozsystemmonitor 08:02:07 INFO - Running setup.py install for mozsystemmonitor 08:02:07 INFO - Successfully installed mozsystemmonitor 08:02:07 INFO - Cleaning up... 08:02:07 INFO - Return code: 0 08:02:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:07 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')]} 08:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:07 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')]} 08:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:07 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:07 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 08:02:07 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 08:02:07 INFO - Using env: {'DISPLAY': ':0', 08:02:07 INFO - 'HOME': '/home/cltbld', 08:02:07 INFO - 'LANG': 'en_US.UTF-8', 08:02:07 INFO - 'LANGUAGE': 'en_US:en', 08:02:07 INFO - 'LOGNAME': 'cltbld', 08:02:07 INFO - 'MAIL': '/var/mail/cltbld', 08:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:07 INFO - 'MOZ_NO_REMOTE': '1', 08:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:07 INFO - 'NO_EM_RESTART': '1', 08:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:07 INFO - 'PWD': '/builds/slave/test', 08:02:07 INFO - 'SHELL': '/bin/bash', 08:02:07 INFO - 'SHLVL': '1', 08:02:07 INFO - 'TERM': 'linux', 08:02:07 INFO - 'TMOUT': '86400', 08:02:07 INFO - 'USER': 'cltbld', 08:02:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:07 INFO - '_': '/tools/buildbot/bin/python'} 08:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:07 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:07 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 08:02:07 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 08:02:07 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 08:02:07 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 08:02:07 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 08:02:07 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 08:02:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 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 08:02:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:40 INFO - warning: no files found matching '*.txt' 08:02:40 INFO - no previously-included directories found matching 'build' 08:02:40 INFO - no previously-included directories found matching 'dist' 08:02:40 INFO - no previously-included directories found matching '.git*' 08:02:40 INFO - Installing collected packages: jsonschema, functools32 08:02:40 INFO - Running setup.py install for functools32 08:02:40 INFO - warning: no files found matching '*.txt' 08:02:40 INFO - no previously-included directories found matching 'build' 08:02:40 INFO - no previously-included directories found matching 'dist' 08:02:40 INFO - no previously-included directories found matching '.git*' 08:02:40 INFO - Successfully installed jsonschema functools32 08:02:40 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02:41 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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:41 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 08:02:41 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 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02:41 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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:41 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 08:02:41 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 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:41 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 08:02:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:44 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 08:02:44 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 08:02:44 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 08:02:44 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 08:02:44 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 08:02:44 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 08:02:44 INFO - Downloading docopt-0.6.1.tar.gz 08:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:44 INFO - Running setup.py install for blobuploader 08:02:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:44 INFO - Running setup.py install for requests 08:02:44 INFO - Running setup.py install for docopt 08:02:45 INFO - Successfully installed blobuploader requests docopt 08:02:45 INFO - Cleaning up... 08:02:45 INFO - Return code: 0 08:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:45 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:45 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 08:02:45 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 08:02:45 INFO - Using env: {'DISPLAY': ':0', 08:02:45 INFO - 'HOME': '/home/cltbld', 08:02:45 INFO - 'LANG': 'en_US.UTF-8', 08:02:45 INFO - 'LANGUAGE': 'en_US:en', 08:02:45 INFO - 'LOGNAME': 'cltbld', 08:02:45 INFO - 'MAIL': '/var/mail/cltbld', 08:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:45 INFO - 'MOZ_NO_REMOTE': '1', 08:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:45 INFO - 'NO_EM_RESTART': '1', 08:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:45 INFO - 'PWD': '/builds/slave/test', 08:02:45 INFO - 'SHELL': '/bin/bash', 08:02:45 INFO - 'SHLVL': '1', 08:02:45 INFO - 'TERM': 'linux', 08:02:45 INFO - 'TMOUT': '86400', 08:02:45 INFO - 'USER': 'cltbld', 08:02:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:45 INFO - '_': '/tools/buildbot/bin/python'} 08:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:45 INFO - Running setup.py (path:/tmp/pip-dYUYNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:45 INFO - Running setup.py (path:/tmp/pip-0X1Whi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:45 INFO - Running setup.py (path:/tmp/pip-amw7R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:45 INFO - Running setup.py (path:/tmp/pip-E2KE4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:45 INFO - Running setup.py (path:/tmp/pip-etZgmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:45 INFO - Running setup.py (path:/tmp/pip-to0teZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:45 INFO - Running setup.py (path:/tmp/pip-7j83Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:45 INFO - Running setup.py (path:/tmp/pip-eDZlYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:45 INFO - Running setup.py (path:/tmp/pip-xg9izg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:45 INFO - Running setup.py (path:/tmp/pip-c08Amz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:46 INFO - Running setup.py (path:/tmp/pip-3RWaUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:46 INFO - Running setup.py (path:/tmp/pip-XzY2PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:46 INFO - Running setup.py (path:/tmp/pip-tp_qTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:46 INFO - Running setup.py (path:/tmp/pip-JpVDCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:46 INFO - Running setup.py (path:/tmp/pip-PPyWkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:46 INFO - Running setup.py (path:/tmp/pip-DNPEfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:46 INFO - Running setup.py (path:/tmp/pip-wT8Ou1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:46 INFO - Running setup.py install for manifestparser 08:02:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:46 INFO - Running setup.py install for mozcrash 08:02:46 INFO - Running setup.py install for mozdebug 08:02:46 INFO - Running setup.py install for mozdevice 08:02:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:46 INFO - Running setup.py install for mozfile 08:02:47 INFO - Running setup.py install for mozhttpd 08:02:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for mozinfo 08:02:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for mozInstall 08:02:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for mozleak 08:02:47 INFO - Running setup.py install for mozlog 08:02:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for moznetwork 08:02:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for mozprocess 08:02:47 INFO - Running setup.py install for mozprofile 08:02:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:47 INFO - Running setup.py install for mozrunner 08:02:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:48 INFO - Running setup.py install for mozscreenshot 08:02:48 INFO - Running setup.py install for moztest 08:02:48 INFO - Running setup.py install for mozversion 08:02:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:48 INFO - Cleaning up... 08:02:48 INFO - Return code: 0 08:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:48 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')]} 08:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 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')]} 08:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:48 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 08:02:48 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 08:02:48 INFO - Using env: {'DISPLAY': ':0', 08:02:48 INFO - 'HOME': '/home/cltbld', 08:02:48 INFO - 'LANG': 'en_US.UTF-8', 08:02:48 INFO - 'LANGUAGE': 'en_US:en', 08:02:48 INFO - 'LOGNAME': 'cltbld', 08:02:48 INFO - 'MAIL': '/var/mail/cltbld', 08:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:48 INFO - 'MOZ_NO_REMOTE': '1', 08:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:48 INFO - 'NO_EM_RESTART': '1', 08:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:48 INFO - 'PWD': '/builds/slave/test', 08:02:48 INFO - 'SHELL': '/bin/bash', 08:02:48 INFO - 'SHLVL': '1', 08:02:48 INFO - 'TERM': 'linux', 08:02:48 INFO - 'TMOUT': '86400', 08:02:48 INFO - 'USER': 'cltbld', 08:02:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:48 INFO - '_': '/tools/buildbot/bin/python'} 08:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:48 INFO - Running setup.py (path:/tmp/pip-fF1hNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:48 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)) 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:48 INFO - Running setup.py (path:/tmp/pip-1TVx1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:48 INFO - Running setup.py (path:/tmp/pip-gbVki2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:48 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)) 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:48 INFO - Running setup.py (path:/tmp/pip-qkioHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:48 INFO - Running setup.py (path:/tmp/pip-aQ9AbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:48 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)) 08:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:48 INFO - Running setup.py (path:/tmp/pip-kPnJgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:49 INFO - Running setup.py (path:/tmp/pip-HESk9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:49 INFO - Running setup.py (path:/tmp/pip-0i5EvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:49 INFO - Running setup.py (path:/tmp/pip-hlqryw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:49 INFO - Running setup.py (path:/tmp/pip-bWY5rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:49 INFO - Running setup.py (path:/tmp/pip-RlyrGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:49 INFO - Running setup.py (path:/tmp/pip-esbXf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:49 INFO - Running setup.py (path:/tmp/pip-Xy9ECC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:49 INFO - Running setup.py (path:/tmp/pip-GEXLSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:49 INFO - Running setup.py (path:/tmp/pip-oSOsoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:49 INFO - Running setup.py (path:/tmp/pip-9fLy0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:49 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)) 08:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:49 INFO - Running setup.py (path:/tmp/pip-MEZjhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:49 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)) 08:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:49 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)) 08:02:49 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:49 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:02:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:49 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 08:02:49 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 08:02:49 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 08:02:49 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 08:02:49 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 08:02:49 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 08:02:51 INFO - Downloading blessings-1.6.tar.gz 08:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:51 INFO - Installing collected packages: blessings 08:02:51 INFO - Running setup.py install for blessings 08:02:51 INFO - Successfully installed blessings 08:02:51 INFO - Cleaning up... 08:02:52 INFO - Return code: 0 08:02:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:52 INFO - Reading from file tmpfile_stdout 08:02:52 INFO - Current package versions: 08:02:52 INFO - argparse == 1.2.1 08:02:52 INFO - blessings == 1.6 08:02:52 INFO - blobuploader == 1.2.4 08:02:52 INFO - docopt == 0.6.1 08:02:52 INFO - functools32 == 3.2.3-2 08:02:52 INFO - jsonschema == 2.5.1 08:02:52 INFO - manifestparser == 1.1 08:02:52 INFO - mozInstall == 1.12 08:02:52 INFO - mozcrash == 1.0 08:02:52 INFO - mozdebug == 0.1 08:02:52 INFO - mozdevice == 0.49 08:02:52 INFO - mozfile == 1.2 08:02:52 INFO - mozhttpd == 0.7 08:02:52 INFO - mozinfo == 0.9 08:02:52 INFO - mozleak == 0.1 08:02:52 INFO - mozlog == 3.4 08:02:52 INFO - moznetwork == 0.27 08:02:52 INFO - mozprocess == 0.23 08:02:52 INFO - mozprofile == 0.28 08:02:52 INFO - mozrunner == 6.13 08:02:52 INFO - mozscreenshot == 0.1 08:02:52 INFO - mozsystemmonitor == 0.3 08:02:52 INFO - moztest == 0.7 08:02:52 INFO - mozversion == 1.4 08:02:52 INFO - psutil == 3.1.1 08:02:52 INFO - requests == 1.2.3 08:02:52 INFO - wsgiref == 0.1.2 08:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:52 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')]} 08:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 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')]} 08:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:52 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 08:02:52 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 08:02:52 INFO - Using env: {'DISPLAY': ':0', 08:02:52 INFO - 'HOME': '/home/cltbld', 08:02:52 INFO - 'LANG': 'en_US.UTF-8', 08:02:52 INFO - 'LANGUAGE': 'en_US:en', 08:02:52 INFO - 'LOGNAME': 'cltbld', 08:02:52 INFO - 'MAIL': '/var/mail/cltbld', 08:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:52 INFO - 'MOZ_NO_REMOTE': '1', 08:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:52 INFO - 'NO_EM_RESTART': '1', 08:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:52 INFO - 'PWD': '/builds/slave/test', 08:02:52 INFO - 'SHELL': '/bin/bash', 08:02:52 INFO - 'SHLVL': '1', 08:02:52 INFO - 'TERM': 'linux', 08:02:52 INFO - 'TMOUT': '86400', 08:02:52 INFO - 'USER': 'cltbld', 08:02:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:52 INFO - '_': '/tools/buildbot/bin/python'} 08:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 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)) 08:02:52 INFO - Cleaning up... 08:02:52 INFO - Return code: 0 08:02:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:52 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')]} 08:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 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')]} 08:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 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 0x7fcd05e74e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', '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 08:02:52 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 08:02:52 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 08:02:52 INFO - Using env: {'DISPLAY': ':0', 08:02:52 INFO - 'HOME': '/home/cltbld', 08:02:52 INFO - 'LANG': 'en_US.UTF-8', 08:02:52 INFO - 'LANGUAGE': 'en_US:en', 08:02:52 INFO - 'LOGNAME': 'cltbld', 08:02:52 INFO - 'MAIL': '/var/mail/cltbld', 08:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:52 INFO - 'MOZ_NO_REMOTE': '1', 08:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:52 INFO - 'NO_EM_RESTART': '1', 08:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:52 INFO - 'PWD': '/builds/slave/test', 08:02:52 INFO - 'SHELL': '/bin/bash', 08:02:52 INFO - 'SHLVL': '1', 08:02:52 INFO - 'TERM': 'linux', 08:02:52 INFO - 'TMOUT': '86400', 08:02:52 INFO - 'USER': 'cltbld', 08:02:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:52 INFO - '_': '/tools/buildbot/bin/python'} 08:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:52 INFO - Cleaning up... 08:02:52 INFO - Return code: 0 08:02:52 INFO - Running post-action listener: _resource_record_post_action 08:02:52 INFO - Running post-action listener: _start_resource_monitoring 08:02:52 INFO - Starting resource monitoring. 08:02:52 INFO - [mozharness: 2016-11-21 16:02:52.746827Z] Finished create-virtualenv step (success) 08:02:52 INFO - [mozharness: 2016-11-21 16:02:52.747303Z] Running install step. 08:02:52 INFO - Running pre-action listener: _resource_record_pre_action 08:02:52 INFO - Running main action method: install 08:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:52 INFO - Reading from file tmpfile_stdout 08:02:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:53 INFO - Reading from file tmpfile_stdout 08:02:53 INFO - Output received: 08:02:53 INFO - Usage: mozinstall [options] installer 08:02:53 INFO - Options: 08:02:53 INFO - -h, --help show this help message and exit 08:02:53 INFO - -d DEST, --destination=DEST 08:02:53 INFO - Directory to install application into. [default: 08:02:53 INFO - "/builds/slave/test"] 08:02:53 INFO - --app=APP Application being installed. [default: firefox] 08:02:53 INFO - mkdir: /builds/slave/test/build/application 08:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:03:09 INFO - Reading from file tmpfile_stdout 08:03:09 INFO - Output received: 08:03:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:03:09 INFO - Running post-action listener: _resource_record_post_action 08:03:09 INFO - [mozharness: 2016-11-21 16:03:09.034255Z] Finished install step (success) 08:03:09 INFO - [mozharness: 2016-11-21 16:03:09.034495Z] Running run-tests step. 08:03:09 INFO - Running pre-action listener: _resource_record_pre_action 08:03:09 INFO - Running main action method: run_tests 08:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:09 INFO - Python 2.7.3 08:03:09 INFO - Return code: 0 08:03:09 INFO - grabbing minidump binary from tooltool 08:03:09 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')]} 08:03:09 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 0x1305fc0>, '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 0x1306ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:09 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 08:03:09 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 08:03:09 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 08:03:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:09 INFO - Return code: 0 08:03:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:03:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:03:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 08:03:09 INFO - Using env: {'DISPLAY': ':0', 08:03:09 INFO - 'HOME': '/home/cltbld', 08:03:09 INFO - 'LANG': 'en_US.UTF-8', 08:03:09 INFO - 'LANGUAGE': 'en_US:en', 08:03:09 INFO - 'LOGNAME': 'cltbld', 08:03:09 INFO - 'MAIL': '/var/mail/cltbld', 08:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:09 INFO - 'MOZ_NO_REMOTE': '1', 08:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:09 INFO - 'NO_EM_RESTART': '1', 08:03:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:09 INFO - 'PWD': '/builds/slave/test', 08:03:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:09 INFO - 'SHELL': '/bin/bash', 08:03:09 INFO - 'SHLVL': '1', 08:03:09 INFO - 'TERM': 'linux', 08:03:09 INFO - 'TMOUT': '86400', 08:03:09 INFO - 'USER': 'cltbld', 08:03:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759', 08:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:09 INFO - '_': '/tools/buildbot/bin/python'} 08:03:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:03:09 INFO - mozversion application_buildid: 20161121064510 08:03:09 INFO - mozversion application_changeset: 0534254e9a40b4bade2577c631fe4cfa0b5db41d 08:03:09 INFO - mozversion application_display_name: Nightly 08:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:09 INFO - mozversion application_name: Firefox 08:03:09 INFO - mozversion application_remotingname: firefox 08:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:03:09 INFO - mozversion application_vendor: Mozilla 08:03:09 INFO - mozversion application_version: 53.0a1 08:03:09 INFO - mozversion platform_buildid: 20161121064510 08:03:09 INFO - mozversion platform_changeset: 0534254e9a40b4bade2577c631fe4cfa0b5db41d 08:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:03:09 INFO - mozversion platform_version: 53.0a1 08:03:09 INFO - using testdate: 1479744189 08:03:09 INFO - actual date: 1479744189 08:03:09 INFO - starting webserver on 'localhost:40571' 08:03:09 INFO - SUITE-START | Running 2 tests 08:03:09 INFO - TEST-START | dromaeo_css 08:03:09 INFO - operating with platform_type : linux_ 08:03:09 INFO - Initialising browser for dromaeo_css test... 08:03:09 INFO - TEST-INFO | started process 31034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGUsdUv/profile http://localhost:40571/getInfo.html) 08:03:13 INFO - PROCESS | 31034 | __metrics Screen width/height:1600/1200 08:03:13 INFO - PROCESS | 31034 | colorDepth:24 08:03:13 INFO - PROCESS | 31034 | Browser inner width/height: 1024/697 08:03:13 INFO - PROCESS | 31034 | __metrics 08:03:14 INFO - PROCESS | 31034 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:03:14 INFO - PROCESS | 31034 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:15 INFO - PROCESS | 31034 | console.error: PushService: 08:03:15 INFO - PROCESS | 31034 | stateChangeProcessEnqueue: Error transitioning state 08:03:15 INFO - PROCESS | 31034 | UnknownError 08:03:15 INFO - TEST-INFO | 31034: exit 0 08:03:15 INFO - Browser initialized. 08:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:16 INFO - TEST-INFO | started process 31116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGUsdUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:28 INFO - PROCESS | 31116 | RSS: Main: 174792704 08:03:28 INFO - PROCESS | 31116 | 08:04:19 INFO - PROCESS | 31116 | 1479744259855 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] 08:06:33 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40571/tests/dromaeo/cssquery-ext.html) 08:06:35 INFO - PROCESS | 31116 | RSS: Main: 330817536 08:06:35 INFO - PROCESS | 31116 | 08:09:38 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-ext.html (next: http://localhost:40571/tests/dromaeo/cssquery-jquery.html) 08:09:38 INFO - PROCESS | 31116 | RSS: Main: 285388800 08:09:38 INFO - PROCESS | 31116 | 08:12:40 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40571/tests/dromaeo/cssquery-mootools.html) 08:12:41 INFO - PROCESS | 31116 | RSS: Main: 237355008 08:12:41 INFO - PROCESS | 31116 | 08:15:43 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40571/tests/dromaeo/cssquery-prototype.html) 08:15:44 INFO - PROCESS | 31116 | RSS: Main: 223477760 08:15:44 INFO - PROCESS | 31116 | 08:18:47 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40571/tests/dromaeo/cssquery-yui.html) 08:18:48 INFO - PROCESS | 31116 | RSS: Main: 222674944 08:18:48 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | Cycle 1(1): loaded http://localhost:40571/tests/dromaeo/cssquery-yui.html (next: http://localhost:40571/tests/dromaeo/cssquery-dojo.html) 08:21:51 INFO - PROCESS | 31116 | RSS: Main: 305721344 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | __start_tp_report 08:21:51 INFO - PROCESS | 31116 | _x_x_mozilla_page_load 08:21:51 INFO - PROCESS | 31116 | _x_x_mozilla_page_load_details 08:21:51 INFO - PROCESS | 31116 | |i|pagename|runs| 08:21:51 INFO - PROCESS | 31116 | |0;dojo.html;2540.199837051329;2557.7186509483963;2579.896804127835;2594.571895637219;2596.7143614202446;4510.639148868091;4552.749598772066;4573.725576465415;4581.587657110859;4582.129395414869;4592.540745925406;4612.607928326096;4622.375979242801;4626.236670949289;4630.768461576916;4210.663146948252;4237.4915010198665;4249.46881639795;4257.510386305568;4280.743155410685;4314.978425107885;4324.524302326741;4344.78276086196;4351.042770590465;4352.782360881959;4272.060146767706;4307.396964424983;4320.1575692739925;4336.913261734763;4354.629856462205;4374.737515749065;4381.452318460192;4390.407295015164;4396.384506169139;4398.120375924827;4129.525104612948;4129.545749967501;4182.059036716745;4300.569943005706;4304.268274393361;4528.43394575678;4535.501094879561;4543.477500087466;4585.9681571646115;4603.148417542765;4926.11329960607;4927.162382395001;4935.925961110586;4948.010397920394;5005.849824505271;4817.229243321087;4870;4874.634402419832;4965.255211718235;4977.129002424561;4616.538346165356;4629.675922685447;4648.883777905579;4658.324542941255;4699.718016918996;5067.619928505377;5074.67014644047;5075.71592783249;5077.339945807095;5122.359705036871;4657.906841863144;4865.099956508057;4887.095887260797;4891.51084891508;4941.703497790144;4811.182099043171;4889.413270407574;4895.926561101586;4900.289458028566;4901.950980490221;4877.512248775094;4878.365812444359;4883.633727470454;4917.532834380728;4924.60603151747;4841.055994081191;4853.199222128309;4858.149823780825;4869.853904382803;4891.608671306287;4012.879613611596;4014.0767623446773;4042.0501182222156;4052.8986775330854;4067.89830254246;3630.6006339302658;3635.9091022724115;3662.432322989941;3673.1918977824835;3674.8346324415465;4285.550017248144;4301.075268817157;4308.849190278325;4310.030243195319;4355.912881742347;4872.074305881871;4936.629752768485;4941.629377796679;4943.777530011158;5002.824901128443;4315.115401342718;4321.827126914951;4323.7621930793475;4328.9394098445455;4337.154254920323;4413.492448368414;4452.154090722753;4458.175237581057;4460.576245256695;4464.464264288241;4683.414573178353;4687.414073240845;4688.2030054890065;4695.22528782747;4698.835540756126;4917.508249175054;4960.429550601727;4966.230234313687;4969.900601988013;4978.950210497848;4716.457607375196;4716.976415117902;4717.952820471752;4746.43042834862;4760.238361862085;4931.334269873521;4931.753412329441;4933.605311574994;4935.136351138464;4936.111499930047;4675.696079754805;4763.761811909321;4812.759362031955;5002.249662550501;5041.319421878;4728.1252968199615;4728.976355118202;4746.7389293589185;4780.330753694555;4784.808607655655;4745.477997420212;4746.43042834862;4752.382190315237;4757.167495688172;4757.429108507002;4610.423697037871;4627.67606267558;4661.463931647904;4687.343771872009;4736.50266722003;4735.455422626442;4758.452777930583;4816.964352664194;4825.662203645711;4828.324034635084;4692.460367057832;4703.835365762318;4712.740799256074;4717.599004084691;4723.574878260973 08:21:51 INFO - PROCESS | 31116 | |1;ext.html;532.8774381892165;558.3132746721533;564.32281262485;586.2027642406326;588.6703446070204;27047.5942860857;29902.551461728093;38305.23389532211;38879.222415551674;39029.804850975706;37876.24247515048;38307.80846095773;38315.233695326075;38315.233695326075;38365.808170959106;7477.700891964329;7623.23767623236;7629.1989341119215;7631.427642926803;7635.961820190892;7391.963040184792;7595.126560445564;9607.423554586712;9839.754006149831;9856.359336643096;9934.403935763841;9983.800323993515;9986.700398988041;9987.300888937778;10010.249231307645;9783.0706082922;9787.510624468783;9830.852537211947;9843.163331116864;9856.655017074403;9761.560729767178;9821.459819709913;9828.115469607697;9828.803423931553;9832.606695732162;36079.4588081179;36462.08844778875;36485.817570912244;36512.81743591265;36545.45181822275;2824.378636699923;2871.2104171352835;2884.307766136133;3037.271054946797;3182.7612929030415;27575.72424275772;27846.721532784817;27927.441451171067;27927.86036069827;28644.283892902637;3436.4501679731125;3500.9025764454836;3503.1067077894972;3503.948815355383;3534.1341371363924;223129;223612;223877;224293.59889615467;225015;48880.511194888306;49285.507144928095;49399.25901111486;49416.752916235186;49621.50378496241;30963.69036309608;31886.521702174487;31961;33669.49495757517;33723;13141.474341026444;13142.080054396292;13150.21098734079;13294.800577991338;13297.534586289434;9318.114779095975;9733.270004749673;9956.701298961043;9972.750681232883;10023.2482563808;14700.852991469948;16779.916100419665;17233.482995510156;17360.479185624452;18102.45692629223;6484.286728459866;6539.790138824237;6632.933670663231;6694.196696396463;6740.595564266159;750.9586972716553;810.9310708589836;892.7187935800332;895.8521843895684;924.8381533231658;24901;26291.342716432242;26712.866435668086;26791.196264112106;26885.731142688324;932.0120672087609;940.3229674634252;972.7908499672462;990.762217067913;1018.149844879519;13391.732165356638;14202.431902723776;14283.928580357031;14533.27333633314;14593.562193134223;338357;338988;339846;340598;344588;45206.547934520895;45572;45600;45703.91589303663;45753;1040.573364920379;1052.3896140238644;1092.7432053467428;1149.8850114988434;1177.3524561490974;25384;26607;26993.46013079688;27323;27648.861755691094;38536.42195367016;39432.211355773296;39518.47945089143;39532;39532.80233598928;269070;269785;269982;270824;353714;32249.51625725663;34715.652843471245;34839.30321393609;34987;35126;38296.61703383042;38467;38541.42187867128;38652.226955461294;39200;33540.49689254614;33985;34226.82886585551;34258.31483370269;34667.30665386729;33603.32793344168;33691.49462758011;33846.66153338435;33980;34806.65193348034;33535.83232083922;33917.66082339145;34242.82878585591;34429.48355774715;34704.479432809036;28451.167510659852;31043.689563104985;31171.688283116877;33552.49671254884;33866.153346166546;23677.408064798517;23715.762842372045;24057.759422406252;24411.51176976486;24453.38866528351 08:21:51 INFO - PROCESS | 31116 | |2;jquery.html;327.255493751715;331.1489472056815;345.77351834548364;353.3904015573137;366.3533862732278;12620.24278543288;13676.863231367695;15762.211889405527;16046.518604441857;16910.66178676429;14585.489507867227;14771;15026.774598381033;16278.26747796349;16422.17889105546;4849.951500484985;4906.362172917516;5090.338256026711;5096.923546146811;5100.77046532905;5027.371578552681;5065.037642847866;5075.923861142067;5094.490550944913;5119.283300337937;5079.415867175285;5080.390353157608;5082.186850103984;5085.262636917645;5085.644004919657;4864.246041863499;5022.723750193738;5055.216441451563;5055.292259083732;5057.848264552069;4500.752458614775;4504.977475112603;4507.864764057051;4518.864434066983;4519.751413672247;20100.386949696447;20220.090095945718;20331.491712707302;20362;20492.5901481971;1645.2020769926576;1753.579141006162;1793.1841012339355;1838.6874231380698;1859.460756380648;8521.744347669579;8576.871346929802;8657.220850123456;9106.225970792491;9112.088791120901;1604.767308740226;1647.744599587066;1691.9323227070902;1692.4668729350337;1748.7639168712187;63460.36539634591;64410;64981;66629.66685166591;66732;9423.811523769624;9509.5720692569;9590;9750.658726944523;9766.902330976742;12927.870721292855;12943.417546210443;12949.352532373343;12955.870441295654;12956;6513.609183449008;6696.263411024784;6702.765403210864;6726.1516570818485;6784.0841486399695;6145.231846019247;6214.7570485903;6222.533310001768;6437.517186210959;6444.645544495098;4083.734557253769;4100.65144462724;4135.338345864648;4155.563665815106;4173.353130264813;1678.639092595098;1700.413357391698;1717.7509261157063;1725.4219836354962;1773.3842582191164;636.3032479435011;788.9566073865877;825.7687847402736;843.8481073406723;872.7469033980202;16186.109763962859;16331.755023674654;16561.6687666246;16918.577035573962;17290.121358737837;817.264461984219;819.8729196974479;829.3323874281141;853.4964371021127;897.6902968475865;9088.152996665094;9184.724458266262;9599.32804703678;9672.419654820733;9708.126268635715;370567;371302;384442.1555784462;391253;395533;74512;75465.62267188629;75889.62055189689;76245;76364;848.7708318753902;880.7489865388334;881.0616693221698;882.6160620130136;883.6730409748434;14557.490487832874;14720.19038952868;14889.329980150702;14897.851021489647;15439.228038597801;34235.657643424245;35526.11184720299;36938;36952;37298.813505932296;47922.5207747918;47974.760126199144;48167.27749083696;48269.5173048265;48353.5164648349;6829.112215411965;6873.175218973755;7079.539949759987;7324.4140468763435;7496.287852653989;8236.958815205886;10712.785744285227;11263.26788758728;11572.768544629229;11796.587119451122;7175.712971481291;9731.416115032838;9755.268354873271;10300.742481438025;10338.0695737384;10089.19286457067;10162.085412312927;10192.439415832201;10231.232657550565;10237.436940968319;5294.702797814406;5441.646292990943;10050.231163313758;10151.593936242467;10253.179745620482;6689.565178263398;6857.55425897315;6904.3095690430555;6963.860722785617;7051.189113252041;7250.528715633467;8574.78563035929;9498.525073746147;10191.94904025475;10360.792784144425 08:21:51 INFO - PROCESS | 31116 | |3;mootools.html;1308.640123965909;1339.879410853023;1377.634926744413;1599.0565566315872;1617.2722274976263;6000.789972350969;6200.224971878515;6457.7416903323865;6908.96545517273;6912.516123871331;6315.589486683374;6536.052272420497;6543.280239173687;6703;6709.865802683956;2001.0795034284247;2035.3181684135832;2036.725042119317;2041.1427200575795;2043.6525790615556;1771.070188151218;1832.395309547846;1995.451250905998;2036.775954644988;2039.3372154049919;1950.288144827142;2028;2029.4317591074448;2040.5000774810192;2043.3461292386442;2018.485286252011;2028.2596852149006;2044.642187617161;2048.7439070116234;2051.4871282179456;2040.7142999980015;2059.1969132038516;2059.6910463430454;2063.030375723408;2064;6898.275681053467;6939.514234003622;6957.5129740918155;6960.895586566206;6962.060121883532;4062.898427539335;4168.43726096976;4188.162367526507;4190;4192.266353388175;2479.5784716598223;2672.9064482743206;2680.437108207279;2683.2486903667004;2686.785057195439;786.6460092958134;812.8211793405501;841.6675413211747;851.2381418630353;853.5177624642057;9062.139096785795;9111.954440227757;9113.726588202364;9118.179363857218;9119.133682300171;3512.1921957949817;3685.557733071995;3713.313037088147;3768.246350729865;3780.4707340972286;7786.844263114706;7790.5325680459355;7795.493292935941;7795.688172473151;7796.064472263365;4157.251694694924;4163.979824942909;4165;4167.6874234432535;4168.8332466701595;3731.5708693500596;3820.522434695663;3822.235552889433;3838.2131663009573;3838.692904567628;3023.833689147074;3049.9237519061758;3061.1581815001055;3124.4532206864164;3129.765267604939;925.1165137294003;956.1633570625703;1022.6216299969059;1033.540074666766;1045.4197920154388;772.34350801818;776.1462391369448;823.9258466738022;831.3183189784439;867.9956600216958;4645.140648979949;4674.368960190331;4713.528647135259;4828.589569886599;4951.331570238044;753.7135888362496;820.4830956497368;833.9958300208582;854.799122206281;860.5396113079472;3254.9674503255137;3261.951070733941;3263.4125857345907;3324.2188085799817;3442.638522955104;7725.5364678119495;8103.189681031968;8175.79560510992;8187.385946053951;8189.631466584018;8151.30713889326;8161.428699990944;8161.959190204011;8165.877511837327;8170.877436838452;6409.230892292955;6499.967500162375;6503.739850405931;6505.381988711065;6517.706703198368;4541.886452838706;4597.954020459752;4669.6731228815015;4680.92978605328;4722.693024953367;7273;7392.112946446461;7406.555606663617;7470.92529074724;7499.700011999459;7467.365273951775;7495.737649182252;7610.771676849703;7719.459637825298;7728;5896.557758168069;5910.70446477683;5965.642061476326;5966.224390829338;5977.133315669291;6360.522960778053;6482.189726284215;6493.610383377012;6501.902471463027;6506.121673574196;5846.1815345852465;5901.881962360814;5925.940740592711;6038.365971573097;6140;5836.182934389104;5871.911921321269;5905.232319798399;5920.141579471038;5924.7926322578505;5615.241942337732;5661.207430959751;5721.370649228498;5744.3394009687745;5747.051736463437;4226.36604509326;4226.746395216297;4336.891577710582;4337.262665346835;4440.666949978699;4264.680148988777;4270.124624451918;4329.437173167594;4444.511103778517;4504.324351347324 08:21:51 INFO - PROCESS | 31116 | |4;prototype.html;259.7026404766542;268.1740240060613;277.106332079045;285.9313764696474;287.97408233259;4486.977565112178;4613.308003799431;4713.622910167187;4795.489420832435;4807.903841923164;4205.453291072156;4607.571652787638;4707.846577588495;4713.363695901053;4719.976400117995;3730.701543876497;3735.981320093396;3737.5514938207316;3743.86896458624;3773.2642134783728;3580.76463620052;3624.640759715107;3690.298843219793;3766.7551609145453;3783.508143941284;3719.6652301293016;3722.957571879878;3730.421784623388;3738.7943663098517;3747.5877653458233;3719.851205951759;3735.4210097434943;3739.4016957286703;3748.7750734955716;3751.6998640108727;3312.0726196664973;3325.235195904931;3331.983340083308;3344.247544302537;3344.3144155448317;4436.4676238851225;4595.724256544618;4603.677742558022;4623.953760462386;4664.626829853603;4213.2837417639075;4236.57634236577;4241.766702831343;4250.171216612762;4250.596193361625;4719.834805781781;4920.360353154103;4963.92554111685;5006.4492905780335;5015.699058056492;3552.662497062775;3555.0579096539177;3577.529796097781;3577.964220357789;3585.3904836177912;4914.213725803854;5126.461721519261;5210.098314115321;5214.530692237717;5221.738913054332;3463.8268086595567;3527.224010717638;3534.752567320263;3551.0057183988524;3559.34152181842;3597.136687195107;3610.530631017951;3618.113562177231;3618.565772107364;3622.402303619926;4147.751134931854;4153.418521407006;4169.770662613585;4172.749635021848;4178.749275043447;4848.248521479177;4977.676451030671;4978.6763860348965;4980.7509624518625;5018.436909794014;1243.1981372015;1255.9246445213316;1261.1235191541973;1263.684078980255;1267.176335382009;850.9234168924703;875.5403413208116;881.4667126388571;886.3618194899661;891.4562117108559;4304.182205380967;4322.697411181187;4340.218760623118;4349.3475978603465;4350.608445239944;5000.774965126578;5006.79836839156;5025.170846810309;5038.647294689336;5038.874028149326;4319.200947824663;4335.653147748172;4355;4364.148990946735;4422.933655995163;2547.414094758216;2661.4563553139133;2668.598985532572;2700.257429206984;2705.9594106088425;4706.835260765925;4711.623070154379;4722.645801564897;4729.763511824395;4741;4858.489858564871;5092.465291144376;5110.744462776846;5125.897482050338;5163.302954101224;4662.790174442158;4716.339712440261;4719.480857105716;4723.173444647242;4732.97633511844;5021.5229553192385;5023.572996295356;5026.396832379992;5046.646734728533;5105;4644.814207431665;4798.136335459511;4863.90272194547;4934.851954441372;4986.1772807487805;4661.3707149534375;4667.32323813052;4677.450789319897;4678.60231880294;4714.38712967312;3333.3333333333917;3416.4533674611944;3443.5351227583956;3541.6448062039485;3548.6806187443253;5110.386753589593;5123.615728820428;5126.077306084791;5132.563732082665;5136.357955255593;4941.703497790144;4945.851624451272;4965.875853103701;4969.676970996874;4999.975000125121;4746.169420351355;4970.62720295972;5013.671377085148;5015.473375295687;5040.949590504195;4964;4965.851024469272;4970.428400733962;4973.35346404965;4975.606830087581;5067.13858644024;5073.949260507347;5091.974540127276;5100.2349647553165;5100.6429549931145;4824.565789079;4917.213245880642;4935.728534930613;4945.120854075429;4946.777395017161 08:21:51 INFO - PROCESS | 31116 | |5;yui.html;567.2568934695549;635.4820821030856;648.0506058624114;700.2927043685877;717.58738725233;13356.866431335697;13611.319434028295;13643.931780341085;13789.793153102699;13807.51673691421;12601.054920880948;12607.11750177488;12640.494380224804;12647.241165530075;12664.240145591271;604.5556515960766;630.7224821078734;745.1840234942729;759.6657470712896;762.1463960364399;743.4832791210084;760.9847803043964;770.7302444144533;771.3482107619053;771.8494893495771;806.7579726082181;809.1423091522975;809.7004108479871;810.068421315489;810.2262339465825;643.6652940470929;661.3816081963331;805.9556724380157;806.3831169155601;806.681360862459;487.9243717223836;488.11407295758085;488.14330849359504;566.2921348314607;582.0483509462018;12838.293893835835;12883.806742898863;12898.67753306175;12909.419076141596;12912.225266483947;10794.018061504885;10878.401687907162;10920.836187457115;11151.159611225748;11312.264702794291;10314.896851031468;10477.947610261976;10515;10564.630237941636;10801.513931873085;3987.322155233617;4015.9397609035886;4050.696197785178;4060.533038700558;4077.4903137107863;35197.29605407903;41794.37308440376;46493;47080.7645961768;47227.76386118047;9385.67150149755;9419.340646154704;9498.287628427895;9512.1439070484;9616.90383096174;14298.499552515612;14303.713925721428;14351.354189061518;14402.42390304376;14550.12699238049;6089.543284253698;6183;6204.472619827275;6286.151369565142;6427.517936154807;3444.042998354988;3499.492573576817;3566.892993210208;3654.250878569887;3668.706503479715;2500.5374005808985;2550.7449255074343;2569.961450578243;2579.509893120301;2580.3420127867275;457.5333160176668;459.80688110993464;459.94940556538756;468.3560104855823;470.66112399073296;527.5489456514624;536.6190005096347;538.3055857943287;543.3045701502084;550.1088237055994;6851.314868513208;7127.5010749248095;7265.4550908681;7447.515911465737;7660.1573826879;437.9167958087953;476.9022350418156;519.1019536202391;567.3758865248276;578.5342799046724;3074.292912630108;3076.0464256080686;3132.8903488377796;3168.5405616185526;3232.175795172216;70394.27311674277;71198.64400678067;71713;73717.6314118426;74567.62716186493;37313.25373492515;59668.40331596715;61158.38841611616;61929.38070619236;63016.369836301965;55411.16883246755;57329.42670573324;57517.13724294139;57776.42223577879;58205.41794582;6183.96908015457;6204.611224678441;6282;6318.178636777189;6368.617882927039;38601.42097868591;39956;40331.1933761329;40377.19245615012;41740;32212.677873221906;34989.825050874584;47637.28544071911;49189.262161066894;51503.484965151365;9560.282978776759;9952.4573691078;10363.896361036293;10464.94767526188;10851.348919064882;11383.715407114889;11752.575275373472;11932;12037.217580857216;12121.878781212075;10888.128949684165;11088.5564577416;11403.258788178742;11657.358845263592;11766.764664706487;8657.437266577652;10242.692719218436;10619.840702389625;10730;10792.136629069813;10418.12451921878;10942.562297508011;11021.889781102087;11028.779424411627;11101.278416902875;9430.19843313326;9703.66037188695;9731.562079706571;10093.545790439595;10335.17318614524;9686.370385924893;10058.446785426871;10160.898391016291;10174.389536627827;10196.490175491344 08:21:51 INFO - PROCESS | 31116 | __end_tp_report 08:21:51 INFO - PROCESS | 31116 | __start_cc_report 08:21:51 INFO - PROCESS | 31116 | _x_x_mozilla_cycle_collect,1516 08:21:51 INFO - PROCESS | 31116 | __end_cc_report 08:21:51 INFO - PROCESS | 31116 | __startTimestamp1479745311519__endTimestamp 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | ------- Summary: start ------- 08:21:51 INFO - PROCESS | 31116 | Number of tests: 6 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#0] dojo.html Cycles:165 Average:4559.05 Median:4688.20 stddev:470.53 (10.0%) stddev-sans-first:444.52 08:21:51 INFO - PROCESS | 31116 | Values: 2540.2 2557.7 2579.9 2594.6 2596.7 4510.6 4552.7 4573.7 4581.6 4582.1 4592.5 4612.6 4622.4 4626.2 4630.8 4210.7 4237.5 4249.5 4257.5 4280.7 4315.0 4324.5 4344.8 4351.0 4352.8 4272.1 4307.4 4320.2 4336.9 4354.6 4374.7 4381.5 4390.4 4396.4 4398.1 4129.5 4129.5 4182.1 4300.6 4304.3 4528.4 4535.5 4543.5 4586.0 4603.1 4926.1 4927.2 4935.9 4948.0 5005.8 4817.2 4870.0 4874.6 4965.3 4977.1 4616.5 4629.7 4648.9 4658.3 4699.7 5067.6 5074.7 5075.7 5077.3 5122.4 4657.9 4865.1 4887.1 4891.5 4941.7 4811.2 4889.4 4895.9 4900.3 4902.0 4877.5 4878.4 4883.6 4917.5 4924.6 4841.1 4853.2 4858.1 4869.9 4891.6 4012.9 4014.1 4042.1 4052.9 4067.9 3630.6 3635.9 3662.4 3673.2 3674.8 4285.6 4301.1 4308.8 4310.0 4355.9 4872.1 4936.6 4941.6 4943.8 5002.8 4315.1 4321.8 4323.8 4328.9 4337.2 4413.5 4452.2 4458.2 4460.6 4464.5 4683.4 4687.4 4688.2 4695.2 4698.8 4917.5 4960.4 4966.2 4969.9 4979.0 4716.5 4717.0 4718.0 4746.4 4760.2 4931.3 4931.8 4933.6 4935.1 4936.1 4675.7 4763.8 4812.8 5002.2 5041.3 4728.1 4729.0 4746.7 4780.3 4784.8 4745.5 4746.4 4752.4 4757.2 4757.4 4610.4 4627.7 4661.5 4687.3 4736.5 4735.5 4758.5 4817.0 4825.7 4828.3 4692.5 4703.8 4712.7 4717.6 4723.6 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#1] ext.html Cycles:180 Average:43217.20 Median:34761.15 stddev:75576.85 (217.4%) stddev-sans-first:75720.91 08:21:51 INFO - PROCESS | 31116 | Values: 532.9 558.3 564.3 586.2 588.7 27047.6 29902.6 38305.2 38879.2 39029.8 37876.2 38307.8 38315.2 38315.2 38365.8 7477.7 7623.2 7629.2 7631.4 7636.0 7392.0 7595.1 9607.4 9839.8 9856.4 9934.4 9983.8 9986.7 9987.3 10010.2 9783.1 9787.5 9830.9 9843.2 9856.7 9761.6 9821.5 9828.1 9828.8 9832.6 36079.5 36462.1 36485.8 36512.8 36545.5 2824.4 2871.2 2884.3 3037.3 3182.8 27575.7 27846.7 27927.4 27927.9 28644.3 3436.5 3500.9 3503.1 3503.9 3534.1 223129.0 223612.0 223877.0 224293.6 225015.0 48880.5 49285.5 49399.3 49416.8 49621.5 30963.7 31886.5 31961.0 33669.5 33723.0 13141.5 13142.1 13150.2 13294.8 13297.5 9318.1 9733.3 9956.7 9972.8 10023.2 14700.9 16779.9 17233.5 17360.5 18102.5 6484.3 6539.8 6632.9 6694.2 6740.6 751.0 810.9 892.7 895.9 924.8 24901.0 26291.3 26712.9 26791.2 26885.7 932.0 940.3 972.8 990.8 1018.1 13391.7 14202.4 14283.9 14533.3 14593.6 338357.0 338988.0 339846.0 340598.0 344588.0 45206.5 45572.0 45600.0 45703.9 45753.0 1040.6 1052.4 1092.7 1149.9 1177.4 25384.0 26607.0 26993.5 27323.0 27648.9 38536.4 39432.2 39518.5 39532.0 39532.8 269070.0 269785.0 269982.0 270824.0 353714.0 32249.5 34715.7 34839.3 34987.0 35126.0 38296.6 38467.0 38541.4 38652.2 39200.0 33540.5 33985.0 34226.8 34258.3 34667.3 33603.3 33691.5 33846.7 33980.0 34806.7 33535.8 33917.7 34242.8 34429.5 34704.5 28451.2 31043.7 31171.7 33552.5 33866.2 23677.4 23715.8 24057.8 24411.5 24453.4 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#2] jquery.html Cycles:180 Average:23404.99 Median:26601.73 stddev:63202.46 (237.6%) stddev-sans-first:63356.01 08:21:51 INFO - PROCESS | 31116 | Values: 327.3 331.1 345.8 353.4 366.4 12620.2 13676.9 15762.2 16046.5 16910.7 14585.5 14771.0 15026.8 16278.3 16422.2 4850.0 4906.4 5090.3 5096.9 5100.8 5027.4 5065.0 5075.9 5094.5 5119.3 5079.4 5080.4 5082.2 5085.3 5085.6 4864.2 5022.7 5055.2 5055.3 5057.8 4500.8 4505.0 4507.9 4518.9 4519.8 20100.4 20220.1 20331.5 20362.0 20492.6 1645.2 1753.6 1793.2 1838.7 1859.5 8521.7 8576.9 8657.2 9106.2 9112.1 1604.8 1647.7 1691.9 1692.5 1748.8 63460.4 64410.0 64981.0 66629.7 66732.0 9423.8 9509.6 9590.0 9750.7 9766.9 12927.9 12943.4 12949.4 12955.9 12956.0 6513.6 6696.3 6702.8 6726.2 6784.1 6145.2 6214.8 6222.5 6437.5 6444.6 4083.7 4100.7 4135.3 4155.6 4173.4 1678.6 1700.4 1717.8 1725.4 1773.4 636.3 789.0 825.8 843.8 872.7 16186.1 16331.8 16561.7 16918.6 17290.1 817.3 819.9 829.3 853.5 897.7 9088.2 9184.7 9599.3 9672.4 9708.1 370567.0 371302.0 384442.2 391253.0 395533.0 74512.0 75465.6 75889.6 76245.0 76364.0 848.8 880.7 881.1 882.6 883.7 14557.5 14720.2 14889.3 14897.9 15439.2 34235.7 35526.1 36938.0 36952.0 37298.8 47922.5 47974.8 48167.3 48269.5 48353.5 6829.1 6873.2 7079.5 7324.4 7496.3 8237.0 10712.8 11263.3 11572.8 11796.6 7175.7 9731.4 9755.3 10300.7 10338.1 10089.2 10162.1 10192.4 10231.2 10237.4 5294.7 5441.6 10050.2 10151.6 10253.2 6689.6 6857.6 6904.3 6963.9 7051.2 7250.5 8574.8 9498.5 10191.9 10360.8 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#3] mootools.html Cycles:180 Average:4515.00 Median:5732.86 stddev:2408.77 (42.0%) stddev-sans-first:2403.48 08:21:51 INFO - PROCESS | 31116 | Values: 1308.6 1339.9 1377.6 1599.1 1617.3 6000.8 6200.2 6457.7 6909.0 6912.5 6315.6 6536.1 6543.3 6703.0 6709.9 2001.1 2035.3 2036.7 2041.1 2043.7 1771.1 1832.4 1995.5 2036.8 2039.3 1950.3 2028.0 2029.4 2040.5 2043.3 2018.5 2028.3 2044.6 2048.7 2051.5 2040.7 2059.2 2059.7 2063.0 2064.0 6898.3 6939.5 6957.5 6960.9 6962.1 4062.9 4168.4 4188.2 4190.0 4192.3 2479.6 2672.9 2680.4 2683.2 2686.8 786.6 812.8 841.7 851.2 853.5 9062.1 9112.0 9113.7 9118.2 9119.1 3512.2 3685.6 3713.3 3768.2 3780.5 7786.8 7790.5 7795.5 7795.7 7796.1 4157.3 4164.0 4165.0 4167.7 4168.8 3731.6 3820.5 3822.2 3838.2 3838.7 3023.8 3049.9 3061.2 3124.5 3129.8 925.1 956.2 1022.6 1033.5 1045.4 772.3 776.1 823.9 831.3 868.0 4645.1 4674.4 4713.5 4828.6 4951.3 753.7 820.5 834.0 854.8 860.5 3255.0 3262.0 3263.4 3324.2 3442.6 7725.5 8103.2 8175.8 8187.4 8189.6 8151.3 8161.4 8162.0 8165.9 8170.9 6409.2 6500.0 6503.7 6505.4 6517.7 4541.9 4598.0 4669.7 4680.9 4722.7 7273.0 7392.1 7406.6 7470.9 7499.7 7467.4 7495.7 7610.8 7719.5 7728.0 5896.6 5910.7 5965.6 5966.2 5977.1 6360.5 6482.2 6493.6 6501.9 6506.1 5846.2 5901.9 5925.9 6038.4 6140.0 5836.2 5871.9 5905.2 5920.1 5924.8 5615.2 5661.2 5721.4 5744.3 5747.1 4226.4 4226.7 4336.9 4337.3 4440.7 4264.7 4270.1 4329.4 4444.5 4504.3 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#4] prototype.html Cycles:180 Average:4098.98 Median:4663.71 stddev:1187.18 (25.5%) stddev-sans-first:1155.01 08:21:51 INFO - PROCESS | 31116 | Values: 259.7 268.2 277.1 285.9 288.0 4487.0 4613.3 4713.6 4795.5 4807.9 4205.5 4607.6 4707.8 4713.4 4720.0 3730.7 3736.0 3737.6 3743.9 3773.3 3580.8 3624.6 3690.3 3766.8 3783.5 3719.7 3723.0 3730.4 3738.8 3747.6 3719.9 3735.4 3739.4 3748.8 3751.7 3312.1 3325.2 3332.0 3344.2 3344.3 4436.5 4595.7 4603.7 4624.0 4664.6 4213.3 4236.6 4241.8 4250.2 4250.6 4719.8 4920.4 4963.9 5006.4 5015.7 3552.7 3555.1 3577.5 3578.0 3585.4 4914.2 5126.5 5210.1 5214.5 5221.7 3463.8 3527.2 3534.8 3551.0 3559.3 3597.1 3610.5 3618.1 3618.6 3622.4 4147.8 4153.4 4169.8 4172.7 4178.7 4848.2 4977.7 4978.7 4980.8 5018.4 1243.2 1255.9 1261.1 1263.7 1267.2 850.9 875.5 881.5 886.4 891.5 4304.2 4322.7 4340.2 4349.3 4350.6 5000.8 5006.8 5025.2 5038.6 5038.9 4319.2 4335.7 4355.0 4364.1 4422.9 2547.4 2661.5 2668.6 2700.3 2706.0 4706.8 4711.6 4722.6 4729.8 4741.0 4858.5 5092.5 5110.7 5125.9 5163.3 4662.8 4716.3 4719.5 4723.2 4733.0 5021.5 5023.6 5026.4 5046.6 5105.0 4644.8 4798.1 4863.9 4934.9 4986.2 4661.4 4667.3 4677.5 4678.6 4714.4 3333.3 3416.5 3443.5 3541.6 3548.7 5110.4 5123.6 5126.1 5132.6 5136.4 4941.7 4945.9 4965.9 4969.7 5000.0 4746.2 4970.6 5013.7 5015.5 5040.9 4964.0 4965.9 4970.4 4973.4 4975.6 5067.1 5073.9 5092.0 5100.2 5100.6 4824.6 4917.2 4935.7 4945.1 4946.8 08:21:51 INFO - PROCESS | 31116 | 08:21:51 INFO - PROCESS | 31116 | [#5] yui.html Cycles:180 Average:14191.30 Median:459.88 stddev:18335.15 (3987.0%) stddev-sans-first:18358.05 08:21:51 INFO - PROCESS | 31116 | Values: 567.3 635.5 648.1 700.3 717.6 13356.9 13611.3 13643.9 13789.8 13807.5 12601.1 12607.1 12640.5 12647.2 12664.2 604.6 630.7 745.2 759.7 762.1 743.5 761.0 770.7 771.3 771.8 806.8 809.1 809.7 810.1 810.2 643.7 661.4 806.0 806.4 806.7 487.9 488.1 488.1 566.3 582.0 12838.3 12883.8 12898.7 12909.4 12912.2 10794.0 10878.4 10920.8 11151.2 11312.3 10314.9 10477.9 10515.0 10564.6 10801.5 3987.3 4015.9 4050.7 4060.5 4077.5 35197.3 41794.4 46493.0 47080.8 47227.8 9385.7 9419.3 9498.3 9512.1 9616.9 14298.5 14303.7 14351.4 14402.4 14550.1 6089.5 6183.0 6204.5 6286.2 6427.5 3444.0 3499.5 3566.9 3654.3 3668.7 2500.5 2550.7 2570.0 2579.5 2580.3 457.5 459.8 459.9 468.4 470.7 527.5 536.6 538.3 543.3 550.1 6851.3 7127.5 7265.5 7447.5 7660.2 437.9 476.9 519.1 567.4 578.5 3074.3 3076.0 3132.9 3168.5 3232.2 70394.3 71198.6 71713.0 73717.6 74567.6 37313.3 59668.4 61158.4 61929.4 63016.4 55411.2 57329.4 57517.1 57776.4 58205.4 6184.0 6204.6 6282.0 6318.2 6368.6 38601.4 39956.0 40331.2 40377.2 41740.0 32212.7 34989.8 47637.3 49189.3 51503.5 9560.3 9952.5 10363.9 10464.9 10851.3 11383.7 11752.6 11932.0 12037.2 12121.9 10888.1 11088.6 11403.3 11657.4 11766.8 8657.4 10242.7 10619.8 10730.0 10792.1 10418.1 10942.6 11021.9 11028.8 11101.3 9430.2 9703.7 9731.6 10093.5 10335.2 9686.4 10058.4 10160.9 10174.4 10196.5 08:21:51 INFO - PROCESS | 31116 | -------- Summary: end -------- 08:21:51 INFO - PROCESS | 31116 | 08:21:52 INFO - TEST-INFO | 31116: exit 0 08:21:52 INFO - TEST-OK | dromaeo_css | took 1123195ms 08:21:52 INFO - TEST-START | kraken 08:21:52 INFO - operating with platform_type : linux_ 08:21:52 INFO - Initialising browser for kraken test... 08:21:52 INFO - TEST-INFO | started process 31418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjoLqZ/profile http://localhost:40571/getInfo.html) 08:21:57 INFO - PROCESS | 31418 | __metrics Screen width/height:1600/1200 08:21:57 INFO - PROCESS | 31418 | colorDepth:24 08:21:57 INFO - PROCESS | 31418 | Browser inner width/height: 1024/697 08:21:57 INFO - PROCESS | 31418 | __metrics 08:21:57 INFO - PROCESS | 31418 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:21:57 INFO - PROCESS | 31418 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:58 INFO - PROCESS | 31418 | console.error: PushService: 08:21:58 INFO - PROCESS | 31418 | stateChangeProcessEnqueue: Error transitioning state 08:21:58 INFO - PROCESS | 31418 | UnknownError 08:21:59 INFO - TEST-INFO | 31418: exit 0 08:21:59 INFO - Browser initialized. 08:21:59 INFO - Running cycle 1/1 for kraken test... 08:21:59 INFO - TEST-INFO | started process 31497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjoLqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:11 INFO - PROCESS | 31497 | RSS: Main: 175505408 08:22:11 INFO - PROCESS | 31497 | 08:22:14 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40571/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:15 INFO - PROCESS | 31497 | RSS: Main: 240062464 08:22:15 INFO - PROCESS | 31497 | 08:22:18 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40571/tests/kraken/driver.html?testName=audio-dft) 08:22:18 INFO - PROCESS | 31497 | RSS: Main: 218914816 08:22:18 INFO - PROCESS | 31497 | 08:22:22 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40571/tests/kraken/driver.html?testName=audio-fft) 08:22:22 INFO - PROCESS | 31497 | RSS: Main: 300388352 08:22:22 INFO - PROCESS | 31497 | 08:22:24 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40571/tests/kraken/driver.html?testName=audio-oscillator) 08:22:25 INFO - PROCESS | 31497 | RSS: Main: 211951616 08:22:25 INFO - PROCESS | 31497 | 08:22:27 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:28 INFO - PROCESS | 31497 | RSS: Main: 214929408 08:22:28 INFO - PROCESS | 31497 | 08:22:31 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40571/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:32 INFO - PROCESS | 31497 | RSS: Main: 253681664 08:22:32 INFO - PROCESS | 31497 | 08:22:35 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40571/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:36 INFO - PROCESS | 31497 | RSS: Main: 248737792 08:22:36 INFO - PROCESS | 31497 | 08:22:39 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40571/tests/kraken/driver.html?testName=json-parse-financial) 08:22:39 INFO - PROCESS | 31497 | RSS: Main: 251351040 08:22:39 INFO - PROCESS | 31497 | 08:22:41 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:42 INFO - PROCESS | 31497 | RSS: Main: 214114304 08:22:42 INFO - PROCESS | 31497 | 08:22:44 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:44 INFO - PROCESS | 31497 | RSS: Main: 221319168 08:22:44 INFO - PROCESS | 31497 | 08:22:46 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:47 INFO - PROCESS | 31497 | RSS: Main: 230387712 08:22:47 INFO - PROCESS | 31497 | 08:22:50 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:51 INFO - PROCESS | 31497 | RSS: Main: 238837760 08:22:51 INFO - PROCESS | 31497 | 08:22:54 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:54 INFO - PROCESS | 31497 | RSS: Main: 234909696 08:22:54 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | Cycle 1(1): loaded http://localhost:40571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40571/tests/kraken/driver.html?testName=ai-astar) 08:22:56 INFO - PROCESS | 31497 | RSS: Main: 286949376 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | __start_tp_report 08:22:56 INFO - PROCESS | 31497 | _x_x_mozilla_page_load 08:22:56 INFO - PROCESS | 31497 | _x_x_mozilla_page_load_details 08:22:56 INFO - PROCESS | 31497 | |i|pagename|runs| 08:22:56 INFO - PROCESS | 31497 | |0;ai-astar;110;115;114;114;114;116;117;115;116;115 08:22:56 INFO - PROCESS | 31497 | |1;audio-beat-detection;159;127;131;175;134;136;128;132;166;143 08:22:56 INFO - PROCESS | 31497 | |2;audio-dft;162;162;164;165;163;163;163;163;163;161 08:22:56 INFO - PROCESS | 31497 | |3;audio-fft;77;78;77;114;77;77;77;77;104;77 08:22:56 INFO - PROCESS | 31497 | |4;audio-oscillator;83;83;117;85;83;83;105;83;84;118 08:22:56 INFO - PROCESS | 31497 | |5;imaging-gaussian-blur;118;118;118;117;117;118;118;117;117;117 08:22:56 INFO - PROCESS | 31497 | |6;imaging-darkroom;147;147;148;147;147;147;147;147;147;146 08:22:56 INFO - PROCESS | 31497 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 08:22:56 INFO - PROCESS | 31497 | |8;json-parse-financial;65;65;65;65;65;64;65;65;65;65 08:22:56 INFO - PROCESS | 31497 | |9;json-stringify-tinderbox;66;67;66;66;66;66;65;66;69;66 08:22:56 INFO - PROCESS | 31497 | |10;stanford-crypto-aes;85;86;85;85;94;84;94;85;91;92 08:22:56 INFO - PROCESS | 31497 | |11;stanford-crypto-ccm;173;142;152;141;140;145;139;148;185;152 08:22:56 INFO - PROCESS | 31497 | |12;stanford-crypto-pbkdf2;179;177;181;177;178;176;176;176;174;174 08:22:56 INFO - PROCESS | 31497 | |13;stanford-crypto-sha256-iterative;69;71;72;70;70;73;70;74;73;73 08:22:56 INFO - PROCESS | 31497 | __end_tp_report 08:22:56 INFO - PROCESS | 31497 | __start_cc_report 08:22:56 INFO - PROCESS | 31497 | _x_x_mozilla_cycle_collect,1989 08:22:56 INFO - PROCESS | 31497 | __end_cc_report 08:22:56 INFO - PROCESS | 31497 | __startTimestamp1479745376942__endTimestamp 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | ------- Summary: start ------- 08:22:56 INFO - PROCESS | 31497 | Number of tests: 14 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.90 (1.6%) stddev-sans-first:1.05 08:22:56 INFO - PROCESS | 31497 | Values: 110.0 115.0 114.0 114.0 114.0 116.0 117.0 115.0 116.0 115.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:139.50 stddev:17.27 (12.4%) stddev-sans-first:17.33 08:22:56 INFO - PROCESS | 31497 | Values: 159.0 127.0 131.0 175.0 134.0 136.0 128.0 132.0 166.0 143.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 08:22:56 INFO - PROCESS | 31497 | Values: 162.0 162.0 164.0 165.0 163.0 163.0 163.0 163.0 163.0 161.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:13.65 (17.7%) stddev-sans-first:14.27 08:22:56 INFO - PROCESS | 31497 | Values: 77.0 78.0 77.0 114.0 77.0 77.0 77.0 77.0 104.0 77.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:14.86 (17.9%) stddev-sans-first:15.36 08:22:56 INFO - PROCESS | 31497 | Values: 83.0 83.0 117.0 85.0 83.0 83.0 105.0 83.0 84.0 118.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:22:56 INFO - PROCESS | 31497 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:22:56 INFO - PROCESS | 31497 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:22:56 INFO - PROCESS | 31497 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:22:56 INFO - PROCESS | 31497 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 08:22:56 INFO - PROCESS | 31497 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 65.0 66.0 69.0 66.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:4.12 (4.7%) stddev-sans-first:4.22 08:22:56 INFO - PROCESS | 31497 | Values: 85.0 86.0 85.0 85.0 94.0 84.0 94.0 85.0 91.0 92.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:150.00 stddev:15.38 (10.3%) stddev-sans-first:14.25 08:22:56 INFO - PROCESS | 31497 | Values: 173.0 142.0 152.0 141.0 140.0 145.0 139.0 148.0 185.0 152.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:2.15 (1.2%) stddev-sans-first:2.13 08:22:56 INFO - PROCESS | 31497 | Values: 179.0 177.0 181.0 177.0 178.0 176.0 176.0 176.0 174.0 174.0 08:22:56 INFO - PROCESS | 31497 | 08:22:56 INFO - PROCESS | 31497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.50 stddev:1.72 (2.4%) stddev-sans-first:1.56 08:22:56 INFO - PROCESS | 31497 | Values: 69.0 71.0 72.0 70.0 70.0 73.0 70.0 74.0 73.0 73.0 08:22:56 INFO - PROCESS | 31497 | -------- Summary: end -------- 08:22:56 INFO - PROCESS | 31497 | 08:22:58 INFO - TEST-INFO | 31497: exit 0 08:22:58 INFO - TEST-OK | kraken | took 65821ms 08:22:58 INFO - SUITE-END | took 1189s 08:22:58 INFO - Completed test suite (00:19:49) 08:22:58 INFO - javascript benchmark 08:22:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2540.199837051329, 2557.7186509483963, 2579.896804127835, 2594.571895637219, 2596.7143614202446, 4510.639148868091, 4552.749598772066, 4573.725576465415, 4581.587657110859, 4582.129395414869, 4592.540745925406, 4612.607928326096, 4622.375979242801, 4626.236670949289, 4630.768461576916, 4210.663146948252, 4237.4915010198665, 4249.46881639795, 4257.510386305568, 4280.743155410685, 4314.978425107885, 4324.524302326741, 4344.78276086196, 4351.042770590465, 4352.782360881959, 4272.060146767706, 4307.396964424983, 4320.1575692739925, 4336.913261734763, 4354.629856462205, 4374.737515749065, 4381.452318460192, 4390.407295015164, 4396.384506169139, 4398.120375924827, 4129.525104612948, 4129.545749967501, 4182.059036716745, 4300.569943005706, 4304.268274393361, 4528.43394575678, 4535.501094879561, 4543.477500087466, 4585.9681571646115, 4603.148417542765, 4926.11329960607, 4927.162382395001, 4935.925961110586, 4948.010397920394, 5005.849824505271, 4817.229243321087, 4870.0, 4874.634402419832, 4965.255211718235, 4977.129002424561, 4616.538346165356, 4629.675922685447, 4648.883777905579, 4658.324542941255, 4699.718016918996, 5067.619928505377, 5074.67014644047, 5075.71592783249, 5077.339945807095, 5122.359705036871, 4657.906841863144, 4865.099956508057, 4887.095887260797, 4891.51084891508, 4941.703497790144, 4811.182099043171, 4889.413270407574, 4895.926561101586, 4900.289458028566, 4901.950980490221, 4877.512248775094, 4878.365812444359, 4883.633727470454, 4917.532834380728, 4924.60603151747, 4841.055994081191, 4853.199222128309, 4858.149823780825, 4869.853904382803, 4891.608671306287, 4012.879613611596, 4014.0767623446773, 4042.0501182222156, 4052.8986775330854, 4067.89830254246, 3630.6006339302658, 3635.9091022724115, 3662.432322989941, 3673.1918977824835, 3674.8346324415465, 4285.550017248144, 4301.075268817157, 4308.849190278325, 4310.030243195319, 4355.912881742347, 4872.074305881871, 4936.629752768485, 4941.629377796679, 4943.777530011158, 5002.824901128443, 4315.115401342718, 4321.827126914951, 4323.7621930793475, 4328.9394098445455, 4337.154254920323, 4413.492448368414, 4452.154090722753, 4458.175237581057, 4460.576245256695, 4464.464264288241, 4683.414573178353, 4687.414073240845, 4688.2030054890065, 4695.22528782747, 4698.835540756126, 4917.508249175054, 4960.429550601727, 4966.230234313687, 4969.900601988013, 4978.950210497848, 4716.457607375196, 4716.976415117902, 4717.952820471752, 4746.43042834862, 4760.238361862085, 4931.334269873521, 4931.753412329441, 4933.605311574994, 4935.136351138464, 4936.111499930047, 4675.696079754805, 4763.761811909321, 4812.759362031955, 5002.249662550501, 5041.319421878, 4728.1252968199615, 4728.976355118202, 4746.7389293589185, 4780.330753694555, 4784.808607655655, 4745.477997420212, 4746.43042834862, 4752.382190315237, 4757.167495688172, 4757.429108507002, 4610.423697037871, 4627.67606267558, 4661.463931647904, 4687.343771872009, 4736.50266722003, 4735.455422626442, 4758.452777930583, 4816.964352664194, 4825.662203645711, 4828.324034635084, 4692.460367057832, 4703.835365762318, 4712.740799256074, 4717.599004084691, 4723.574878260973], "value": 4529.195572947071, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8774381892165, 558.3132746721533, 564.32281262485, 586.2027642406326, 588.6703446070204, 27047.5942860857, 29902.551461728093, 38305.23389532211, 38879.222415551674, 39029.804850975706, 37876.24247515048, 38307.80846095773, 38315.233695326075, 38315.233695326075, 38365.808170959106, 7477.700891964329, 7623.23767623236, 7629.1989341119215, 7631.427642926803, 7635.961820190892, 7391.963040184792, 7595.126560445564, 9607.423554586712, 9839.754006149831, 9856.359336643096, 9934.403935763841, 9983.800323993515, 9986.700398988041, 9987.300888937778, 10010.249231307645, 9783.0706082922, 9787.510624468783, 9830.852537211947, 9843.163331116864, 9856.655017074403, 9761.560729767178, 9821.459819709913, 9828.115469607697, 9828.803423931553, 9832.606695732162, 36079.4588081179, 36462.08844778875, 36485.817570912244, 36512.81743591265, 36545.45181822275, 2824.378636699923, 2871.2104171352835, 2884.307766136133, 3037.271054946797, 3182.7612929030415, 27575.72424275772, 27846.721532784817, 27927.441451171067, 27927.86036069827, 28644.283892902637, 3436.4501679731125, 3500.9025764454836, 3503.1067077894972, 3503.948815355383, 3534.1341371363924, 223129.0, 223612.0, 223877.0, 224293.59889615467, 225015.0, 48880.511194888306, 49285.507144928095, 49399.25901111486, 49416.752916235186, 49621.50378496241, 30963.69036309608, 31886.521702174487, 31961.0, 33669.49495757517, 33723.0, 13141.474341026444, 13142.080054396292, 13150.21098734079, 13294.800577991338, 13297.534586289434, 9318.114779095975, 9733.270004749673, 9956.701298961043, 9972.750681232883, 10023.2482563808, 14700.852991469948, 16779.916100419665, 17233.482995510156, 17360.479185624452, 18102.45692629223, 6484.286728459866, 6539.790138824237, 6632.933670663231, 6694.196696396463, 6740.595564266159, 750.9586972716553, 810.9310708589836, 892.7187935800332, 895.8521843895684, 924.8381533231658, 24901.0, 26291.342716432242, 26712.866435668086, 26791.196264112106, 26885.731142688324, 932.0120672087609, 940.3229674634252, 972.7908499672462, 990.762217067913, 1018.149844879519, 13391.732165356638, 14202.431902723776, 14283.928580357031, 14533.27333633314, 14593.562193134223, 338357.0, 338988.0, 339846.0, 340598.0, 344588.0, 45206.547934520895, 45572.0, 45600.0, 45703.91589303663, 45753.0, 1040.573364920379, 1052.3896140238644, 1092.7432053467428, 1149.8850114988434, 1177.3524561490974, 25384.0, 26607.0, 26993.46013079688, 27323.0, 27648.861755691094, 38536.42195367016, 39432.211355773296, 39518.47945089143, 39532.0, 39532.80233598928, 269070.0, 269785.0, 269982.0, 270824.0, 353714.0, 32249.51625725663, 34715.652843471245, 34839.30321393609, 34987.0, 35126.0, 38296.61703383042, 38467.0, 38541.42187867128, 38652.226955461294, 39200.0, 33540.49689254614, 33985.0, 34226.82886585551, 34258.31483370269, 34667.30665386729, 33603.32793344168, 33691.49462758011, 33846.66153338435, 33980.0, 34806.65193348034, 33535.83232083922, 33917.66082339145, 34242.82878585591, 34429.48355774715, 34704.479432809036, 28451.167510659852, 31043.689563104985, 31171.688283116877, 33552.49671254884, 33866.153346166546, 23677.408064798517, 23715.762842372045, 24057.759422406252, 24411.51176976486, 24453.38866528351], "value": 16930.35739841424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.255493751715, 331.1489472056815, 345.77351834548364, 353.3904015573137, 366.3533862732278, 12620.24278543288, 13676.863231367695, 15762.211889405527, 16046.518604441857, 16910.66178676429, 14585.489507867227, 14771.0, 15026.774598381033, 16278.26747796349, 16422.17889105546, 4849.951500484985, 4906.362172917516, 5090.338256026711, 5096.923546146811, 5100.77046532905, 5027.371578552681, 5065.037642847866, 5075.923861142067, 5094.490550944913, 5119.283300337937, 5079.415867175285, 5080.390353157608, 5082.186850103984, 5085.262636917645, 5085.644004919657, 4864.246041863499, 5022.723750193738, 5055.216441451563, 5055.292259083732, 5057.848264552069, 4500.752458614775, 4504.977475112603, 4507.864764057051, 4518.864434066983, 4519.751413672247, 20100.386949696447, 20220.090095945718, 20331.491712707302, 20362.0, 20492.5901481971, 1645.2020769926576, 1753.579141006162, 1793.1841012339355, 1838.6874231380698, 1859.460756380648, 8521.744347669579, 8576.871346929802, 8657.220850123456, 9106.225970792491, 9112.088791120901, 1604.767308740226, 1647.744599587066, 1691.9323227070902, 1692.4668729350337, 1748.7639168712187, 63460.36539634591, 64410.0, 64981.0, 66629.66685166591, 66732.0, 9423.811523769624, 9509.5720692569, 9590.0, 9750.658726944523, 9766.902330976742, 12927.870721292855, 12943.417546210443, 12949.352532373343, 12955.870441295654, 12956.0, 6513.609183449008, 6696.263411024784, 6702.765403210864, 6726.1516570818485, 6784.0841486399695, 6145.231846019247, 6214.7570485903, 6222.533310001768, 6437.517186210959, 6444.645544495098, 4083.734557253769, 4100.65144462724, 4135.338345864648, 4155.563665815106, 4173.353130264813, 1678.639092595098, 1700.413357391698, 1717.7509261157063, 1725.4219836354962, 1773.3842582191164, 636.3032479435011, 788.9566073865877, 825.7687847402736, 843.8481073406723, 872.7469033980202, 16186.109763962859, 16331.755023674654, 16561.6687666246, 16918.577035573962, 17290.121358737837, 817.264461984219, 819.8729196974479, 829.3323874281141, 853.4964371021127, 897.6902968475865, 9088.152996665094, 9184.724458266262, 9599.32804703678, 9672.419654820733, 9708.126268635715, 370567.0, 371302.0, 384442.1555784462, 391253.0, 395533.0, 74512.0, 75465.62267188629, 75889.62055189689, 76245.0, 76364.0, 848.7708318753902, 880.7489865388334, 881.0616693221698, 882.6160620130136, 883.6730409748434, 14557.490487832874, 14720.19038952868, 14889.329980150702, 14897.851021489647, 15439.228038597801, 34235.657643424245, 35526.11184720299, 36938.0, 36952.0, 37298.813505932296, 47922.5207747918, 47974.760126199144, 48167.27749083696, 48269.5173048265, 48353.5164648349, 6829.112215411965, 6873.175218973755, 7079.539949759987, 7324.4140468763435, 7496.287852653989, 8236.958815205886, 10712.785744285227, 11263.26788758728, 11572.768544629229, 11796.587119451122, 7175.712971481291, 9731.416115032838, 9755.268354873271, 10300.742481438025, 10338.0695737384, 10089.19286457067, 10162.085412312927, 10192.439415832201, 10231.232657550565, 10237.436940968319, 5294.702797814406, 5441.646292990943, 10050.231163313758, 10151.593936242467, 10253.179745620482, 6689.565178263398, 6857.55425897315, 6904.3095690430555, 6963.860722785617, 7051.189113252041, 7250.528715633467, 8574.78563035929, 9498.525073746147, 10191.94904025475, 10360.792784144425], "value": 7695.810760918983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.640123965909, 1339.879410853023, 1377.634926744413, 1599.0565566315872, 1617.2722274976263, 6000.789972350969, 6200.224971878515, 6457.7416903323865, 6908.96545517273, 6912.516123871331, 6315.589486683374, 6536.052272420497, 6543.280239173687, 6703.0, 6709.865802683956, 2001.0795034284247, 2035.3181684135832, 2036.725042119317, 2041.1427200575795, 2043.6525790615556, 1771.070188151218, 1832.395309547846, 1995.451250905998, 2036.775954644988, 2039.3372154049919, 1950.288144827142, 2028.0, 2029.4317591074448, 2040.5000774810192, 2043.3461292386442, 2018.485286252011, 2028.2596852149006, 2044.642187617161, 2048.7439070116234, 2051.4871282179456, 2040.7142999980015, 2059.1969132038516, 2059.6910463430454, 2063.030375723408, 2064.0, 6898.275681053467, 6939.514234003622, 6957.5129740918155, 6960.895586566206, 6962.060121883532, 4062.898427539335, 4168.43726096976, 4188.162367526507, 4190.0, 4192.266353388175, 2479.5784716598223, 2672.9064482743206, 2680.437108207279, 2683.2486903667004, 2686.785057195439, 786.6460092958134, 812.8211793405501, 841.6675413211747, 851.2381418630353, 853.5177624642057, 9062.139096785795, 9111.954440227757, 9113.726588202364, 9118.179363857218, 9119.133682300171, 3512.1921957949817, 3685.557733071995, 3713.313037088147, 3768.246350729865, 3780.4707340972286, 7786.844263114706, 7790.5325680459355, 7795.493292935941, 7795.688172473151, 7796.064472263365, 4157.251694694924, 4163.979824942909, 4165.0, 4167.6874234432535, 4168.8332466701595, 3731.5708693500596, 3820.522434695663, 3822.235552889433, 3838.2131663009573, 3838.692904567628, 3023.833689147074, 3049.9237519061758, 3061.1581815001055, 3124.4532206864164, 3129.765267604939, 925.1165137294003, 956.1633570625703, 1022.6216299969059, 1033.540074666766, 1045.4197920154388, 772.34350801818, 776.1462391369448, 823.9258466738022, 831.3183189784439, 867.9956600216958, 4645.140648979949, 4674.368960190331, 4713.528647135259, 4828.589569886599, 4951.331570238044, 753.7135888362496, 820.4830956497368, 833.9958300208582, 854.799122206281, 860.5396113079472, 3254.9674503255137, 3261.951070733941, 3263.4125857345907, 3324.2188085799817, 3442.638522955104, 7725.5364678119495, 8103.189681031968, 8175.79560510992, 8187.385946053951, 8189.631466584018, 8151.30713889326, 8161.428699990944, 8161.959190204011, 8165.877511837327, 8170.877436838452, 6409.230892292955, 6499.967500162375, 6503.739850405931, 6505.381988711065, 6517.706703198368, 4541.886452838706, 4597.954020459752, 4669.6731228815015, 4680.92978605328, 4722.693024953367, 7273.0, 7392.112946446461, 7406.555606663617, 7470.92529074724, 7499.700011999459, 7467.365273951775, 7495.737649182252, 7610.771676849703, 7719.459637825298, 7728.0, 5896.557758168069, 5910.70446477683, 5965.642061476326, 5966.224390829338, 5977.133315669291, 6360.522960778053, 6482.189726284215, 6493.610383377012, 6501.902471463027, 6506.121673574196, 5846.1815345852465, 5901.881962360814, 5925.940740592711, 6038.365971573097, 6140.0, 5836.182934389104, 5871.911921321269, 5905.232319798399, 5920.141579471038, 5924.7926322578505, 5615.241942337732, 5661.207430959751, 5721.370649228498, 5744.3394009687745, 5747.051736463437, 4226.36604509326, 4226.746395216297, 4336.891577710582, 4337.262665346835, 4440.666949978699, 4264.680148988777, 4270.124624451918, 4329.437173167594, 4444.511103778517, 4504.324351347324], "value": 3700.0209362907126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.7026404766542, 268.1740240060613, 277.106332079045, 285.9313764696474, 287.97408233259, 4486.977565112178, 4613.308003799431, 4713.622910167187, 4795.489420832435, 4807.903841923164, 4205.453291072156, 4607.571652787638, 4707.846577588495, 4713.363695901053, 4719.976400117995, 3730.701543876497, 3735.981320093396, 3737.5514938207316, 3743.86896458624, 3773.2642134783728, 3580.76463620052, 3624.640759715107, 3690.298843219793, 3766.7551609145453, 3783.508143941284, 3719.6652301293016, 3722.957571879878, 3730.421784623388, 3738.7943663098517, 3747.5877653458233, 3719.851205951759, 3735.4210097434943, 3739.4016957286703, 3748.7750734955716, 3751.6998640108727, 3312.0726196664973, 3325.235195904931, 3331.983340083308, 3344.247544302537, 3344.3144155448317, 4436.4676238851225, 4595.724256544618, 4603.677742558022, 4623.953760462386, 4664.626829853603, 4213.2837417639075, 4236.57634236577, 4241.766702831343, 4250.171216612762, 4250.596193361625, 4719.834805781781, 4920.360353154103, 4963.92554111685, 5006.4492905780335, 5015.699058056492, 3552.662497062775, 3555.0579096539177, 3577.529796097781, 3577.964220357789, 3585.3904836177912, 4914.213725803854, 5126.461721519261, 5210.098314115321, 5214.530692237717, 5221.738913054332, 3463.8268086595567, 3527.224010717638, 3534.752567320263, 3551.0057183988524, 3559.34152181842, 3597.136687195107, 3610.530631017951, 3618.113562177231, 3618.565772107364, 3622.402303619926, 4147.751134931854, 4153.418521407006, 4169.770662613585, 4172.749635021848, 4178.749275043447, 4848.248521479177, 4977.676451030671, 4978.6763860348965, 4980.7509624518625, 5018.436909794014, 1243.1981372015, 1255.9246445213316, 1261.1235191541973, 1263.684078980255, 1267.176335382009, 850.9234168924703, 875.5403413208116, 881.4667126388571, 886.3618194899661, 891.4562117108559, 4304.182205380967, 4322.697411181187, 4340.218760623118, 4349.3475978603465, 4350.608445239944, 5000.774965126578, 5006.79836839156, 5025.170846810309, 5038.647294689336, 5038.874028149326, 4319.200947824663, 4335.653147748172, 4355.0, 4364.148990946735, 4422.933655995163, 2547.414094758216, 2661.4563553139133, 2668.598985532572, 2700.257429206984, 2705.9594106088425, 4706.835260765925, 4711.623070154379, 4722.645801564897, 4729.763511824395, 4741.0, 4858.489858564871, 5092.465291144376, 5110.744462776846, 5125.897482050338, 5163.302954101224, 4662.790174442158, 4716.339712440261, 4719.480857105716, 4723.173444647242, 4732.97633511844, 5021.5229553192385, 5023.572996295356, 5026.396832379992, 5046.646734728533, 5105.0, 4644.814207431665, 4798.136335459511, 4863.90272194547, 4934.851954441372, 4986.1772807487805, 4661.3707149534375, 4667.32323813052, 4677.450789319897, 4678.60231880294, 4714.38712967312, 3333.3333333333917, 3416.4533674611944, 3443.5351227583956, 3541.6448062039485, 3548.6806187443253, 5110.386753589593, 5123.615728820428, 5126.077306084791, 5132.563732082665, 5136.357955255593, 4941.703497790144, 4945.851624451272, 4965.875853103701, 4969.676970996874, 4999.975000125121, 4746.169420351355, 4970.62720295972, 5013.671377085148, 5015.473375295687, 5040.949590504195, 4964.0, 4965.851024469272, 4970.428400733962, 4973.35346404965, 4975.606830087581, 5067.13858644024, 5073.949260507347, 5091.974540127276, 5100.2349647553165, 5100.6429549931145, 4824.565789079, 4917.213245880642, 4935.728534930613, 4945.120854075429, 4946.777395017161], "value": 3719.107762927365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2568934695549, 635.4820821030856, 648.0506058624114, 700.2927043685877, 717.58738725233, 13356.866431335697, 13611.319434028295, 13643.931780341085, 13789.793153102699, 13807.51673691421, 12601.054920880948, 12607.11750177488, 12640.494380224804, 12647.241165530075, 12664.240145591271, 604.5556515960766, 630.7224821078734, 745.1840234942729, 759.6657470712896, 762.1463960364399, 743.4832791210084, 760.9847803043964, 770.7302444144533, 771.3482107619053, 771.8494893495771, 806.7579726082181, 809.1423091522975, 809.7004108479871, 810.068421315489, 810.2262339465825, 643.6652940470929, 661.3816081963331, 805.9556724380157, 806.3831169155601, 806.681360862459, 487.9243717223836, 488.11407295758085, 488.14330849359504, 566.2921348314607, 582.0483509462018, 12838.293893835835, 12883.806742898863, 12898.67753306175, 12909.419076141596, 12912.225266483947, 10794.018061504885, 10878.401687907162, 10920.836187457115, 11151.159611225748, 11312.264702794291, 10314.896851031468, 10477.947610261976, 10515.0, 10564.630237941636, 10801.513931873085, 3987.322155233617, 4015.9397609035886, 4050.696197785178, 4060.533038700558, 4077.4903137107863, 35197.29605407903, 41794.37308440376, 46493.0, 47080.7645961768, 47227.76386118047, 9385.67150149755, 9419.340646154704, 9498.287628427895, 9512.1439070484, 9616.90383096174, 14298.499552515612, 14303.713925721428, 14351.354189061518, 14402.42390304376, 14550.12699238049, 6089.543284253698, 6183.0, 6204.472619827275, 6286.151369565142, 6427.517936154807, 3444.042998354988, 3499.492573576817, 3566.892993210208, 3654.250878569887, 3668.706503479715, 2500.5374005808985, 2550.7449255074343, 2569.961450578243, 2579.509893120301, 2580.3420127867275, 457.5333160176668, 459.80688110993464, 459.94940556538756, 468.3560104855823, 470.66112399073296, 527.5489456514624, 536.6190005096347, 538.3055857943287, 543.3045701502084, 550.1088237055994, 6851.314868513208, 7127.5010749248095, 7265.4550908681, 7447.515911465737, 7660.1573826879, 437.9167958087953, 476.9022350418156, 519.1019536202391, 567.3758865248276, 578.5342799046724, 3074.292912630108, 3076.0464256080686, 3132.8903488377796, 3168.5405616185526, 3232.175795172216, 70394.27311674277, 71198.64400678067, 71713.0, 73717.6314118426, 74567.62716186493, 37313.25373492515, 59668.40331596715, 61158.38841611616, 61929.38070619236, 63016.369836301965, 55411.16883246755, 57329.42670573324, 57517.13724294139, 57776.42223577879, 58205.41794582, 6183.96908015457, 6204.611224678441, 6282.0, 6318.178636777189, 6368.617882927039, 38601.42097868591, 39956.0, 40331.1933761329, 40377.19245615012, 41740.0, 32212.677873221906, 34989.825050874584, 47637.28544071911, 49189.262161066894, 51503.484965151365, 9560.282978776759, 9952.4573691078, 10363.896361036293, 10464.94767526188, 10851.348919064882, 11383.715407114889, 11752.575275373472, 11932.0, 12037.217580857216, 12121.878781212075, 10888.128949684165, 11088.5564577416, 11403.258788178742, 11657.358845263592, 11766.764664706487, 8657.437266577652, 10242.692719218436, 10619.840702389625, 10730.0, 10792.136629069813, 10418.12451921878, 10942.562297508011, 11021.889781102087, 11028.779424411627, 11101.278416902875, 9430.19843313326, 9703.66037188695, 9731.562079706571, 10093.545790439595, 10335.17318614524, 9686.370385924893, 10058.446785426871, 10160.898391016291, 10174.389536627827, 10196.490175491344], "value": 5861.860046297569, "unit": "score"}], "name": "dromaeo_css", "value": 6020.218044883001, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 114.0, 114.0, 114.0, 116.0, 117.0, 115.0, 116.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 131.0, 175.0, 134.0, 136.0, 128.0, 132.0, 166.0, 143.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 165.0, 163.0, 163.0, 163.0, 163.0, 163.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 114.0, 77.0, 77.0, 77.0, 77.0, 104.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 85.0, 83.0, 83.0, 105.0, 83.0, 84.0, 118.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 69.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 94.0, 84.0, 94.0, 85.0, 91.0, 92.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 142.0, 152.0, 141.0, 140.0, 145.0, 139.0, 148.0, 185.0, 152.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 181.0, 177.0, 178.0, 176.0, 176.0, 176.0, 174.0, 174.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 72.0, 70.0, 70.0, 73.0, 70.0, 74.0, 73.0, 73.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1575.3999999999999, "alertThreshold": 2.0}]} 08:22:58 INFO - Return code: 0 08:22:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:58 INFO - # TBPL SUCCESS # 08:22:58 INFO - Running post-action listener: _resource_record_post_action 08:22:58 INFO - [mozharness: 2016-11-21 16:22:58.745184Z] Finished run-tests step (success) 08:22:58 INFO - Running post-run listener: _resource_record_post_run 08:22:58 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288976896; Read time: 260; Write time: 250188 08:22:58 INFO - TinderboxPrint: CPU usage
13.1% 08:22:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 260 08:22:58 INFO - TinderboxPrint: I/O write bytes / time
288,976,896 / 250,188 08:22:58 INFO - TinderboxPrint: CPU idle
8,354.7 (86.9%) 08:22:58 INFO - TinderboxPrint: CPU user
1,209.5 (12.6%) 08:22:58 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1863680; Read time: 0; Write time: 172 08:22:58 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287113216; Read time: 252; Write time: 250016 08:22:59 INFO - Running post-run listener: _upload_blobber_files 08:22:59 INFO - Blob upload gear active. 08:22:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:59 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 08:22:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:22:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:23:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:01 INFO - (blobuploader) - INFO - Done attempting. 08:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:05 INFO - (blobuploader) - INFO - Done attempting. 08:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:05 INFO - (blobuploader) - INFO - Done attempting. 08:23:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:05 INFO - Return code: 0 08:23:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f9eb2fcda3cfb1be1cc5140fd5304b8cffef4bfc20d699881f14dba420615596fef06a73cdf98cd87db100cc3e17ef14989bfb85f69e4518a76f87bc3d13fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43b9bfc7662810646b7002a43ec1bd6936351c35cf7ecca19a143477f7a244f322ca4d4271ac100f935bef5669af9106aca26df20a5d07b9038e91cbbe63de14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e400589957a3c34aacf28953f1d6f081b4087a74a75daaeef35fb7f529ac78fad8df5781eb40562fcaec4aaf90a2cdd74718369acac9b3d4b9a145a0c01c1ca"} 08:23:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:05 INFO - Contents: 08:23:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f9eb2fcda3cfb1be1cc5140fd5304b8cffef4bfc20d699881f14dba420615596fef06a73cdf98cd87db100cc3e17ef14989bfb85f69e4518a76f87bc3d13fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43b9bfc7662810646b7002a43ec1bd6936351c35cf7ecca19a143477f7a244f322ca4d4271ac100f935bef5669af9106aca26df20a5d07b9038e91cbbe63de14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e400589957a3c34aacf28953f1d6f081b4087a74a75daaeef35fb7f529ac78fad8df5781eb40562fcaec4aaf90a2cdd74718369acac9b3d4b9a145a0c01c1ca"} 08:23:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:05 INFO - Copying logs to upload dir... 08:23:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.673784 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-21 08:23:05.089320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 08:23:05.093173) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 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-Non-PGO/sha512/d2f9eb2fcda3cfb1be1cc5140fd5304b8cffef4bfc20d699881f14dba420615596fef06a73cdf98cd87db100cc3e17ef14989bfb85f69e4518a76f87bc3d13fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43b9bfc7662810646b7002a43ec1bd6936351c35cf7ecca19a143477f7a244f322ca4d4271ac100f935bef5669af9106aca26df20a5d07b9038e91cbbe63de14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e400589957a3c34aacf28953f1d6f081b4087a74a75daaeef35fb7f529ac78fad8df5781eb40562fcaec4aaf90a2cdd74718369acac9b3d4b9a145a0c01c1ca"} build_url:https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/a1w_hxZdRxakqhZgkwHdGA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f9eb2fcda3cfb1be1cc5140fd5304b8cffef4bfc20d699881f14dba420615596fef06a73cdf98cd87db100cc3e17ef14989bfb85f69e4518a76f87bc3d13fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43b9bfc7662810646b7002a43ec1bd6936351c35cf7ecca19a143477f7a244f322ca4d4271ac100f935bef5669af9106aca26df20a5d07b9038e91cbbe63de14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e400589957a3c34aacf28953f1d6f081b4087a74a75daaeef35fb7f529ac78fad8df5781eb40562fcaec4aaf90a2cdd74718369acac9b3d4b9a145a0c01c1ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 08:23:05.119788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:23:05.120103) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479742734.28913-1106864759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:23:05.204174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 08:23:05.204582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 08:23:05.204929) ========= ========= Total master_lag: 0.16 =========